builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0207 starttime: 1464369009.98 results: success (0) buildid: 20160527075240 builduid: dbb5d63ad4954beeb3b184121e5a2727 revision: c4ab769466fde230752eccfcc3dd256277b7cff7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:09.983762) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:09.984203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:09.984633) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:10.058507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:10.058883) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-27 10:10:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.93M=0.001s 2016-05-27 10:10:10 (7.93 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116460 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:10.237824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:10.238138) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020161 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:10.316858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 10:10:10.317203) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c4ab769466fde230752eccfcc3dd256277b7cff7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c4ab769466fde230752eccfcc3dd256277b7cff7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-27 10:10:10,398 truncating revision to first 12 chars 2016-05-27 10:10:10,398 Setting DEBUG logging. 2016-05-27 10:10:10,398 attempt 1/10 2016-05-27 10:10:10,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c4ab769466fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 10:10:11,721 unpacking tar archive at: mozilla-beta-c4ab769466fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594320 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 10:10:11.948488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:11.948786) ========= script_repo_revision: c4ab769466fde230752eccfcc3dd256277b7cff7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:11.949154) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:11.949425) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 10:10:12.027890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-27 10:10:12.028290) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:10:12 INFO - MultiFileLogger online at 20160527 10:10:12 in /builds/slave/test 10:10:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:10:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:10:12 INFO - {'append_to_log': False, 10:10:12 INFO - 'base_work_dir': '/builds/slave/test', 10:10:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:10:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:10:12 INFO - 'branch': 'Mozilla-Beta', 10:10:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:10:12 INFO - 'config_files': ('talos/mac_config.py',), 10:10:12 INFO - 'default_actions': ('clobber', 10:10:12 INFO - 'read-buildbot-config', 10:10:12 INFO - 'download-and-extract', 10:10:12 INFO - 'populate-webroot', 10:10:12 INFO - 'create-virtualenv', 10:10:12 INFO - 'install', 10:10:12 INFO - 'run-tests'), 10:10:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:10:12 INFO - 'download_minidump_stackwalk': True, 10:10:12 INFO - 'download_symbols': 'ondemand', 10:10:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:10:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:10:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:10:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:10:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:10:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:10:12 INFO - 'installer_path': 'installer.exe', 10:10:12 INFO - 'log_level': 'info', 10:10:12 INFO - 'log_name': 'talos', 10:10:12 INFO - 'log_to_console': True, 10:10:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:10:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:10:12 INFO - 'opt_config_files': (), 10:10:12 INFO - 'pip_index': False, 10:10:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:12 INFO - 'cmd': ('bash', 10:10:12 INFO - '-c', 10:10:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:12 INFO - 'enabled': True, 10:10:12 INFO - 'halt_on_failure': False, 10:10:12 INFO - 'name': 'check_screen_resolution'},), 10:10:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:10:12 INFO - 'cmd': ('bash', 10:10:12 INFO - '-c', 10:10:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:10:12 INFO - 'enabled': True, 10:10:12 INFO - 'halt_on_failure': False, 10:10:12 INFO - 'name': 'check_screen_resolution'},), 10:10:12 INFO - 'run_cmd_checks_enabled': True, 10:10:12 INFO - 'sps_profile': False, 10:10:12 INFO - 'sps_profile_interval': 0, 10:10:12 INFO - 'suite': 'dromaeojs', 10:10:12 INFO - 'system_bits': '32', 10:10:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:10:12 INFO - 'title': 't-yosemite-r7-0207', 10:10:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:10:12 INFO - 'use_talos_json': True, 10:10:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:10:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:10:12 INFO - 'work_dir': 'build'} 10:10:12 INFO - ##### 10:10:12 INFO - ##### Running clobber step. 10:10:12 INFO - ##### 10:10:12 INFO - Running pre-action listener: _resource_record_pre_action 10:10:12 INFO - Running main action method: clobber 10:10:12 INFO - rmtree: /builds/slave/test/build 10:10:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:10:13 INFO - Running post-action listener: _resource_record_post_action 10:10:13 INFO - ##### 10:10:13 INFO - ##### Running read-buildbot-config step. 10:10:13 INFO - ##### 10:10:13 INFO - Running pre-action listener: _resource_record_pre_action 10:10:13 INFO - Running main action method: read_buildbot_config 10:10:13 INFO - Using buildbot properties: 10:10:13 INFO - { 10:10:13 INFO - "project": "", 10:10:13 INFO - "product": "firefox", 10:10:13 INFO - "script_repo_revision": "production", 10:10:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:10:13 INFO - "repository": "", 10:10:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:10:13 INFO - "buildid": "20160527075240", 10:10:13 INFO - "pgo_build": "False", 10:10:13 INFO - "basedir": "/builds/slave/test", 10:10:13 INFO - "buildnumber": 10, 10:10:13 INFO - "slavename": "t-yosemite-r7-0207", 10:10:13 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:10:13 INFO - "platform": "yosemite_r7", 10:10:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:10:13 INFO - "branch": "mozilla-beta", 10:10:13 INFO - "repo_path": "releases/mozilla-beta", 10:10:13 INFO - "revision": "c4ab769466fde230752eccfcc3dd256277b7cff7", 10:10:13 INFO - "stage_platform": "macosx64", 10:10:13 INFO - "builduid": "dbb5d63ad4954beeb3b184121e5a2727", 10:10:13 INFO - "slavebuilddir": "test" 10:10:13 INFO - } 10:10:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:10:13 INFO - Running post-action listener: _resource_record_post_action 10:10:13 INFO - ##### 10:10:13 INFO - ##### Running download-and-extract step. 10:10:13 INFO - ##### 10:10:13 INFO - Running pre-action listener: _resource_record_pre_action 10:10:13 INFO - Running main action method: download_and_extract 10:10:13 INFO - mkdir: /builds/slave/test/build/tests 10:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:13 INFO - https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:10:15 INFO - Downloaded 1241 bytes. 10:10:15 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:10:15 INFO - Using the following test package requirements: 10:10:15 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:10:15 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:10:15 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:10:15 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:10:15 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:10:15 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:10:15 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:10:15 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:10:15 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:10:15 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:10:15 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:10:15 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:10:15 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:15 INFO - https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:10:19 INFO - Downloaded 17816929 bytes. 10:10:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:10:22 INFO - Return code: 0 10:10:22 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:22 INFO - https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:10:28 INFO - Downloaded 17816929 bytes. 10:10:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:10:32 INFO - Return code: 0 10:10: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')]} 10:10:32 INFO - https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:10:33 INFO - Downloaded 10845194 bytes. 10:10:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:10:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:10:33 INFO - Return code: 0 10:10:33 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')]} 10:10:33 INFO - https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:10:36 INFO - Downloaded 88466178 bytes. 10:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:10:36 INFO - mkdir: /builds/slave/test/properties 10:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:10:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:10:36 INFO - Contents: 10:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:10:36 INFO - Running post-action listener: _resource_record_post_action 10:10:36 INFO - Running post-action listener: set_extra_try_arguments 10:10:36 INFO - ##### 10:10:36 INFO - ##### Running populate-webroot step. 10:10:36 INFO - ##### 10:10:36 INFO - Running pre-action listener: _resource_record_pre_action 10:10:36 INFO - Running main action method: populate_webroot 10:10:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:10:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:10:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:10:36 INFO - '--tppagecycles', 10:10:36 INFO - '7'], 10:10:36 INFO - 'tests': ['tsvgm']}}, 10:10:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:10:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:10:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:10:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:10:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:10:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'tests': ['damp', 'tps']}, 10:10:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['damp', 'tps']}, 10:10:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:10:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:10:36 INFO - 'other': {'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'other_l64': {'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'other_nol64': {'tests': ['a11yr', 10:10:36 INFO - 'ts_paint', 10:10:36 INFO - 'tpaint', 10:10:36 INFO - 'sessionrestore', 10:10:36 INFO - 'sessionrestore_no_auto_restore', 10:10:36 INFO - 'tabpaint']}, 10:10:36 INFO - 'svgr': {'tests': ['tsvgx', 10:10:36 INFO - 'tsvgr_opacity', 10:10:36 INFO - 'tart', 10:10:36 INFO - 'tscrollx', 10:10:36 INFO - 'cart']}, 10:10:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['tsvgx', 10:10:36 INFO - 'tsvgr_opacity', 10:10:36 INFO - 'tart', 10:10:36 INFO - 'tscrollx', 10:10:36 INFO - 'cart']}, 10:10:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'tests': ['tp5o']}, 10:10:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'talos_options': ['--e10s'], 10:10:36 INFO - 'tests': ['tp5o']}, 10:10:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'talos_options': ['--xperf_path', 10:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:36 INFO - 'tests': ['tp5n']}, 10:10:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:10:36 INFO - 'talos_options': ['--e10s', 10:10:36 INFO - '--xperf_path', 10:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:10:36 INFO - 'tests': ['tp5n']}}, 10:10:36 INFO - 'talos.zip': {'path': '', 10:10:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:10:36 INFO - Running post-action listener: _resource_record_post_action 10:10:36 INFO - ##### 10:10:36 INFO - ##### Running create-virtualenv step. 10:10:36 INFO - ##### 10:10:36 INFO - Running pre-action listener: _resource_record_pre_action 10:10:36 INFO - Running main action method: create_virtualenv 10:10:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:10:36 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 10:10:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:10:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:10:37 INFO - Using real prefix '/tools/python27' 10:10:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:10:37 INFO - Installing distribute.............................................................................................................................................................................................done. 10:10:40 INFO - Installing pip.................done. 10:10:40 INFO - Return code: 0 10:10:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:40 INFO - 'HOME': '/Users/cltbld', 10:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:40 INFO - 'LOGNAME': 'cltbld', 10:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:40 INFO - 'MOZ_NO_REMOTE': '1', 10:10:40 INFO - 'NO_EM_RESTART': '1', 10:10:40 INFO - 'PAGER': '/bin/cat', 10:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:40 INFO - 'PWD': '/builds/slave/test', 10:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:40 INFO - 'SHELL': '/bin/bash', 10:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:40 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:40 INFO - 'USER': 'cltbld', 10:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:40 INFO - 'XPC_FLAGS': '0x0', 10:10:40 INFO - 'XPC_SERVICE_NAME': '0', 10:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:10:40 INFO - Cleaning up... 10:10:40 INFO - Return code: 0 10:10:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:40 INFO - 'HOME': '/Users/cltbld', 10:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:40 INFO - 'LOGNAME': 'cltbld', 10:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:40 INFO - 'MOZ_NO_REMOTE': '1', 10:10:40 INFO - 'NO_EM_RESTART': '1', 10:10:40 INFO - 'PAGER': '/bin/cat', 10:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:40 INFO - 'PWD': '/builds/slave/test', 10:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:40 INFO - 'SHELL': '/bin/bash', 10:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:40 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:40 INFO - 'USER': 'cltbld', 10:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:40 INFO - 'XPC_FLAGS': '0x0', 10:10:40 INFO - 'XPC_SERVICE_NAME': '0', 10:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:41 INFO - Downloading/unpacking psutil>=0.7.1 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:44 INFO - Installing collected packages: psutil 10:10:44 INFO - Running setup.py install for psutil 10:10:44 INFO - building 'psutil._psutil_osx' extension 10:10:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:10:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:10:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:10:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:10:44 INFO - building 'psutil._psutil_posix' extension 10:10:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:10:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:10:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:10:44 INFO - ^ 10:10:44 INFO - 1 warning generated. 10:10:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:10:44 INFO - Successfully installed psutil 10:10:44 INFO - Cleaning up... 10:10:45 INFO - Return code: 0 10:10:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:10: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 mozsystemmonitor==0.0.0 10:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:45 INFO - 'HOME': '/Users/cltbld', 10:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:45 INFO - 'LOGNAME': 'cltbld', 10:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:45 INFO - 'MOZ_NO_REMOTE': '1', 10:10:45 INFO - 'NO_EM_RESTART': '1', 10:10:45 INFO - 'PAGER': '/bin/cat', 10:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:45 INFO - 'PWD': '/builds/slave/test', 10:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:45 INFO - 'SHELL': '/bin/bash', 10:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:45 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:45 INFO - 'USER': 'cltbld', 10:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:45 INFO - 'XPC_FLAGS': '0x0', 10:10:45 INFO - 'XPC_SERVICE_NAME': '0', 10:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:10:45 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 10:10:45 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 10:10:45 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 10:10:45 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 10:10:45 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 10:10:45 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 10:10:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:10:47 INFO - Installing collected packages: mozsystemmonitor 10:10:47 INFO - Running setup.py install for mozsystemmonitor 10:10:47 INFO - Successfully installed mozsystemmonitor 10:10:47 INFO - Cleaning up... 10:10:47 INFO - Return code: 0 10:10:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:47 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 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:47 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 10:10:47 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 10:10:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:48 INFO - 'HOME': '/Users/cltbld', 10:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:48 INFO - 'LOGNAME': 'cltbld', 10:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:48 INFO - 'MOZ_NO_REMOTE': '1', 10:10:48 INFO - 'NO_EM_RESTART': '1', 10:10:48 INFO - 'PAGER': '/bin/cat', 10:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:48 INFO - 'PWD': '/builds/slave/test', 10:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:48 INFO - 'SHELL': '/bin/bash', 10:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:48 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:48 INFO - 'USER': 'cltbld', 10:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:48 INFO - 'XPC_FLAGS': '0x0', 10:10:48 INFO - 'XPC_SERVICE_NAME': '0', 10:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:10:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10: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 10:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:10:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:51 INFO - Downloading docopt-0.6.1.tar.gz 10:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:10:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:10:51 INFO - Running setup.py install for blobuploader 10:10:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:10:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:10:52 INFO - Running setup.py install for requests 10:10:52 INFO - Running setup.py install for docopt 10:10:52 INFO - Successfully installed blobuploader requests docopt 10:10:52 INFO - Cleaning up... 10:10:52 INFO - Return code: 0 10:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10: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')]} 10:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10: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')]} 10:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:52 INFO - 'HOME': '/Users/cltbld', 10:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:52 INFO - 'LOGNAME': 'cltbld', 10:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:52 INFO - 'MOZ_NO_REMOTE': '1', 10:10:52 INFO - 'NO_EM_RESTART': '1', 10:10:52 INFO - 'PAGER': '/bin/cat', 10:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:52 INFO - 'PWD': '/builds/slave/test', 10:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:52 INFO - 'SHELL': '/bin/bash', 10:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:52 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:52 INFO - 'USER': 'cltbld', 10:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:52 INFO - 'XPC_FLAGS': '0x0', 10:10:52 INFO - 'XPC_SERVICE_NAME': '0', 10:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-kK9hCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-z17V0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-2YGbee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-xdZtvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wROaAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eZr2Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-15H4iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-gDPrwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:53 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-tjaXBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-8Aklz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-u0frRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-2naSBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-KhPx1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-TL0SgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-SLBq80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Te8B8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:54 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-zD0Cwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:10:54 INFO - Running setup.py install for manifestparser 10:10:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:10:55 INFO - Running setup.py install for mozcrash 10:10:55 INFO - Running setup.py install for mozdebug 10:10:55 INFO - Running setup.py install for mozdevice 10:10:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:10:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:10:55 INFO - Running setup.py install for mozfile 10:10:55 INFO - Running setup.py install for mozhttpd 10:10:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:10:55 INFO - Running setup.py install for mozinfo 10:10:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:10:55 INFO - Running setup.py install for mozInstall 10:10:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Running setup.py install for mozleak 10:10:56 INFO - Running setup.py install for mozlog 10:10:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Running setup.py install for moznetwork 10:10:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Running setup.py install for mozprocess 10:10:56 INFO - Running setup.py install for mozprofile 10:10:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Running setup.py install for mozrunner 10:10:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:10:56 INFO - Running setup.py install for mozscreenshot 10:10:57 INFO - Running setup.py install for moztest 10:10:57 INFO - Running setup.py install for mozversion 10:10:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:10:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:10:57 INFO - Cleaning up... 10:10:57 INFO - Return code: 0 10:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:10:57 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')]} 10:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:57 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')]} 10:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:10:57 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 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:10:57 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 10:10:57 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 10:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:10:57 INFO - 'HOME': '/Users/cltbld', 10:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:10:57 INFO - 'LOGNAME': 'cltbld', 10:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:10:57 INFO - 'MOZ_NO_REMOTE': '1', 10:10:57 INFO - 'NO_EM_RESTART': '1', 10:10:57 INFO - 'PAGER': '/bin/cat', 10:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:10:57 INFO - 'PWD': '/builds/slave/test', 10:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:10:57 INFO - 'SHELL': '/bin/bash', 10:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:10:57 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:10:57 INFO - 'USER': 'cltbld', 10:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:10:57 INFO - 'XPC_FLAGS': '0x0', 10:10:57 INFO - 'XPC_SERVICE_NAME': '0', 10:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:10:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Jk3wKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:10:57 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)) 10:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:10:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-tVkjcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:10:57 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)) 10:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:10:57 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-6ZXcxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wV803z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-1f7dFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-2HFob1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-H2CKX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Hygaw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-2G8sWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-S4eMwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-7d5Dfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-lcRIfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:10:58 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)) 10:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:10:58 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-O8n59s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:10:59 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)) 10:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:10:59 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-N4JuQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:10:59 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)) 10:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:59 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-D80Tpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:10:59 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)) 10:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:10:59 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-tQu08L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:10:59 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)) 10:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:10:59 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-mn_CBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:10:59 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)) 10:10:59 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)) 10:10:59 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)) 10:10:59 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)) 10:10:59 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)) 10:10:59 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)) 10:10:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:01 INFO - Downloading blessings-1.6.tar.gz 10:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:02 INFO - Installing collected packages: blessings 10:11:02 INFO - Running setup.py install for blessings 10:11:02 INFO - Successfully installed blessings 10:11:02 INFO - Cleaning up... 10:11:02 INFO - Return code: 0 10:11:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:02 INFO - Reading from file tmpfile_stdout 10:11:02 INFO - Current package versions: 10:11:02 INFO - blessings == 1.6 10:11:02 INFO - blobuploader == 1.2.4 10:11:02 INFO - docopt == 0.6.1 10:11:02 INFO - manifestparser == 1.1 10:11:02 INFO - mozInstall == 1.12 10:11:02 INFO - mozcrash == 0.17 10:11:02 INFO - mozdebug == 0.1 10:11:02 INFO - mozdevice == 0.48 10:11:02 INFO - mozfile == 1.2 10:11:02 INFO - mozhttpd == 0.7 10:11:02 INFO - mozinfo == 0.9 10:11:02 INFO - mozleak == 0.1 10:11:02 INFO - mozlog == 3.1 10:11:02 INFO - moznetwork == 0.27 10:11:02 INFO - mozprocess == 0.22 10:11:02 INFO - mozprofile == 0.28 10:11:02 INFO - mozrunner == 6.11 10:11:02 INFO - mozscreenshot == 0.1 10:11:02 INFO - mozsystemmonitor == 0.0 10:11:02 INFO - moztest == 0.7 10:11:02 INFO - mozversion == 1.4 10:11:02 INFO - psutil == 3.1.1 10:11:02 INFO - requests == 1.2.3 10:11:02 INFO - wsgiref == 0.1.2 10:11:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:02 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 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:11:02 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 10:11:02 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 10:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:02 INFO - 'HOME': '/Users/cltbld', 10:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:02 INFO - 'LOGNAME': 'cltbld', 10:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:02 INFO - 'MOZ_NO_REMOTE': '1', 10:11:02 INFO - 'NO_EM_RESTART': '1', 10:11:02 INFO - 'PAGER': '/bin/cat', 10:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:02 INFO - 'PWD': '/builds/slave/test', 10:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:02 INFO - 'SHELL': '/bin/bash', 10:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:11:02 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:02 INFO - 'USER': 'cltbld', 10:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:02 INFO - 'XPC_FLAGS': '0x0', 10:11:02 INFO - 'XPC_SERVICE_NAME': '0', 10:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 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)) 10:11:02 INFO - Cleaning up... 10:11:02 INFO - Return code: 0 10:11:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:02 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 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:11:02 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 10:11:02 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 10:11:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:11:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:02 INFO - 'HOME': '/Users/cltbld', 10:11:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:02 INFO - 'LOGNAME': 'cltbld', 10:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:02 INFO - 'MOZ_NO_REMOTE': '1', 10:11:02 INFO - 'NO_EM_RESTART': '1', 10:11:02 INFO - 'PAGER': '/bin/cat', 10:11:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:02 INFO - 'PWD': '/builds/slave/test', 10:11:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:02 INFO - 'SHELL': '/bin/bash', 10:11:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:11:02 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:11:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:02 INFO - 'USER': 'cltbld', 10:11:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:02 INFO - 'XPC_FLAGS': '0x0', 10:11:02 INFO - 'XPC_SERVICE_NAME': '0', 10:11:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:03 INFO - Downloading/unpacking jsonschema 10:11:03 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 10:11:03 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 10:11:03 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 10:11:03 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 10:11:03 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 10:11:03 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 10:11:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:05 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 10:11:06 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:06 INFO - warning: no files found matching '*.txt' 10:11:06 INFO - no previously-included directories found matching 'build' 10:11:06 INFO - no previously-included directories found matching 'dist' 10:11:06 INFO - no previously-included directories found matching '.git*' 10:11:06 INFO - Installing collected packages: jsonschema, functools32 10:11:06 INFO - Running setup.py install for functools32 10:11:06 INFO - warning: no files found matching '*.txt' 10:11:06 INFO - no previously-included directories found matching 'build' 10:11:06 INFO - no previously-included directories found matching 'dist' 10:11:06 INFO - no previously-included directories found matching '.git*' 10:11:06 INFO - Successfully installed jsonschema functools32 10:11:06 INFO - Cleaning up... 10:11:06 INFO - Return code: 0 10:11:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f900a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9074c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9152da3c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:11: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', 'flake8'] in /builds/slave/test/build 10:11: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 flake8 10:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:06 INFO - 'HOME': '/Users/cltbld', 10:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:06 INFO - 'LOGNAME': 'cltbld', 10:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:06 INFO - 'MOZ_NO_REMOTE': '1', 10:11:06 INFO - 'NO_EM_RESTART': '1', 10:11:06 INFO - 'PAGER': '/bin/cat', 10:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:06 INFO - 'PWD': '/builds/slave/test', 10:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:06 INFO - 'SHELL': '/bin/bash', 10:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:11:06 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:06 INFO - 'USER': 'cltbld', 10:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:06 INFO - 'XPC_FLAGS': '0x0', 10:11:06 INFO - 'XPC_SERVICE_NAME': '0', 10:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:06 INFO - Downloading/unpacking flake8 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:06 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 10:11:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:11:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:11:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11: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 10:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:10 INFO - no previously-included directories found matching 'docs/_build' 10:11:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:11:10 INFO - Running setup.py install for pep8 10:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:11:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:11:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:11:10 INFO - no previously-included directories found matching 'docs/_build' 10:11:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:11:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:11:10 INFO - Cleaning up... 10:11:10 INFO - Return code: 0 10:11:10 INFO - Running post-action listener: _resource_record_post_action 10:11:10 INFO - Running post-action listener: _start_resource_monitoring 10:11:10 INFO - Starting resource monitoring. 10:11:10 INFO - ##### 10:11:10 INFO - ##### Running install step. 10:11:10 INFO - ##### 10:11:10 INFO - Running pre-action listener: _resource_record_pre_action 10:11:10 INFO - Running main action method: install 10:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:11:11 INFO - Reading from file tmpfile_stdout 10:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:11:11 INFO - Reading from file tmpfile_stdout 10:11:11 INFO - Output received: 10:11:11 INFO - Usage: mozinstall [options] installer 10:11:11 INFO - Options: 10:11:11 INFO - -h, --help show this help message and exit 10:11:11 INFO - -d DEST, --destination=DEST 10:11:11 INFO - Directory to install application into. [default: 10:11:11 INFO - "/builds/slave/test"] 10:11:11 INFO - --app=APP Application being installed. [default: firefox] 10:11:11 INFO - mkdir: /builds/slave/test/build/application 10:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:11:33 INFO - Reading from file tmpfile_stdout 10:11:33 INFO - Output received: 10:11:33 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:11:33 INFO - Running post-action listener: _resource_record_post_action 10:11:33 INFO - ##### 10:11:33 INFO - ##### Running run-tests step. 10:11:33 INFO - ##### 10:11:33 INFO - Running pre-action listener: _resource_record_pre_action 10:11:33 INFO - Running main action method: run_tests 10:11:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:33 INFO - 2016-05-27 10:11:33.362 screenresolution[1961:27248] starting screenresolution argv=screenresolution get 10:11:33 INFO - 2016-05-27 10:11:33.365 screenresolution[1961:27248] Display 0: 1600x1200x32@60 10:11:33 INFO - 2016-05-27 10:11:33.371 screenresolution[1962:27251] starting screenresolution argv=screenresolution list 10:11:33 INFO - Available Modes on Display 0 10:11:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:33 INFO - Intel Iris: 10:11:33 INFO - Chipset Model: Intel Iris 10:11:33 INFO - Type: GPU 10:11:33 INFO - Bus: Built-In 10:11:33 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:33 INFO - Vendor: Intel (0x8086) 10:11:33 INFO - Device ID: 0x0a2e 10:11:33 INFO - Revision ID: 0x0009 10:11:33 INFO - Displays: 10:11:33 INFO - Display: 10:11:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:33 INFO - Display Serial Number: 1600x1200 60 10:11:33 INFO - Main Display: Yes 10:11:33 INFO - Mirror: Off 10:11:33 INFO - Online: Yes 10:11:33 INFO - Rotation: Supported 10:11:33 INFO - Return code: 0 10:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:11:33 INFO - Python 2.7.3 10:11:33 INFO - Return code: 0 10:11:33 INFO - grabbing minidump binary from tooltool 10:11:33 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')]} 10:11:33 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a4d30>, '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 0x10f608db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f79bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:11:33 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:11:33 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:11:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:11:33 INFO - Return code: 0 10:11:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:11:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:11:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:11:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:11:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:11:34 INFO - Return code: 0 10:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 10:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 10:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DFjOTPkX6w/Render', 10:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:11:34 INFO - 'HOME': '/Users/cltbld', 10:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:11:34 INFO - 'LOGNAME': 'cltbld', 10:11:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:11:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:34 INFO - 'MOZ_NO_REMOTE': '1', 10:11:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:11:34 INFO - 'NO_EM_RESTART': '1', 10:11:34 INFO - 'PAGER': '/bin/cat', 10:11:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:34 INFO - 'PWD': '/builds/slave/test', 10:11:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:11:34 INFO - 'SHELL': '/bin/bash', 10:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners', 10:11:34 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 10:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:11:34 INFO - 'USER': 'cltbld', 10:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:34 INFO - 'XPC_FLAGS': '0x0', 10:11:34 INFO - 'XPC_SERVICE_NAME': '0', 10:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:11:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 10:11:35 INFO - mozversion application_buildid: 20160527075240 10:11:35 INFO - mozversion application_changeset: c4ab769466fde230752eccfcc3dd256277b7cff7 10:11:35 INFO - mozversion application_display_name: Firefox 10:11:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:11:35 INFO - mozversion application_name: Firefox 10:11:35 INFO - mozversion application_remotingname: firefox 10:11:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:11:35 INFO - mozversion application_vendor: Mozilla 10:11:35 INFO - mozversion application_version: 47.0 10:11:35 INFO - mozversion platform_buildid: 20160527075240 10:11:35 INFO - mozversion platform_changeset: c4ab769466fde230752eccfcc3dd256277b7cff7 10:11:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:11:35 INFO - mozversion platform_version: 47.0 10:11:35 INFO - using testdate: 1464369095 10:11:35 INFO - actual date: 1464369095 10:11:35 INFO - starting webserver on 'localhost:50395' 10:11:35 INFO - SUITE-START | Running 2 tests 10:11:35 INFO - TEST-START | dromaeo_css 10:11:35 INFO - operating with platform_type : mac_ 10:11:35 INFO - Initialising browser for dromaeo_css test... 10:11:35 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpLVTiCY/profile http://localhost:50395/getInfo.html) 10:11:37 INFO - PROCESS | 1980 | __metrics Screen width/height:1600/1200 10:11:37 INFO - PROCESS | 1980 | colorDepth:24 10:11:37 INFO - PROCESS | 1980 | Browser inner width/height: 1024/689 10:11:37 INFO - PROCESS | 1980 | __metrics 10:11:37 INFO - PROCESS | 1980 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:11:37 INFO - PROCESS | 1980 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:11:37 INFO - TEST-INFO | 1980: exit 0 10:11:37 INFO - Browser initialized. 10:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:11:37 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpLVTiCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:49 INFO - PROCESS | 1983 | RSS: Main: 157114368 10:11:49 INFO - PROCESS | 1983 | 10:12:41 INFO - PROCESS | 1983 | 1464369161103 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] 10:14:51 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50395/tests/dromaeo/cssquery-ext.html) 10:14:52 INFO - PROCESS | 1983 | RSS: Main: 267153408 10:14:52 INFO - PROCESS | 1983 | 10:17:54 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-ext.html (next: http://localhost:50395/tests/dromaeo/cssquery-jquery.html) 10:17:55 INFO - PROCESS | 1983 | RSS: Main: 292913152 10:17:55 INFO - PROCESS | 1983 | 10:20:57 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50395/tests/dromaeo/cssquery-mootools.html) 10:20:57 INFO - PROCESS | 1983 | RSS: Main: 291057664 10:20:57 INFO - PROCESS | 1983 | 10:23:59 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50395/tests/dromaeo/cssquery-prototype.html) 10:24:00 INFO - PROCESS | 1983 | RSS: Main: 252039168 10:24:00 INFO - PROCESS | 1983 | 10:27:03 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50395/tests/dromaeo/cssquery-yui.html) 10:27:03 INFO - PROCESS | 1983 | RSS: Main: 255201280 10:27:03 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:50395/tests/dromaeo/cssquery-yui.html (next: http://localhost:50395/tests/dromaeo/cssquery-dojo.html) 10:30:06 INFO - PROCESS | 1983 | RSS: Main: 300888064 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | __start_tp_report 10:30:06 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 10:30:06 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 10:30:06 INFO - PROCESS | 1983 | |i|pagename|runs| 10:30:06 INFO - PROCESS | 1983 | |0;dojo.html;3559.3415218184637;3643.8542458301654;3645.54430696163;3658.707303415726;3720.3303405387037;5872.823815285537;5890.234269544964;5891.941080589193;5912.586118971673;5952.523798096153;5854.648721076738;5941.10883367494;5941.792037278696;5954.910676339859;5964.13520039594;5186.818461353853;5279.313689220415;5307.814226502073;5351.036813373591;5401.405845357008;5386.865328366803;5399.136138217886;5402.6758394496455;5407.540359069484;5414.377346605152;5326;5394.541463975567;5411.998780225671;5431.782728690848;5455.5908306876945;5390.1375779875225;5393.325834270716;5395.730213489349;5406.648567843117;5451.809186678447;5124.103281925685;5325.707086110262;5342.198670199462;5353.384360798519;5354.892902141974;5722.055860782966;5756.539476841885;5763.769449222026;5768;5784.826455206308;6242.344553821874;6389.137466442064;6390.488760899117;6393.808185754435;6395.392437718409;6246.094316324153;6270.46701030413;6297.370262973666;6297.433231009185;6324.209473815773;6061.090836374535;6062.787802426894;6063.423974722395;6080.665563393967;6095;6257.812265632038;6331.240251169889;6434.549581529342;6437.517186210959;6451.387118223761;6319.431251187415;6323.1779868617705;6352.936470635234;6356.523260755369;6356.904646430307;6327.841803954846;6339.619622822645;6343.9365606343345;6346.746130154742;6352.4918006559365;6209.037599172136;6252.249730032425;6311.684415779193;6387.265464471552;6397.10440538325;6329.050642403677;6359.109724638554;6369.904451433232;6373.776917807854;6387.840303992437;5060.266261392151;5075.56857667095;5089.109405854035;5092.032513822362;5095.668781529189;4480.081583275421;4500.189965806187;4547.067851090585;4605.65457590682;4634.83778067766;5949.1076338549565;5968.432998865101;5971.820845374646;5981.461668449861;5988.970055149696;6296.401841825019;6345.619262844152;6376.776812811529;6379.362063793584;6380.968095159495;5869.060950248026;5871.1486834409625;5896.086106653475;5909.966597139607;5986.551008674367;5500.972495137498;5564.916526252109;5576.330840299109;5589.217509548666;5601.6358936668985;6441.162648855712;6444.709988050549;6454.838629034218;6473.611583305017;6479.481641468766;6145.647957449354;6286.65423401699;6327.525435592257;6344.587601805868;6354.3963323484195;6392.616443013434;6400.007998760199;6448.161738973903;6456.483481321389;6467.126937863516;6364.936350636434;6367.9044814328745;6371.904421433589;6381.585196962183;6384.010478375859;6268.686565671789;6281.748730050746;6285.371462853861;6305.936940630719;6394;5587.525060369914;6243.157173781663;6259.62442253448;6264.373562643881;6288.528360373082;6227.384498510727;6261.092141639346;6269.937300627118;6276.372362763687;6278.560500764903;5175.171972484535;6102.0541816018585;6142.345304543789;6150.7539698411565;6225.066240063846;6220.533459990609;6242.344553821783;6274.686265686606;6277.71750271248;6285.277193122666;5285.260063591023;6157.076438534255;6162.845928851635;6179;6204.503639708722 10:30:06 INFO - PROCESS | 1983 | |1;ext.html;488.97310647914395;589.5489950188107;597.677254282687;668.9264180940096;670.7289686044945;35731;40174;40234.994125146884;40251;40311;45447.77276113615;45945.77027114868;45984.77007614965;46126.84682882929;46214;9778.755531111727;10014.048665376778;10019.799604007916;10024.99750024999;10047;9742.269329800294;9872.457014864216;9875.753106172331;9887.307888447811;9888.752781180492;9961.252906032041;10059.144972677332;10062.345947513424;10064.144547713417;10067.64763233287;9956.551955161998;10028.498575071217;10035.74910627233;10038.799224015553;10040.548175332127;9958.103770660602;10090.747731306703;10092.04125608066;10093.596256149745;10106.44414557199;44323;44589.77705111486;44763.55236447659;44879.55120448786;45059.54940450619;3434.6221915589267;3447.9655203448146;3515.789052656849;3885.320068987944;4001.0397504598977;29574;30001.949931752282;30559.236019099477;30968.225794355098;31120.688793112007;2795.3011747063233;2802.495550800855;2812.2406950123554;2869.497837878384;2923.1522858371045;497358;498384;498889;499061;500070;48515.75742121338;49083.52749417523;71801.64099179575;72148.2785172152;72184.27815721881;48272;48626.27060594094;48735.512644873095;48747.26879096816;48805.511944880804;16813.831861681472;16927.746083808754;16969.745453818203;17009.23458444373;17024.91487542579;13295.800562991562;13353.065285429926;13365.732685346238;13372.799408008888;13421.463141474233;12792.488300468063;15686.294116764544;15692.136932468595;15715.921420393053;15801.446949356947;6272.623642581369;6357.4914006879335;6408.51936104794;6421.614703117828;6442.226932768004;997.344408282248;1032.2439632604621;1089.3137323486312;1138.510440510572;1169.8537682789652;30952;31123.807244773034;31172.376552468824;31218.84390578078;31392;1148.3511815824033;1159.2812456277163;1208.5528354508888;1238.2137342787214;1255.1841303152842;15747.44883929057;15822.446214382671;15863.444779432895;16143.838561614468;16153.515394538183;544979;547048;551385;554986;556161;63890;64318.71362572722;64368.67815660985;64475;64604.67697661481;1244.2161438293997;1418.2483283859572;1540.5763415060724;1547.5589457004926;1572.732635451953;24519.38701532476;29884;29964.550531742476;30489.847550762104;32760.344793103526;58175;58926.705366472896;59276.70361648164;59361.81276374362;59486.70256648689;508912;512964;514467;517540;517635;46682.53317466782;47783.761081195764;47939.76030119827;49352;49375.76560586014;46399.3040104392;46437.53562464332;46655.53344466648;47644.52355476401;48151.75924120357;37498;38055.80972095122;38813.805930970164;39443.013924652114;39716;38835.02912427212;39728.00679983023;40394.59605403908;40675.983100421545;40713;37959.620403795605;38414.9664285246;38935.805320974345;39122;39398.01504962399;32871.027738335775;33410.33179336448;34256.40107964695;34604.65395346014;35162.648373515935;26322.73677263203;26365.98282891824;26400.339991500365;26621.866890665424;26791.866040669673 10:30:06 INFO - PROCESS | 1983 | |2;jquery.html;383.3023896508355;386.71802973144037;389.69409013924076;390.3383764519139;395.94654721612574;19626.705599416022;21257.468563285925;21947.67078493824;21971.121155153796;22002.33992980211;21839.672404913897;21931.342059738232;22218.00018999145;22304.33087007388;22316.995735191915;5903.4686878180955;5991.550633702468;6138.386161383871;6232.252129744415;6244.906326405107;6095.238095238095;6196.194494715681;6203.565750397474;6212.192414986045;6217.316095229521;5867.442592953684;6166.8149955501185;6181.969090154543;6186.752529898821;6199.0391489319;6075.301340345851;6120.326764055951;6129.1725617041575;6131.632102073845;6147.2930612979635;5242.18746094356;5318.654287471302;5326.547243484309;5347.946520534783;5363.651362661414;13507.054506184571;14007.789883151761;14049.016568840185;27478.862605687045;27535.86232068847;2159.3953692965993;2446.6330050492393;2748.4090920452;2850.144956513038;2860.3707184419395;10173.643922462752;10586.20603454744;11360.545578176863;11571.6528504145;15216.619584510365;1687.0721103393084;1732.8799809114705;1748.5978225008319;1790.6597746428267;1861.7300491428666;115599.42200288945;117679;118665.40667296694;121361.99999999911;121821.39089304586;10407.843882341771;10740.409277489656;11637.359945202927;11665.941670291595;11753;14628.48800292006;14639.023731796284;14670.386257511665;14702.191379474018;14713.822894168441;8665.090165532654;8810.603522841488;8857.070007649232;8888.60001299943;8926.018138004814;8922.643094276285;8945.15021072997;8952.507612081397;9028.81942361149;9051.502167380726;3748.269087527906;4564.246899261651;4569.9314510282375;4579.931301030487;4613.653975951817;1879.6710575649206;1911.397909658453;1912.7130930360556;1915.2817693364989;1928.6142771445766;904.213334399077;955.7992821507561;990.4601991914424;1040.6825918094903;1105.160078340451;20813.687794683094;21455.570888582453;21542.676859847114;21595.432772752512;21886.233981810878;908.5911339896941;956.7942892278194;1004.6333088422673;1022.1260821997085;1050.2700623066896;11298.830517542243;11417.120237506186;11463.426828658534;11528.193026488234;11533.942330288295;685084;691290;700084;704838;714132;80643.7903431449;83548.16451835526;110719;120788;124353.37823310826;992.9205663546899;1004.0662184168647;1022.2435397805571;1022.3916769522123;1026.2457094035879;18324.040194282712;18478.63042739111;18846.151923163216;19044.523886902938;19164.233430662618;45600.7719961398;52364.476355237486;52574;53944.908388383396;55455;74541;75248;76899.61550192213;77833.61083194548;79180.60409697915;8065.516069035877;8209.466384684976;8212.712555060543;8459.027211870714;8696.956515217384;12458.626241212778;12828.679283017998;13174.473021079433;13520.918326533658;13537.390817413043;11354.091672666333;11614;11714.355710436008;11907.106966977684;12062.97464715509;11340.489677964346;11465.197436179387;11530.135239856876;11790.705232369259;11909.761804763682;11722.355270459866;11804.940975295069;11919.582814601446;12055.457504412147;12203.69490762738;8199.918000819915;8421.326293896596;8452.492850428995;8584.356173287153;8838.823223535623;9807.313488055768;11527.308361498337;11744.530218791153;11986.101042421678;12131.514739410324 10:30:06 INFO - PROCESS | 1983 | |3;mootools.html;1495.596189028963;1605.181357507671;1639.5737108351825;1968.2127149140342;2057.269669267409;8248.257656810885;8789.736307910765;8921.420107692995;8930.240929520998;8944.955275223623;8624.784380390493;8850.91149088509;8859.15837995391;8860.20258176764;8867.955660221689;2125.6280150973516;2526.002229119497;2580.303318104111;2581.4449893272945;2581.5095131924872;2555.1567982565803;2627.172440681189;2629.3163777417913;2631.8552479613613;2637.0770230419294;2550.630158626998;2560.4111054457485;2590.378309205796;2591.5335239656856;2594.9091781787643;2559.5392829290813;2565.8973641054336;2593.247958092151;2597.0390955346643;2597.8830952607177;2596.389848385628;2613.5426300397544;2627.973720262792;2635.367511797174;2639.9076032338776;8977.820443591158;9037.096290370977;9046.728598142066;9050.547472626342;9065.274778017743;5598.412166722517;5699.2306038684665;5756.194132821366;5758.193852860602;5761.991651460978;2992.7755418343495;3615.94576081359;3755.192633583765;3760.492333534965;3817.0838998640406;1061.6814955513314;1080.7028067281483;1088.0751361342875;1096.2490693874722;1118.9608363707232;12084.939575302154;12290.20113692607;12294.508219671203;12304.261744295281;12307;4285.400043993844;5028.79884804611;5052.520010598987;5118.795248190105;5125.487451254845;10610.310329828537;10623.256372053882;10639.308444951053;10640.840387394195;10640.946795265974;5725.2843394575675;5728.684922329228;5731.627444216113;5734.942650573525;5757.309122905278;4591.242444996538;4598.540145985442;4703.482616912137;4758.095961767253;5170.689758614495;4073.6333729963853;4125.319322311785;4157.812898419578;4162.895927601774;4173.603507666767;1348.1493991942864;1380.641033331321;1383.5295999360064;1391.9095258808145;1392.1855714407186;1188.9405529723651;1198.8681245063035;1241.8944389726794;1414.420087764012;1438.9064710793764;8415.747527574182;8487.915120848837;8534.487930724177;8536.317094632539;8546;534.3587694766296;536.0404875273296;538.6202727077401;542.8045903474746;544.5833937038169;6316.178896743394;6317.5893566918;6363.713632886531;6370.458511026522;6380.585261957958;10673;11008.284461509977;11021.393823339633;11185.32888026721;11227.21409501327;9701.6604418845;10006.399616023062;10912.890871091346;10962.835557466644;10969.451527423596;8573.657053717907;8578.65685372578;8621.137886211454;8640.14236939061;8694.478331300143;8015.83968320642;8108.635111420118;8119.715809946623;8282.296004839656;8349.749507514784;9418.858717119112;9530.761730956505;9684.983076777118;9724.367916085432;9919.702408927455;9857.11285984265;10067.798644026932;10139.64511242103;10267.58929642806;10276.972302769664;7658.119316278477;8324;8400.075991641037;8407.2433480987;8460.450070745383;7981;8001.319887809602;8028.357731381592;8238.83522329538;8450.450720703135;7379.704811807467;7473.290037446434;7488.850222995401;7614.895840103043;7663.69345226207;7359.852802943804;7413.925860741324;7471.9626401867645;7482.401407887465;7495.400367970658;7819.374450044096;7895.763127106196;7907.920920790719;7912.68349266046;7922.683092676229;7158.4273258140265;7173.390261827803;7245.492815502864;7258.419326453765;7259.6370181491775;7331.193568707545;7406.07424071991;7407.2592740725495;7408.37028852532;7430.665620047002 10:30:06 INFO - PROCESS | 1983 | |4;prototype.html;293.50983856958874;341.57815098353547;342.91084318077293;344.83103279393094;347.1252443841519;5125.513076257755;5244.737763111839;6433.4531564816925;6437.645929473877;6523.739050437988;6405.5516113872045;6430;6459.483241340693;6465.385788350111;6467.450266727334;4671.369365135697;4727.787249573777;4807.783649735753;4883.1942729449775;4894.290327902452;4815.759212039402;4855;4873.537013983666;4878.268259761029;4885.120678277908;4807.951920480786;4814.759262036901;4823;4844.75776211188;4848.054629347279;4611.262198048313;4655.371524844137;4759.286107083931;4760.166970780099;4777.856664300077;4115.300398932189;4116.115035267402;4117.21772863155;4127.009517715756;4130.297849365615;6090;6101.237345331833;6104.542159338067;6111.908321375183;6129.325774164839;5591.30108736408;5591.4688104629995;5592.3009623797025;5596.748146333425;5603.80386686464;5534.52956498694;6717.227518835348;6779.389854913082;6790.830229244259;6799.218089919673;4315.3095504719095;4487.506374298824;4497.572730590621;4507.504174540798;4514.661400394951;6502.5448218624715;6966.825829354256;7125.180604230528;7132.358087772073;7136.357727804522;4537.549723149528;4589.747563884019;4589.862304130815;4591.77041147948;4606.355110284563;4645.070985802853;4650.720956742606;4653.255029363989;4656.4412270527755;4677.298405239241;5466.207399926989;5478.808241711521;5479.369872464717;5484.314460692413;5492.890142197213;6576.572522786004;6817.7272909083085;6828;6850.212225594021;6856.725730970706;1593.4263665080562;1606.3253433557934;1613.6853313603735;1615.111688571281;1618.425458962075;1029.3155051890558;1032.488917985602;1047.8113939490813;1048.3605000949415;1056.9418681972566;6380.521460890452;6516.283208847023;6566.146400967844;6566.737330506822;6572.671366431659;7105.396041336441;7117.3238542338395;7117.679704413314;7119.252478489788;7123.786286411416;6692.063111164441;6700.83247918806;6700.899486507707;6715.764948226789;6716.496262780311;3709.8330575124182;3752.3996160614715;3760.1163726524246;3760.435934609776;3761.717871159674;7135.857282854314;7483.289087536676;7487.1764105948305;7510.1738808731;7510.248975102446;7312.853742925112;7317.341439270384;7322.340989310881;7334.229905859808;7364.852702945911;7450.850982980419;7463.992361031192;7474.289942455458;7474.887876681854;7477.962610186914;7144.106986626672;7144.606556803529;7154.141503019671;7162.140543134858;7166.140063192451;6798.864022719419;6997.641132256444;7030.648467576703;7042.154941407064;7059.329363710439;7391.371733402721;7431.739889103856;7459.962700186465;7481.738139165103;7482.70069197226;3891.4746509220895;4813.278008298783;4816.084943860796;4820.831270905502;4821.7589120544535;5685.658860468385;7053.259407762111;7055.2944705529035;7073.6463176839925;7074.717011319695;5278.604104692086;6687.164104486939;6851.07510486078;6853.17761868579;6990.475714321345;5840.86103209887;6710.932890671031;6905.482088843256;6943.79168624942;6998.965005174941;6804.591724496546;6812.250652428328;6834.2140653825445;6836.38472537474;6856.485763567653;6964.965175174294;6966.059581956371;6971.3028697129885;6972;6977.651117444209;6528.9020664689115;6540.149780528501;6714.261431242657;6793.762218322335;6830.077939478306 10:30:06 INFO - PROCESS | 1983 | |5;yui.html;667.1379780740623;770.6108415250297;800.0439474827582;815.8898548695925;827.4538804389105;15345.999999999985;15641.921790391032;15643.687126257468;15654.21728913554;15669.13819739914;13850.030497865153;14449.63875903103;14454.277286135677;14456.349464274106;14461.710765784677;964.8600952861848;986.6349450703214;986.7681094942683;986.8865080515761;987.7086259553449;972.9221662267001;992.7915137821067;992.9304948653597;994.9502524873764;995.1342332171022;1045.707201983442;1047.3558761361785;1048.1300520567947;1048.8741351037886;1049.1397054415384;1032.2516175772616;1036.984445233322;1040.1055092620416;1040.5525623981684;1041.250299784154;776.3556248313886;777.6267391651982;778.1323823936327;779.0690125300268;779.4154384211841;14123.929380353135;14174.291285435687;14210.218437985906;14211.573652790434;14211.715765684628;11812.232204906653;11978.520859165623;12049.082939784541;12219.633410997685;12724.427400766988;11272.15458840582;11354.48904799286;11452.083833293316;11770;11870.228435151688;3544.430288041175;3559.2525569630407;3578.177019285579;3622.4852836535383;3826.6364695354177;77695.6115219426;83042.77179211522;83635.5818220905;83768.16231837726;84148.3170336596;9669.564869580885;9963.950180249052;10144.797104057878;10274.948625256975;10319.896801032044;22156.667649985262;22559.09763609437;22580.322590322317;22582.435439113826;22661.433464163198;8023.358131349478;8111.148329425443;8128.552929588811;8183.918160818315;8227.218414250636;4247.957520424756;4347.152305300436;4359.869203923888;4431.246688063037;4457.8216871324785;3811.256804923069;3866.168773713665;3866.709996750255;3867.2652196082654;3871.5741268460447;676.7732809508772;695.9930400696029;700.2892064554482;700.6706847781535;722.2055738687507;525.3590619444271;561.6517758989371;609.9512039036866;611.9938800612026;620.6586377492451;8172.305354044854;8742.519161446055;8884.244839188741;9023.639054437748;9167.44995300284;617.1452538234578;627.3068259573197;639.0350570638277;645.7417033186669;652.4356431686651;3711.2206436648607;3854.3447613905705;3932.5870783567884;3981.0407663354317;4116.073883376276;97262.51368743111;97843;99224;99233.51149732759;99248.00751992388;72895;83574;83584;84631;84837.72743408853;71739;72300;72960.17599559948;73447;74792.62603686946;8448.577571121543;8623.525706086226;8770.12298770118;8778.780530486789;8864.64541418336;51341.22988155106;52282.954340913726;52653;52924.47075529196;55074.17388739252;70412.29587704057;74093.88859167225;74925;75156;75891;11049.779004419706;11250.66248012561;11367.846058348852;11483.8277425837;11574.131940104357;11821.70445738829;12134.150609457252;12255.69360765988;12466.1273710843;12509.687257818627;10033.1973442123;11293.604723834955;11506;11771.705707357385;11820.82268765952;11642.126840487166;11935.701607459536;11962.461689223832;11987.76024479523;12008.819867702166;10916.890831091587;11306.321620702784;11469.483873225558;11505.309681418807;11556.826647600461;9339.486328252011;9480.762980925532;9767.706968790948;9843.310968232156;9904.108630223314;9427.3400861939;9802.068803463659;9948.651797187063;9976.401415915068;9981.401115933068 10:30:06 INFO - PROCESS | 1983 | __end_tp_report 10:30:06 INFO - PROCESS | 1983 | __start_cc_report 10:30:06 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,995 10:30:06 INFO - PROCESS | 1983 | __end_cc_report 10:30:06 INFO - PROCESS | 1983 | __startTimestamp1464370206470__endTimestamp 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | ------- Summary: start ------- 10:30:06 INFO - PROCESS | 1983 | Number of tests: 6 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#0] dojo.html Cycles:165 Average:5891.90 Median:6157.08 stddev:620.67 (10.1%) stddev-sans-first:594.99 10:30:06 INFO - PROCESS | 1983 | Values: 3559.3 3643.9 3645.5 3658.7 3720.3 5872.8 5890.2 5891.9 5912.6 5952.5 5854.6 5941.1 5941.8 5954.9 5964.1 5186.8 5279.3 5307.8 5351.0 5401.4 5386.9 5399.1 5402.7 5407.5 5414.4 5326.0 5394.5 5412.0 5431.8 5455.6 5390.1 5393.3 5395.7 5406.6 5451.8 5124.1 5325.7 5342.2 5353.4 5354.9 5722.1 5756.5 5763.8 5768.0 5784.8 6242.3 6389.1 6390.5 6393.8 6395.4 6246.1 6270.5 6297.4 6297.4 6324.2 6061.1 6062.8 6063.4 6080.7 6095.0 6257.8 6331.2 6434.5 6437.5 6451.4 6319.4 6323.2 6352.9 6356.5 6356.9 6327.8 6339.6 6343.9 6346.7 6352.5 6209.0 6252.2 6311.7 6387.3 6397.1 6329.1 6359.1 6369.9 6373.8 6387.8 5060.3 5075.6 5089.1 5092.0 5095.7 4480.1 4500.2 4547.1 4605.7 4634.8 5949.1 5968.4 5971.8 5981.5 5989.0 6296.4 6345.6 6376.8 6379.4 6381.0 5869.1 5871.1 5896.1 5910.0 5986.6 5501.0 5564.9 5576.3 5589.2 5601.6 6441.2 6444.7 6454.8 6473.6 6479.5 6145.6 6286.7 6327.5 6344.6 6354.4 6392.6 6400.0 6448.2 6456.5 6467.1 6364.9 6367.9 6371.9 6381.6 6384.0 6268.7 6281.7 6285.4 6305.9 6394.0 5587.5 6243.2 6259.6 6264.4 6288.5 6227.4 6261.1 6269.9 6276.4 6278.6 5175.2 6102.1 6142.3 6150.8 6225.1 6220.5 6242.3 6274.7 6277.7 6285.3 5285.3 6157.1 6162.8 6179.0 6204.5 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#1] ext.html Cycles:180 Average:67273.67 Median:21410.56 stddev:138718.91 (647.9%) stddev-sans-first:139017.42 10:30:06 INFO - PROCESS | 1983 | Values: 489.0 589.5 597.7 668.9 670.7 35731.0 40174.0 40235.0 40251.0 40311.0 45447.8 45945.8 45984.8 46126.8 46214.0 9778.8 10014.0 10019.8 10025.0 10047.0 9742.3 9872.5 9875.8 9887.3 9888.8 9961.3 10059.1 10062.3 10064.1 10067.6 9956.6 10028.5 10035.7 10038.8 10040.5 9958.1 10090.7 10092.0 10093.6 10106.4 44323.0 44589.8 44763.6 44879.6 45059.5 3434.6 3448.0 3515.8 3885.3 4001.0 29574.0 30001.9 30559.2 30968.2 31120.7 2795.3 2802.5 2812.2 2869.5 2923.2 497358.0 498384.0 498889.0 499061.0 500070.0 48515.8 49083.5 71801.6 72148.3 72184.3 48272.0 48626.3 48735.5 48747.3 48805.5 16813.8 16927.7 16969.7 17009.2 17024.9 13295.8 13353.1 13365.7 13372.8 13421.5 12792.5 15686.3 15692.1 15715.9 15801.4 6272.6 6357.5 6408.5 6421.6 6442.2 997.3 1032.2 1089.3 1138.5 1169.9 30952.0 31123.8 31172.4 31218.8 31392.0 1148.4 1159.3 1208.6 1238.2 1255.2 15747.4 15822.4 15863.4 16143.8 16153.5 544979.0 547048.0 551385.0 554986.0 556161.0 63890.0 64318.7 64368.7 64475.0 64604.7 1244.2 1418.2 1540.6 1547.6 1572.7 24519.4 29884.0 29964.6 30489.8 32760.3 58175.0 58926.7 59276.7 59361.8 59486.7 508912.0 512964.0 514467.0 517540.0 517635.0 46682.5 47783.8 47939.8 49352.0 49375.8 46399.3 46437.5 46655.5 47644.5 48151.8 37498.0 38055.8 38813.8 39443.0 39716.0 38835.0 39728.0 40394.6 40676.0 40713.0 37959.6 38415.0 38935.8 39122.0 39398.0 32871.0 33410.3 34256.4 34604.7 35162.6 26322.7 26366.0 26400.3 26621.9 26791.9 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#2] jquery.html Cycles:180 Average:37261.70 Median:21986.73 stddev:115406.10 (524.9%) stddev-sans-first:115696.62 10:30:06 INFO - PROCESS | 1983 | Values: 383.3 386.7 389.7 390.3 395.9 19626.7 21257.5 21947.7 21971.1 22002.3 21839.7 21931.3 22218.0 22304.3 22317.0 5903.5 5991.6 6138.4 6232.3 6244.9 6095.2 6196.2 6203.6 6212.2 6217.3 5867.4 6166.8 6182.0 6186.8 6199.0 6075.3 6120.3 6129.2 6131.6 6147.3 5242.2 5318.7 5326.5 5347.9 5363.7 13507.1 14007.8 14049.0 27478.9 27535.9 2159.4 2446.6 2748.4 2850.1 2860.4 10173.6 10586.2 11360.5 11571.7 15216.6 1687.1 1732.9 1748.6 1790.7 1861.7 115599.4 117679.0 118665.4 121362.0 121821.4 10407.8 10740.4 11637.4 11665.9 11753.0 14628.5 14639.0 14670.4 14702.2 14713.8 8665.1 8810.6 8857.1 8888.6 8926.0 8922.6 8945.2 8952.5 9028.8 9051.5 3748.3 4564.2 4569.9 4579.9 4613.7 1879.7 1911.4 1912.7 1915.3 1928.6 904.2 955.8 990.5 1040.7 1105.2 20813.7 21455.6 21542.7 21595.4 21886.2 908.6 956.8 1004.6 1022.1 1050.3 11298.8 11417.1 11463.4 11528.2 11533.9 685084.0 691290.0 700084.0 704838.0 714132.0 80643.8 83548.2 110719.0 120788.0 124353.4 992.9 1004.1 1022.2 1022.4 1026.2 18324.0 18478.6 18846.2 19044.5 19164.2 45600.8 52364.5 52574.0 53944.9 55455.0 74541.0 75248.0 76899.6 77833.6 79180.6 8065.5 8209.5 8212.7 8459.0 8697.0 12458.6 12828.7 13174.5 13520.9 13537.4 11354.1 11614.0 11714.4 11907.1 12063.0 11340.5 11465.2 11530.1 11790.7 11909.8 11722.4 11804.9 11919.6 12055.5 12203.7 8199.9 8421.3 8452.5 8584.4 8838.8 9807.3 11527.3 11744.5 11986.1 12131.5 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#3] mootools.html Cycles:180 Average:6225.83 Median:540.71 stddev:3282.39 (607.0%) stddev-sans-first:3272.34 10:30:06 INFO - PROCESS | 1983 | Values: 1495.6 1605.2 1639.6 1968.2 2057.3 8248.3 8789.7 8921.4 8930.2 8945.0 8624.8 8850.9 8859.2 8860.2 8868.0 2125.6 2526.0 2580.3 2581.4 2581.5 2555.2 2627.2 2629.3 2631.9 2637.1 2550.6 2560.4 2590.4 2591.5 2594.9 2559.5 2565.9 2593.2 2597.0 2597.9 2596.4 2613.5 2628.0 2635.4 2639.9 8977.8 9037.1 9046.7 9050.5 9065.3 5598.4 5699.2 5756.2 5758.2 5762.0 2992.8 3615.9 3755.2 3760.5 3817.1 1061.7 1080.7 1088.1 1096.2 1119.0 12084.9 12290.2 12294.5 12304.3 12307.0 4285.4 5028.8 5052.5 5118.8 5125.5 10610.3 10623.3 10639.3 10640.8 10640.9 5725.3 5728.7 5731.6 5734.9 5757.3 4591.2 4598.5 4703.5 4758.1 5170.7 4073.6 4125.3 4157.8 4162.9 4173.6 1348.1 1380.6 1383.5 1391.9 1392.2 1188.9 1198.9 1241.9 1414.4 1438.9 8415.7 8487.9 8534.5 8536.3 8546.0 534.4 536.0 538.6 542.8 544.6 6316.2 6317.6 6363.7 6370.5 6380.6 10673.0 11008.3 11021.4 11185.3 11227.2 9701.7 10006.4 10912.9 10962.8 10969.5 8573.7 8578.7 8621.1 8640.1 8694.5 8015.8 8108.6 8119.7 8282.3 8349.7 9418.9 9530.8 9685.0 9724.4 9919.7 9857.1 10067.8 10139.6 10267.6 10277.0 7658.1 8324.0 8400.1 8407.2 8460.5 7981.0 8001.3 8028.4 8238.8 8450.5 7379.7 7473.3 7488.9 7614.9 7663.7 7359.9 7413.9 7472.0 7482.4 7495.4 7819.4 7895.8 7907.9 7912.7 7922.7 7158.4 7173.4 7245.5 7258.4 7259.6 7331.2 7406.1 7407.3 7408.4 7430.7 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#4] prototype.html Cycles:180 Average:5635.93 Median:6448.56 stddev:1782.37 (27.6%) stddev-sans-first:1741.68 10:30:06 INFO - PROCESS | 1983 | Values: 293.5 341.6 342.9 344.8 347.1 5125.5 5244.7 6433.5 6437.6 6523.7 6405.6 6430.0 6459.5 6465.4 6467.5 4671.4 4727.8 4807.8 4883.2 4894.3 4815.8 4855.0 4873.5 4878.3 4885.1 4808.0 4814.8 4823.0 4844.8 4848.1 4611.3 4655.4 4759.3 4760.2 4777.9 4115.3 4116.1 4117.2 4127.0 4130.3 6090.0 6101.2 6104.5 6111.9 6129.3 5591.3 5591.5 5592.3 5596.7 5603.8 5534.5 6717.2 6779.4 6790.8 6799.2 4315.3 4487.5 4497.6 4507.5 4514.7 6502.5 6966.8 7125.2 7132.4 7136.4 4537.5 4589.7 4589.9 4591.8 4606.4 4645.1 4650.7 4653.3 4656.4 4677.3 5466.2 5478.8 5479.4 5484.3 5492.9 6576.6 6817.7 6828.0 6850.2 6856.7 1593.4 1606.3 1613.7 1615.1 1618.4 1029.3 1032.5 1047.8 1048.4 1056.9 6380.5 6516.3 6566.1 6566.7 6572.7 7105.4 7117.3 7117.7 7119.3 7123.8 6692.1 6700.8 6700.9 6715.8 6716.5 3709.8 3752.4 3760.1 3760.4 3761.7 7135.9 7483.3 7487.2 7510.2 7510.2 7312.9 7317.3 7322.3 7334.2 7364.9 7450.9 7464.0 7474.3 7474.9 7478.0 7144.1 7144.6 7154.1 7162.1 7166.1 6798.9 6997.6 7030.6 7042.2 7059.3 7391.4 7431.7 7460.0 7481.7 7482.7 3891.5 4813.3 4816.1 4820.8 4821.8 5685.7 7053.3 7055.3 7073.6 7074.7 5278.6 6687.2 6851.1 6853.2 6990.5 5840.9 6710.9 6905.5 6943.8 6999.0 6804.6 6812.3 6834.2 6836.4 6856.5 6965.0 6966.1 6971.3 6972.0 6977.7 6528.9 6540.1 6714.3 6793.8 6830.1 10:30:06 INFO - PROCESS | 1983 | 10:30:06 INFO - PROCESS | 1983 | [#5] yui.html Cycles:180 Average:19163.15 Median:26589.18 stddev:27130.00 (102.0%) stddev-sans-first:27170.56 10:30:06 INFO - PROCESS | 1983 | Values: 667.1 770.6 800.0 815.9 827.5 15346.0 15641.9 15643.7 15654.2 15669.1 13850.0 14449.6 14454.3 14456.3 14461.7 964.9 986.6 986.8 986.9 987.7 972.9 992.8 992.9 995.0 995.1 1045.7 1047.4 1048.1 1048.9 1049.1 1032.3 1037.0 1040.1 1040.6 1041.3 776.4 777.6 778.1 779.1 779.4 14123.9 14174.3 14210.2 14211.6 14211.7 11812.2 11978.5 12049.1 12219.6 12724.4 11272.2 11354.5 11452.1 11770.0 11870.2 3544.4 3559.3 3578.2 3622.5 3826.6 77695.6 83042.8 83635.6 83768.2 84148.3 9669.6 9964.0 10144.8 10274.9 10319.9 22156.7 22559.1 22580.3 22582.4 22661.4 8023.4 8111.1 8128.6 8183.9 8227.2 4248.0 4347.2 4359.9 4431.2 4457.8 3811.3 3866.2 3866.7 3867.3 3871.6 676.8 696.0 700.3 700.7 722.2 525.4 561.7 610.0 612.0 620.7 8172.3 8742.5 8884.2 9023.6 9167.4 617.1 627.3 639.0 645.7 652.4 3711.2 3854.3 3932.6 3981.0 4116.1 97262.5 97843.0 99224.0 99233.5 99248.0 72895.0 83574.0 83584.0 84631.0 84837.7 71739.0 72300.0 72960.2 73447.0 74792.6 8448.6 8623.5 8770.1 8778.8 8864.6 51341.2 52283.0 52653.0 52924.5 55074.2 70412.3 74093.9 74925.0 75156.0 75891.0 11049.8 11250.7 11367.8 11483.8 11574.1 11821.7 12134.2 12255.7 12466.1 12509.7 10033.2 11293.6 11506.0 11771.7 11820.8 11642.1 11935.7 11962.5 11987.8 12008.8 10916.9 11306.3 11469.5 11505.3 11556.8 9339.5 9480.8 9767.7 9843.3 9904.1 9427.3 9802.1 9948.7 9976.4 9981.4 10:30:06 INFO - PROCESS | 1983 | -------- Summary: end -------- 10:30:06 INFO - PROCESS | 1983 | 10:30:07 INFO - TEST-INFO | 1983: exit 0 10:30:07 INFO - TEST-OK | dromaeo_css | took 1111952ms 10:30:07 INFO - TEST-START | kraken 10:30:07 INFO - operating with platform_type : mac_ 10:30:07 INFO - Initialising browser for kraken test... 10:30:07 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpQxpMYy/profile http://localhost:50395/getInfo.html) 10:30:09 INFO - PROCESS | 1987 | __metrics Screen width/height:1600/1200 10:30:09 INFO - PROCESS | 1987 | colorDepth:24 10:30:09 INFO - PROCESS | 1987 | Browser inner width/height: 1024/689 10:30:09 INFO - PROCESS | 1987 | __metrics 10:30:09 INFO - PROCESS | 1987 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:30:09 INFO - PROCESS | 1987 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:30:09 INFO - TEST-INFO | 1987: exit 0 10:30:09 INFO - Browser initialized. 10:30:09 INFO - Running cycle 1/1 for kraken test... 10:30:09 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpQxpMYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:21 INFO - PROCESS | 1990 | RSS: Main: 157270016 10:30:21 INFO - PROCESS | 1990 | 10:30:24 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50395/tests/kraken/driver.html?testName=audio-beat-detection) 10:30:24 INFO - PROCESS | 1990 | RSS: Main: 218116096 10:30:24 INFO - PROCESS | 1990 | 10:30:27 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50395/tests/kraken/driver.html?testName=audio-dft) 10:30:28 INFO - PROCESS | 1990 | RSS: Main: 228474880 10:30:28 INFO - PROCESS | 1990 | 10:30:31 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50395/tests/kraken/driver.html?testName=audio-fft) 10:30:31 INFO - PROCESS | 1990 | RSS: Main: 218025984 10:30:31 INFO - PROCESS | 1990 | 10:30:33 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50395/tests/kraken/driver.html?testName=audio-oscillator) 10:30:34 INFO - PROCESS | 1990 | RSS: Main: 219983872 10:30:34 INFO - PROCESS | 1990 | 10:30:36 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:30:36 INFO - PROCESS | 1990 | RSS: Main: 219934720 10:30:36 INFO - PROCESS | 1990 | 10:30:39 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50395/tests/kraken/driver.html?testName=imaging-darkroom) 10:30:40 INFO - PROCESS | 1990 | RSS: Main: 220094464 10:30:40 INFO - PROCESS | 1990 | 10:30:42 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50395/tests/kraken/driver.html?testName=imaging-desaturate) 10:30:43 INFO - PROCESS | 1990 | RSS: Main: 220536832 10:30:43 INFO - PROCESS | 1990 | 10:30:46 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50395/tests/kraken/driver.html?testName=json-parse-financial) 10:30:46 INFO - PROCESS | 1990 | RSS: Main: 220524544 10:30:46 INFO - PROCESS | 1990 | 10:30:48 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:30:48 INFO - PROCESS | 1990 | RSS: Main: 255336448 10:30:48 INFO - PROCESS | 1990 | 10:30:50 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:30:51 INFO - PROCESS | 1990 | RSS: Main: 256356352 10:30:51 INFO - PROCESS | 1990 | 10:30:53 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:30:54 INFO - PROCESS | 1990 | RSS: Main: 261566464 10:30:54 INFO - PROCESS | 1990 | 10:30:56 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:30:57 INFO - PROCESS | 1990 | RSS: Main: 263704576 10:30:57 INFO - PROCESS | 1990 | 10:30:59 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:00 INFO - PROCESS | 1990 | RSS: Main: 263905280 10:31:00 INFO - PROCESS | 1990 | 10:31:01 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:50395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50395/tests/kraken/driver.html?testName=ai-astar) 10:31:02 INFO - PROCESS | 1990 | RSS: Main: 325492736 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | __start_tp_report 10:31:02 INFO - PROCESS | 1990 | _x_x_mozilla_page_load 10:31:02 INFO - PROCESS | 1990 | _x_x_mozilla_page_load_details 10:31:02 INFO - PROCESS | 1990 | |i|pagename|runs| 10:31:02 INFO - PROCESS | 1990 | |0;ai-astar;109;110;109;110;111;111;129;110;109;108 10:31:02 INFO - PROCESS | 1990 | |1;audio-beat-detection;152;113;140;160;152;145;163;150;173;120 10:31:02 INFO - PROCESS | 1990 | |2;audio-dft;184;186;212;265;203;184;183;184;182;185 10:31:02 INFO - PROCESS | 1990 | |3;audio-fft;77;72;78;113;56;57;58;58;118;54 10:31:02 INFO - PROCESS | 1990 | |4;audio-oscillator;89;90;133;78;80;80;120;76;79;119 10:31:02 INFO - PROCESS | 1990 | |5;imaging-gaussian-blur;90;85;87;90;87;83;89;84;90;87 10:31:02 INFO - PROCESS | 1990 | |6;imaging-darkroom;92;92;93;93;92;93;93;93;92;93 10:31:02 INFO - PROCESS | 1990 | |7;imaging-desaturate;88;88;86;83;86;85;86;89;84;85 10:31:02 INFO - PROCESS | 1990 | |8;json-parse-financial;53;58;58;57;57;59;58;58;70;52 10:31:02 INFO - PROCESS | 1990 | |9;json-stringify-tinderbox;62;72;71;74;70;67;65;65;65;64 10:31:02 INFO - PROCESS | 1990 | |10;stanford-crypto-aes;95;95;109;106;80;79;80;81;80;83 10:31:02 INFO - PROCESS | 1990 | |11;stanford-crypto-ccm;130;129;127;118;121;117;121;122;117;118 10:31:02 INFO - PROCESS | 1990 | |12;stanford-crypto-pbkdf2;135;134;132;119;127;157;170;133;131;155 10:31:02 INFO - PROCESS | 1990 | |13;stanford-crypto-sha256-iterative;67;64;68;65;67;65;66;66;65;66 10:31:02 INFO - PROCESS | 1990 | __end_tp_report 10:31:02 INFO - PROCESS | 1990 | __start_cc_report 10:31:02 INFO - PROCESS | 1990 | _x_x_mozilla_cycle_collect,1162 10:31:02 INFO - PROCESS | 1990 | __end_cc_report 10:31:02 INFO - PROCESS | 1990 | __startTimestamp1464370262205__endTimestamp 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | ------- Summary: start ------- 10:31:02 INFO - PROCESS | 1990 | Number of tests: 14 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#0] ai-astar Cycles:10 Average:111.60 Median:110.00 stddev:6.19 (5.6%) stddev-sans-first:6.49 10:31:02 INFO - PROCESS | 1990 | Values: 109.0 110.0 109.0 110.0 111.0 111.0 129.0 110.0 109.0 108.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:152.00 stddev:18.55 (12.2%) stddev-sans-first:19.58 10:31:02 INFO - PROCESS | 1990 | Values: 152.0 113.0 140.0 160.0 152.0 145.0 163.0 150.0 173.0 120.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#2] audio-dft Cycles:10 Average:196.80 Median:185.50 stddev:25.99 (14.0%) stddev-sans-first:27.15 10:31:02 INFO - PROCESS | 1990 | Values: 184.0 186.0 212.0 265.0 203.0 184.0 183.0 184.0 182.0 185.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#3] audio-fft Cycles:10 Average:74.10 Median:58.00 stddev:23.60 (40.7%) stddev-sans-first:25.00 10:31:02 INFO - PROCESS | 1990 | Values: 77.0 72.0 78.0 113.0 56.0 57.0 58.0 58.0 118.0 54.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:79.50 stddev:21.24 (26.7%) stddev-sans-first:22.43 10:31:02 INFO - PROCESS | 1990 | Values: 89.0 90.0 133.0 78.0 80.0 80.0 120.0 76.0 79.0 119.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:2.57 (2.9%) stddev-sans-first:2.52 10:31:02 INFO - PROCESS | 1990 | Values: 90.0 85.0 87.0 90.0 87.0 83.0 89.0 84.0 90.0 87.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 10:31:02 INFO - PROCESS | 1990 | Values: 92.0 92.0 93.0 93.0 92.0 93.0 93.0 93.0 92.0 93.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.89 (2.2%) stddev-sans-first:1.86 10:31:02 INFO - PROCESS | 1990 | Values: 88.0 88.0 86.0 83.0 86.0 85.0 86.0 89.0 84.0 85.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:4.81 (8.3%) stddev-sans-first:4.75 10:31:02 INFO - PROCESS | 1990 | Values: 53.0 58.0 58.0 57.0 57.0 59.0 58.0 58.0 70.0 52.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.50 stddev:3.98 (5.8%) stddev-sans-first:3.69 10:31:02 INFO - PROCESS | 1990 | Values: 62.0 72.0 71.0 74.0 70.0 67.0 65.0 65.0 65.0 64.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:80.50 stddev:11.56 (14.4%) stddev-sans-first:12.05 10:31:02 INFO - PROCESS | 1990 | Values: 95.0 95.0 109.0 106.0 80.0 79.0 80.0 81.0 80.0 83.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:121.50 stddev:4.97 (4.1%) stddev-sans-first:4.34 10:31:02 INFO - PROCESS | 1990 | Values: 130.0 129.0 127.0 118.0 121.0 117.0 121.0 122.0 117.0 118.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.30 Median:134.50 stddev:15.90 (11.8%) stddev-sans-first:16.78 10:31:02 INFO - PROCESS | 1990 | Values: 135.0 134.0 132.0 119.0 127.0 157.0 170.0 133.0 131.0 155.0 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - PROCESS | 1990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 10:31:02 INFO - PROCESS | 1990 | Values: 67.0 64.0 68.0 65.0 67.0 65.0 66.0 66.0 65.0 66.0 10:31:02 INFO - PROCESS | 1990 | -------- Summary: end -------- 10:31:02 INFO - PROCESS | 1990 | 10:31:02 INFO - TEST-INFO | 1990: exit 0 10:31:02 INFO - TEST-OK | kraken | took 55869ms 10:31:02 INFO - SUITE-END | took 1167s 10:31:03 INFO - Completed test suite (00:19:28) 10:31:03 INFO - javascript benchmark 10:31:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3559.3415218184637, 3643.8542458301654, 3645.54430696163, 3658.707303415726, 3720.3303405387037, 5872.823815285537, 5890.234269544964, 5891.941080589193, 5912.586118971673, 5952.523798096153, 5854.648721076738, 5941.10883367494, 5941.792037278696, 5954.910676339859, 5964.13520039594, 5186.818461353853, 5279.313689220415, 5307.814226502073, 5351.036813373591, 5401.405845357008, 5386.865328366803, 5399.136138217886, 5402.6758394496455, 5407.540359069484, 5414.377346605152, 5326.0, 5394.541463975567, 5411.998780225671, 5431.782728690848, 5455.5908306876945, 5390.1375779875225, 5393.325834270716, 5395.730213489349, 5406.648567843117, 5451.809186678447, 5124.103281925685, 5325.707086110262, 5342.198670199462, 5353.384360798519, 5354.892902141974, 5722.055860782966, 5756.539476841885, 5763.769449222026, 5768.0, 5784.826455206308, 6242.344553821874, 6389.137466442064, 6390.488760899117, 6393.808185754435, 6395.392437718409, 6246.094316324153, 6270.46701030413, 6297.370262973666, 6297.433231009185, 6324.209473815773, 6061.090836374535, 6062.787802426894, 6063.423974722395, 6080.665563393967, 6095.0, 6257.812265632038, 6331.240251169889, 6434.549581529342, 6437.517186210959, 6451.387118223761, 6319.431251187415, 6323.1779868617705, 6352.936470635234, 6356.523260755369, 6356.904646430307, 6327.841803954846, 6339.619622822645, 6343.9365606343345, 6346.746130154742, 6352.4918006559365, 6209.037599172136, 6252.249730032425, 6311.684415779193, 6387.265464471552, 6397.10440538325, 6329.050642403677, 6359.109724638554, 6369.904451433232, 6373.776917807854, 6387.840303992437, 5060.266261392151, 5075.56857667095, 5089.109405854035, 5092.032513822362, 5095.668781529189, 4480.081583275421, 4500.189965806187, 4547.067851090585, 4605.65457590682, 4634.83778067766, 5949.1076338549565, 5968.432998865101, 5971.820845374646, 5981.461668449861, 5988.970055149696, 6296.401841825019, 6345.619262844152, 6376.776812811529, 6379.362063793584, 6380.968095159495, 5869.060950248026, 5871.1486834409625, 5896.086106653475, 5909.966597139607, 5986.551008674367, 5500.972495137498, 5564.916526252109, 5576.330840299109, 5589.217509548666, 5601.6358936668985, 6441.162648855712, 6444.709988050549, 6454.838629034218, 6473.611583305017, 6479.481641468766, 6145.647957449354, 6286.65423401699, 6327.525435592257, 6344.587601805868, 6354.3963323484195, 6392.616443013434, 6400.007998760199, 6448.161738973903, 6456.483481321389, 6467.126937863516, 6364.936350636434, 6367.9044814328745, 6371.904421433589, 6381.585196962183, 6384.010478375859, 6268.686565671789, 6281.748730050746, 6285.371462853861, 6305.936940630719, 6394.0, 5587.525060369914, 6243.157173781663, 6259.62442253448, 6264.373562643881, 6288.528360373082, 6227.384498510727, 6261.092141639346, 6269.937300627118, 6276.372362763687, 6278.560500764903, 5175.171972484535, 6102.0541816018585, 6142.345304543789, 6150.7539698411565, 6225.066240063846, 6220.533459990609, 6242.344553821783, 6274.686265686606, 6277.71750271248, 6285.277193122666, 5285.260063591023, 6157.076438534255, 6162.845928851635, 6179.0, 6204.503639708722], "unit": "score", "name": "dojo.html", "value": 5855.054855534986}, {"lowerIsBetter": false, "replicates": [488.97310647914395, 589.5489950188107, 597.677254282687, 668.9264180940096, 670.7289686044945, 35731.0, 40174.0, 40234.994125146884, 40251.0, 40311.0, 45447.77276113615, 45945.77027114868, 45984.77007614965, 46126.84682882929, 46214.0, 9778.755531111727, 10014.048665376778, 10019.799604007916, 10024.99750024999, 10047.0, 9742.269329800294, 9872.457014864216, 9875.753106172331, 9887.307888447811, 9888.752781180492, 9961.252906032041, 10059.144972677332, 10062.345947513424, 10064.144547713417, 10067.64763233287, 9956.551955161998, 10028.498575071217, 10035.74910627233, 10038.799224015553, 10040.548175332127, 9958.103770660602, 10090.747731306703, 10092.04125608066, 10093.596256149745, 10106.44414557199, 44323.0, 44589.77705111486, 44763.55236447659, 44879.55120448786, 45059.54940450619, 3434.6221915589267, 3447.9655203448146, 3515.789052656849, 3885.320068987944, 4001.0397504598977, 29574.0, 30001.949931752282, 30559.236019099477, 30968.225794355098, 31120.688793112007, 2795.3011747063233, 2802.495550800855, 2812.2406950123554, 2869.497837878384, 2923.1522858371045, 497358.0, 498384.0, 498889.0, 499061.0, 500070.0, 48515.75742121338, 49083.52749417523, 71801.64099179575, 72148.2785172152, 72184.27815721881, 48272.0, 48626.27060594094, 48735.512644873095, 48747.26879096816, 48805.511944880804, 16813.831861681472, 16927.746083808754, 16969.745453818203, 17009.23458444373, 17024.91487542579, 13295.800562991562, 13353.065285429926, 13365.732685346238, 13372.799408008888, 13421.463141474233, 12792.488300468063, 15686.294116764544, 15692.136932468595, 15715.921420393053, 15801.446949356947, 6272.623642581369, 6357.4914006879335, 6408.51936104794, 6421.614703117828, 6442.226932768004, 997.344408282248, 1032.2439632604621, 1089.3137323486312, 1138.510440510572, 1169.8537682789652, 30952.0, 31123.807244773034, 31172.376552468824, 31218.84390578078, 31392.0, 1148.3511815824033, 1159.2812456277163, 1208.5528354508888, 1238.2137342787214, 1255.1841303152842, 15747.44883929057, 15822.446214382671, 15863.444779432895, 16143.838561614468, 16153.515394538183, 544979.0, 547048.0, 551385.0, 554986.0, 556161.0, 63890.0, 64318.71362572722, 64368.67815660985, 64475.0, 64604.67697661481, 1244.2161438293997, 1418.2483283859572, 1540.5763415060724, 1547.5589457004926, 1572.732635451953, 24519.38701532476, 29884.0, 29964.550531742476, 30489.847550762104, 32760.344793103526, 58175.0, 58926.705366472896, 59276.70361648164, 59361.81276374362, 59486.70256648689, 508912.0, 512964.0, 514467.0, 517540.0, 517635.0, 46682.53317466782, 47783.761081195764, 47939.76030119827, 49352.0, 49375.76560586014, 46399.3040104392, 46437.53562464332, 46655.53344466648, 47644.52355476401, 48151.75924120357, 37498.0, 38055.80972095122, 38813.805930970164, 39443.013924652114, 39716.0, 38835.02912427212, 39728.00679983023, 40394.59605403908, 40675.983100421545, 40713.0, 37959.620403795605, 38414.9664285246, 38935.805320974345, 39122.0, 39398.01504962399, 32871.027738335775, 33410.33179336448, 34256.40107964695, 34604.65395346014, 35162.648373515935, 26322.73677263203, 26365.98282891824, 26400.339991500365, 26621.866890665424, 26791.866040669673], "unit": "score", "name": "ext.html", "value": 20575.692890176153}, {"lowerIsBetter": false, "replicates": [383.3023896508355, 386.71802973144037, 389.69409013924076, 390.3383764519139, 395.94654721612574, 19626.705599416022, 21257.468563285925, 21947.67078493824, 21971.121155153796, 22002.33992980211, 21839.672404913897, 21931.342059738232, 22218.00018999145, 22304.33087007388, 22316.995735191915, 5903.4686878180955, 5991.550633702468, 6138.386161383871, 6232.252129744415, 6244.906326405107, 6095.238095238095, 6196.194494715681, 6203.565750397474, 6212.192414986045, 6217.316095229521, 5867.442592953684, 6166.8149955501185, 6181.969090154543, 6186.752529898821, 6199.0391489319, 6075.301340345851, 6120.326764055951, 6129.1725617041575, 6131.632102073845, 6147.2930612979635, 5242.18746094356, 5318.654287471302, 5326.547243484309, 5347.946520534783, 5363.651362661414, 13507.054506184571, 14007.789883151761, 14049.016568840185, 27478.862605687045, 27535.86232068847, 2159.3953692965993, 2446.6330050492393, 2748.4090920452, 2850.144956513038, 2860.3707184419395, 10173.643922462752, 10586.20603454744, 11360.545578176863, 11571.6528504145, 15216.619584510365, 1687.0721103393084, 1732.8799809114705, 1748.5978225008319, 1790.6597746428267, 1861.7300491428666, 115599.42200288945, 117679.0, 118665.40667296694, 121361.99999999911, 121821.39089304586, 10407.843882341771, 10740.409277489656, 11637.359945202927, 11665.941670291595, 11753.0, 14628.48800292006, 14639.023731796284, 14670.386257511665, 14702.191379474018, 14713.822894168441, 8665.090165532654, 8810.603522841488, 8857.070007649232, 8888.60001299943, 8926.018138004814, 8922.643094276285, 8945.15021072997, 8952.507612081397, 9028.81942361149, 9051.502167380726, 3748.269087527906, 4564.246899261651, 4569.9314510282375, 4579.931301030487, 4613.653975951817, 1879.6710575649206, 1911.397909658453, 1912.7130930360556, 1915.2817693364989, 1928.6142771445766, 904.213334399077, 955.7992821507561, 990.4601991914424, 1040.6825918094903, 1105.160078340451, 20813.687794683094, 21455.570888582453, 21542.676859847114, 21595.432772752512, 21886.233981810878, 908.5911339896941, 956.7942892278194, 1004.6333088422673, 1022.1260821997085, 1050.2700623066896, 11298.830517542243, 11417.120237506186, 11463.426828658534, 11528.193026488234, 11533.942330288295, 685084.0, 691290.0, 700084.0, 704838.0, 714132.0, 80643.7903431449, 83548.16451835526, 110719.0, 120788.0, 124353.37823310826, 992.9205663546899, 1004.0662184168647, 1022.2435397805571, 1022.3916769522123, 1026.2457094035879, 18324.040194282712, 18478.63042739111, 18846.151923163216, 19044.523886902938, 19164.233430662618, 45600.7719961398, 52364.476355237486, 52574.0, 53944.908388383396, 55455.0, 74541.0, 75248.0, 76899.61550192213, 77833.61083194548, 79180.60409697915, 8065.516069035877, 8209.466384684976, 8212.712555060543, 8459.027211870714, 8696.956515217384, 12458.626241212778, 12828.679283017998, 13174.473021079433, 13520.918326533658, 13537.390817413043, 11354.091672666333, 11614.0, 11714.355710436008, 11907.106966977684, 12062.97464715509, 11340.489677964346, 11465.197436179387, 11530.135239856876, 11790.705232369259, 11909.761804763682, 11722.355270459866, 11804.940975295069, 11919.582814601446, 12055.457504412147, 12203.69490762738, 8199.918000819915, 8421.326293896596, 8452.492850428995, 8584.356173287153, 8838.823223535623, 9807.313488055768, 11527.308361498337, 11744.530218791153, 11986.101042421678, 12131.514739410324], "unit": "score", "name": "jquery.html", "value": 9776.142479521555}, {"lowerIsBetter": false, "replicates": [1495.596189028963, 1605.181357507671, 1639.5737108351825, 1968.2127149140342, 2057.269669267409, 8248.257656810885, 8789.736307910765, 8921.420107692995, 8930.240929520998, 8944.955275223623, 8624.784380390493, 8850.91149088509, 8859.15837995391, 8860.20258176764, 8867.955660221689, 2125.6280150973516, 2526.002229119497, 2580.303318104111, 2581.4449893272945, 2581.5095131924872, 2555.1567982565803, 2627.172440681189, 2629.3163777417913, 2631.8552479613613, 2637.0770230419294, 2550.630158626998, 2560.4111054457485, 2590.378309205796, 2591.5335239656856, 2594.9091781787643, 2559.5392829290813, 2565.8973641054336, 2593.247958092151, 2597.0390955346643, 2597.8830952607177, 2596.389848385628, 2613.5426300397544, 2627.973720262792, 2635.367511797174, 2639.9076032338776, 8977.820443591158, 9037.096290370977, 9046.728598142066, 9050.547472626342, 9065.274778017743, 5598.412166722517, 5699.2306038684665, 5756.194132821366, 5758.193852860602, 5761.991651460978, 2992.7755418343495, 3615.94576081359, 3755.192633583765, 3760.492333534965, 3817.0838998640406, 1061.6814955513314, 1080.7028067281483, 1088.0751361342875, 1096.2490693874722, 1118.9608363707232, 12084.939575302154, 12290.20113692607, 12294.508219671203, 12304.261744295281, 12307.0, 4285.400043993844, 5028.79884804611, 5052.520010598987, 5118.795248190105, 5125.487451254845, 10610.310329828537, 10623.256372053882, 10639.308444951053, 10640.840387394195, 10640.946795265974, 5725.2843394575675, 5728.684922329228, 5731.627444216113, 5734.942650573525, 5757.309122905278, 4591.242444996538, 4598.540145985442, 4703.482616912137, 4758.095961767253, 5170.689758614495, 4073.6333729963853, 4125.319322311785, 4157.812898419578, 4162.895927601774, 4173.603507666767, 1348.1493991942864, 1380.641033331321, 1383.5295999360064, 1391.9095258808145, 1392.1855714407186, 1188.9405529723651, 1198.8681245063035, 1241.8944389726794, 1414.420087764012, 1438.9064710793764, 8415.747527574182, 8487.915120848837, 8534.487930724177, 8536.317094632539, 8546.0, 534.3587694766296, 536.0404875273296, 538.6202727077401, 542.8045903474746, 544.5833937038169, 6316.178896743394, 6317.5893566918, 6363.713632886531, 6370.458511026522, 6380.585261957958, 10673.0, 11008.284461509977, 11021.393823339633, 11185.32888026721, 11227.21409501327, 9701.6604418845, 10006.399616023062, 10912.890871091346, 10962.835557466644, 10969.451527423596, 8573.657053717907, 8578.65685372578, 8621.137886211454, 8640.14236939061, 8694.478331300143, 8015.83968320642, 8108.635111420118, 8119.715809946623, 8282.296004839656, 8349.749507514784, 9418.858717119112, 9530.761730956505, 9684.983076777118, 9724.367916085432, 9919.702408927455, 9857.11285984265, 10067.798644026932, 10139.64511242103, 10267.58929642806, 10276.972302769664, 7658.119316278477, 8324.0, 8400.075991641037, 8407.2433480987, 8460.450070745383, 7981.0, 8001.319887809602, 8028.357731381592, 8238.83522329538, 8450.450720703135, 7379.704811807467, 7473.290037446434, 7488.850222995401, 7614.895840103043, 7663.69345226207, 7359.852802943804, 7413.925860741324, 7471.9626401867645, 7482.401407887465, 7495.400367970658, 7819.374450044096, 7895.763127106196, 7907.920920790719, 7912.68349266046, 7922.683092676229, 7158.4273258140265, 7173.390261827803, 7245.492815502864, 7258.419326453765, 7259.6370181491775, 7331.193568707545, 7406.07424071991, 7407.2592740725495, 7408.37028852532, 7430.665620047002], "unit": "score", "name": "mootools.html", "value": 5002.700426017798}, {"lowerIsBetter": false, "replicates": [293.50983856958874, 341.57815098353547, 342.91084318077293, 344.83103279393094, 347.1252443841519, 5125.513076257755, 5244.737763111839, 6433.4531564816925, 6437.645929473877, 6523.739050437988, 6405.5516113872045, 6430.0, 6459.483241340693, 6465.385788350111, 6467.450266727334, 4671.369365135697, 4727.787249573777, 4807.783649735753, 4883.1942729449775, 4894.290327902452, 4815.759212039402, 4855.0, 4873.537013983666, 4878.268259761029, 4885.120678277908, 4807.951920480786, 4814.759262036901, 4823.0, 4844.75776211188, 4848.054629347279, 4611.262198048313, 4655.371524844137, 4759.286107083931, 4760.166970780099, 4777.856664300077, 4115.300398932189, 4116.115035267402, 4117.21772863155, 4127.009517715756, 4130.297849365615, 6090.0, 6101.237345331833, 6104.542159338067, 6111.908321375183, 6129.325774164839, 5591.30108736408, 5591.4688104629995, 5592.3009623797025, 5596.748146333425, 5603.80386686464, 5534.52956498694, 6717.227518835348, 6779.389854913082, 6790.830229244259, 6799.218089919673, 4315.3095504719095, 4487.506374298824, 4497.572730590621, 4507.504174540798, 4514.661400394951, 6502.5448218624715, 6966.825829354256, 7125.180604230528, 7132.358087772073, 7136.357727804522, 4537.549723149528, 4589.747563884019, 4589.862304130815, 4591.77041147948, 4606.355110284563, 4645.070985802853, 4650.720956742606, 4653.255029363989, 4656.4412270527755, 4677.298405239241, 5466.207399926989, 5478.808241711521, 5479.369872464717, 5484.314460692413, 5492.890142197213, 6576.572522786004, 6817.7272909083085, 6828.0, 6850.212225594021, 6856.725730970706, 1593.4263665080562, 1606.3253433557934, 1613.6853313603735, 1615.111688571281, 1618.425458962075, 1029.3155051890558, 1032.488917985602, 1047.8113939490813, 1048.3605000949415, 1056.9418681972566, 6380.521460890452, 6516.283208847023, 6566.146400967844, 6566.737330506822, 6572.671366431659, 7105.396041336441, 7117.3238542338395, 7117.679704413314, 7119.252478489788, 7123.786286411416, 6692.063111164441, 6700.83247918806, 6700.899486507707, 6715.764948226789, 6716.496262780311, 3709.8330575124182, 3752.3996160614715, 3760.1163726524246, 3760.435934609776, 3761.717871159674, 7135.857282854314, 7483.289087536676, 7487.1764105948305, 7510.1738808731, 7510.248975102446, 7312.853742925112, 7317.341439270384, 7322.340989310881, 7334.229905859808, 7364.852702945911, 7450.850982980419, 7463.992361031192, 7474.289942455458, 7474.887876681854, 7477.962610186914, 7144.106986626672, 7144.606556803529, 7154.141503019671, 7162.140543134858, 7166.140063192451, 6798.864022719419, 6997.641132256444, 7030.648467576703, 7042.154941407064, 7059.329363710439, 7391.371733402721, 7431.739889103856, 7459.962700186465, 7481.738139165103, 7482.70069197226, 3891.4746509220895, 4813.278008298783, 4816.084943860796, 4820.831270905502, 4821.7589120544535, 5685.658860468385, 7053.259407762111, 7055.2944705529035, 7073.6463176839925, 7074.717011319695, 5278.604104692086, 6687.164104486939, 6851.07510486078, 6853.17761868579, 6990.475714321345, 5840.86103209887, 6710.932890671031, 6905.482088843256, 6943.79168624942, 6998.965005174941, 6804.591724496546, 6812.250652428328, 6834.2140653825445, 6836.38472537474, 6856.485763567653, 6964.965175174294, 6966.059581956371, 6971.3028697129885, 6972.0, 6977.651117444209, 6528.9020664689115, 6540.149780528501, 6714.261431242657, 6793.762218322335, 6830.077939478306], "unit": "score", "name": "prototype.html", "value": 5044.528316253123}, {"lowerIsBetter": false, "replicates": [667.1379780740623, 770.6108415250297, 800.0439474827582, 815.8898548695925, 827.4538804389105, 15345.999999999985, 15641.921790391032, 15643.687126257468, 15654.21728913554, 15669.13819739914, 13850.030497865153, 14449.63875903103, 14454.277286135677, 14456.349464274106, 14461.710765784677, 964.8600952861848, 986.6349450703214, 986.7681094942683, 986.8865080515761, 987.7086259553449, 972.9221662267001, 992.7915137821067, 992.9304948653597, 994.9502524873764, 995.1342332171022, 1045.707201983442, 1047.3558761361785, 1048.1300520567947, 1048.8741351037886, 1049.1397054415384, 1032.2516175772616, 1036.984445233322, 1040.1055092620416, 1040.5525623981684, 1041.250299784154, 776.3556248313886, 777.6267391651982, 778.1323823936327, 779.0690125300268, 779.4154384211841, 14123.929380353135, 14174.291285435687, 14210.218437985906, 14211.573652790434, 14211.715765684628, 11812.232204906653, 11978.520859165623, 12049.082939784541, 12219.633410997685, 12724.427400766988, 11272.15458840582, 11354.48904799286, 11452.083833293316, 11770.0, 11870.228435151688, 3544.430288041175, 3559.2525569630407, 3578.177019285579, 3622.4852836535383, 3826.6364695354177, 77695.6115219426, 83042.77179211522, 83635.5818220905, 83768.16231837726, 84148.3170336596, 9669.564869580885, 9963.950180249052, 10144.797104057878, 10274.948625256975, 10319.896801032044, 22156.667649985262, 22559.09763609437, 22580.322590322317, 22582.435439113826, 22661.433464163198, 8023.358131349478, 8111.148329425443, 8128.552929588811, 8183.918160818315, 8227.218414250636, 4247.957520424756, 4347.152305300436, 4359.869203923888, 4431.246688063037, 4457.8216871324785, 3811.256804923069, 3866.168773713665, 3866.709996750255, 3867.2652196082654, 3871.5741268460447, 676.7732809508772, 695.9930400696029, 700.2892064554482, 700.6706847781535, 722.2055738687507, 525.3590619444271, 561.6517758989371, 609.9512039036866, 611.9938800612026, 620.6586377492451, 8172.305354044854, 8742.519161446055, 8884.244839188741, 9023.639054437748, 9167.44995300284, 617.1452538234578, 627.3068259573197, 639.0350570638277, 645.7417033186669, 652.4356431686651, 3711.2206436648607, 3854.3447613905705, 3932.5870783567884, 3981.0407663354317, 4116.073883376276, 97262.51368743111, 97843.0, 99224.0, 99233.51149732759, 99248.00751992388, 72895.0, 83574.0, 83584.0, 84631.0, 84837.72743408853, 71739.0, 72300.0, 72960.17599559948, 73447.0, 74792.62603686946, 8448.577571121543, 8623.525706086226, 8770.12298770118, 8778.780530486789, 8864.64541418336, 51341.22988155106, 52282.954340913726, 52653.0, 52924.47075529196, 55074.17388739252, 70412.29587704057, 74093.88859167225, 74925.0, 75156.0, 75891.0, 11049.779004419706, 11250.66248012561, 11367.846058348852, 11483.8277425837, 11574.131940104357, 11821.70445738829, 12134.150609457252, 12255.69360765988, 12466.1273710843, 12509.687257818627, 10033.1973442123, 11293.604723834955, 11506.0, 11771.705707357385, 11820.82268765952, 11642.126840487166, 11935.701607459536, 11962.461689223832, 11987.76024479523, 12008.819867702166, 10916.890831091587, 11306.321620702784, 11469.483873225558, 11505.309681418807, 11556.826647600461, 9339.486328252011, 9480.762980925532, 9767.706968790948, 9843.310968232156, 9904.108630223314, 9427.3400861939, 9802.068803463659, 9948.651797187063, 9976.401415915068, 9981.401115933068], "unit": "score", "name": "yui.html", "value": 7256.400999325009}], "name": "dromaeo_css", "value": 7744.128378294633}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 111.0, 111.0, 129.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [152.0, 113.0, 140.0, 160.0, 152.0, 145.0, 163.0, 150.0, 173.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 212.0, 265.0, 203.0, 184.0, 183.0, 184.0, 182.0, 185.0], "unit": "score", "name": "audio-dft", "value": 196.8}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 78.0, 113.0, 56.0, 57.0, 58.0, 58.0, 118.0, 54.0], "unit": "score", "name": "audio-fft", "value": 74.1}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 133.0, 78.0, 80.0, 80.0, 120.0, 76.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 87.0, 90.0, 87.0, 83.0, 89.0, 84.0, 90.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 86.0, 83.0, 86.0, 85.0, 86.0, 89.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [53.0, 58.0, 58.0, 57.0, 57.0, 59.0, 58.0, 58.0, 70.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [62.0, 72.0, 71.0, 74.0, 70.0, 67.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 109.0, 106.0, 80.0, 79.0, 80.0, 81.0, 80.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [130.0, 129.0, 127.0, 118.0, 121.0, 117.0, 121.0, 122.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 132.0, 119.0, 127.0, 157.0, 170.0, 133.0, 131.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.3}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 68.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1431.0}]} 10:31:03 INFO - Return code: 0 10:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:31:03 INFO - # TBPL SUCCESS # 10:31:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:31:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:31:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:31:03 INFO - 2016-05-27 10:31:03.520 screenresolution[1994:29334] starting screenresolution argv=screenresolution get 10:31:03 INFO - 2016-05-27 10:31:03.522 screenresolution[1994:29334] Display 0: 1600x1200x32@60 10:31:03 INFO - 2016-05-27 10:31:03.528 screenresolution[1995:29337] starting screenresolution argv=screenresolution list 10:31:03 INFO - Available Modes on Display 0 10:31:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:31:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:31:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:31:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:31:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:31:03 INFO - Intel Iris: 10:31:03 INFO - Chipset Model: Intel Iris 10:31:03 INFO - Type: GPU 10:31:03 INFO - Bus: Built-In 10:31:03 INFO - VRAM (Dynamic, Max): 1536 MB 10:31:03 INFO - Vendor: Intel (0x8086) 10:31:03 INFO - Device ID: 0x0a2e 10:31:03 INFO - Revision ID: 0x0009 10:31:03 INFO - Displays: 10:31:03 INFO - Display: 10:31:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:31:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:31:03 INFO - Display Serial Number: 1600x1200 60 10:31:03 INFO - Main Display: Yes 10:31:03 INFO - Mirror: Off 10:31:03 INFO - Online: Yes 10:31:03 INFO - Rotation: Supported 10:31:03 INFO - Return code: 0 10:31:03 INFO - Running post-action listener: _resource_record_post_action 10:31:03 INFO - Running post-run listener: _resource_record_post_run 10:31:04 INFO - Total resource usage - Wall time: 1192s; CPU: 52.0%; Read bytes: 479232; Write bytes: 507685888; Read time: 5; Write time: 1551 10:31:04 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198453760; Write bytes: 196304896; Read time: 17857; Write time: 401 10:31:04 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 479232; Write bytes: 300583936; Read time: 5; Write time: 1114 10:31:04 INFO - Running post-run listener: _upload_blobber_files 10:31:04 INFO - Blob upload gear active. 10:31:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:04 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 10:31:04 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:31:04 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:31:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:06 INFO - (blobuploader) - INFO - Done attempting. 10:31:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:31:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:07 INFO - (blobuploader) - INFO - Done attempting. 10:31:07 INFO - (blobuploader) - INFO - Iteration through files over. 10:31:07 INFO - Return code: 0 10:31:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:31:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:31:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487f2b1861daf92eeab9a92e7a179108481c2df12ad666facf51b4bc12ed0f9716f5707d78e2f68954f5770d3bb61a1776c4036dae975fdbef7f62aeb1ca112c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913c2a8d6773b29f440a955f29b05ffb0a752da347e2ccdfe8a86713de9eb7ee6d82be935844c25ebc91fce1254b1a00c275d6794169962cba47b6d0be4b0d4"} 10:31:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:31:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:31:07 INFO - Contents: 10:31:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487f2b1861daf92eeab9a92e7a179108481c2df12ad666facf51b4bc12ed0f9716f5707d78e2f68954f5770d3bb61a1776c4036dae975fdbef7f62aeb1ca112c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913c2a8d6773b29f440a955f29b05ffb0a752da347e2ccdfe8a86713de9eb7ee6d82be935844c25ebc91fce1254b1a00c275d6794169962cba47b6d0be4b0d4"} 10:31:07 INFO - Running post-run listener: copy_logs_to_upload_dir 10:31:07 INFO - Copying logs to upload dir... 10:31:07 INFO - mkdir: /builds/slave/test/build/upload/logs 10:31:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.044058 ========= master_lag: 15.95 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-27 10:31:23.019649) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-05-27 10:31:23.020780) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487f2b1861daf92eeab9a92e7a179108481c2df12ad666facf51b4bc12ed0f9716f5707d78e2f68954f5770d3bb61a1776c4036dae975fdbef7f62aeb1ca112c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913c2a8d6773b29f440a955f29b05ffb0a752da347e2ccdfe8a86713de9eb7ee6d82be935844c25ebc91fce1254b1a00c275d6794169962cba47b6d0be4b0d4"} build_url:https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011503 build_url: 'https://queue.taskcluster.net/v1/task/cQQDieBqTqqyY9ML0Waq_g/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487f2b1861daf92eeab9a92e7a179108481c2df12ad666facf51b4bc12ed0f9716f5707d78e2f68954f5770d3bb61a1776c4036dae975fdbef7f62aeb1ca112c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9913c2a8d6773b29f440a955f29b05ffb0a752da347e2ccdfe8a86713de9eb7ee6d82be935844c25ebc91fce1254b1a00c275d6794169962cba47b6d0be4b0d4"}' ========= master_lag: 4.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-05-27 10:31:27.562467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-05-27 10:31:27.562999) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DFjOTPkX6w/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3KFvunKFmT/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005583 ========= master_lag: 2.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-05-27 10:31:30.077478) ========= ========= Started reboot skipped (results: 3, elapsed: 6 secs) (at 2016-05-27 10:31:30.078028) ========= ========= Finished reboot skipped (results: 3, elapsed: 6 secs) (at 2016-05-27 10:31:36.573869) ========= ========= Total master_lag: 23.14 =========