builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1461078751.76 results: success (0) buildid: 20160419065241 builduid: e397c9814c614aaba8d24a82ca4595c8 revision: 29e500802b47d41effd9755787a5f31d18d79c1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.759981) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.760449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.760739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.780945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.781316) ========= 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.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-04-19 08:12:31-- 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% 9.59M=0.001s 2016-04-19 08:12:31 (9.59 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.880551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.880879) ========= 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.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.027692 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:31.929347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 08:12:31.929730) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29e500802b47d41effd9755787a5f31d18d79c1c --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-aurora --rev 29e500802b47d41effd9755787a5f31d18d79c1c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-04-19 08:12:32,006 truncating revision to first 12 chars 2016-04-19 08:12:32,006 Setting DEBUG logging. 2016-04-19 08:12:32,006 attempt 1/10 2016-04-19 08:12:32,006 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29e500802b47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 08:12:33,012 unpacking tar archive at: mozilla-aurora-29e500802b47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-19 08:12:33.207880) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:33.208203) ========= script_repo_revision: 29e500802b47d41effd9755787a5f31d18d79c1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:33.208583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:33.208862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 08:12:33.223289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-19 08:12:33.223692) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:12:33 INFO - MultiFileLogger online at 20160419 08:12:33 in /builds/slave/test 08:12:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:12:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:33 INFO - {'append_to_log': False, 08:12:33 INFO - 'base_work_dir': '/builds/slave/test', 08:12:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:12:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:33 INFO - 'branch': 'Mozilla-Aurora', 08:12:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:33 INFO - 'config_files': ('talos/mac_config.py',), 08:12:33 INFO - 'default_actions': ('clobber', 08:12:33 INFO - 'read-buildbot-config', 08:12:33 INFO - 'download-and-extract', 08:12:33 INFO - 'populate-webroot', 08:12:33 INFO - 'create-virtualenv', 08:12:33 INFO - 'install', 08:12:33 INFO - 'run-tests'), 08:12:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:33 INFO - 'download_minidump_stackwalk': True, 08:12:33 INFO - 'download_symbols': 'ondemand', 08:12:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:33 INFO - 'installer_path': 'installer.exe', 08:12:33 INFO - 'log_level': 'info', 08:12:33 INFO - 'log_name': 'talos', 08:12:33 INFO - 'log_to_console': True, 08:12:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:12:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:12:33 INFO - 'opt_config_files': (), 08:12:33 INFO - 'pip_index': False, 08:12:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:33 INFO - 'cmd': ('bash', 08:12:33 INFO - '-c', 08:12:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:33 INFO - 'enabled': True, 08:12:33 INFO - 'halt_on_failure': False, 08:12:33 INFO - 'name': 'check_screen_resolution'},), 08:12:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:33 INFO - 'cmd': ('bash', 08:12:33 INFO - '-c', 08:12:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:33 INFO - 'enabled': True, 08:12:33 INFO - 'halt_on_failure': False, 08:12:33 INFO - 'name': 'check_screen_resolution'},), 08:12:33 INFO - 'run_cmd_checks_enabled': True, 08:12:33 INFO - 'sps_profile': False, 08:12:33 INFO - 'sps_profile_interval': 0, 08:12:33 INFO - 'suite': 'dromaeojs', 08:12:33 INFO - 'system_bits': '32', 08:12:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:33 INFO - 'title': 't-yosemite-r7-0084', 08:12:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:33 INFO - 'use_talos_json': True, 08:12:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:33 INFO - 'work_dir': 'build'} 08:12:33 INFO - ##### 08:12:33 INFO - ##### Running clobber step. 08:12:33 INFO - ##### 08:12:33 INFO - Running pre-action listener: _resource_record_pre_action 08:12:33 INFO - Running main action method: clobber 08:12:33 INFO - rmtree: /builds/slave/test/build 08:12:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:35 INFO - Running post-action listener: _resource_record_post_action 08:12:35 INFO - ##### 08:12:35 INFO - ##### Running read-buildbot-config step. 08:12:35 INFO - ##### 08:12:35 INFO - Running pre-action listener: _resource_record_pre_action 08:12:35 INFO - Running main action method: read_buildbot_config 08:12:35 INFO - Using buildbot properties: 08:12:35 INFO - { 08:12:35 INFO - "project": "", 08:12:35 INFO - "product": "firefox", 08:12:35 INFO - "script_repo_revision": "production", 08:12:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:12:35 INFO - "repository": "", 08:12:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:12:35 INFO - "buildid": "20160419065241", 08:12:35 INFO - "pgo_build": "False", 08:12:35 INFO - "basedir": "/builds/slave/test", 08:12:35 INFO - "buildnumber": 186, 08:12:35 INFO - "slavename": "t-yosemite-r7-0084", 08:12:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:12:35 INFO - "platform": "yosemite_r7", 08:12:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:12:35 INFO - "branch": "mozilla-aurora", 08:12:35 INFO - "repo_path": "releases/mozilla-aurora", 08:12:35 INFO - "revision": "29e500802b47d41effd9755787a5f31d18d79c1c", 08:12:35 INFO - "stage_platform": "macosx64", 08:12:35 INFO - "builduid": "e397c9814c614aaba8d24a82ca4595c8", 08:12:35 INFO - "slavebuilddir": "test" 08:12:35 INFO - } 08:12:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 08:12:35 INFO - Running post-action listener: _resource_record_post_action 08:12:35 INFO - ##### 08:12:35 INFO - ##### Running download-and-extract step. 08:12:35 INFO - ##### 08:12:35 INFO - Running pre-action listener: _resource_record_pre_action 08:12:35 INFO - Running main action method: download_and_extract 08:12:35 INFO - mkdir: /builds/slave/test/build/tests 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:35 INFO - https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 08:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 08:12:36 INFO - Downloaded 1277 bytes. 08:12:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 08:12:36 INFO - Using the following test package requirements: 08:12:36 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:12:36 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 08:12:36 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 08:12:36 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'jsshell-mac.zip'], 08:12:36 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 08:12:36 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:12:36 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 08:12:36 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 08:12:36 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 08:12:36 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 08:12:36 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 08:12:36 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 08:12:36 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:12:36 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')]} 08:12:36 INFO - https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:12:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:12:37 INFO - Downloaded 17911333 bytes. 08:12:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:12:40 INFO - Return code: 0 08:12:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:12: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')]} 08:12:40 INFO - https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 08:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:12:42 INFO - Downloaded 17911333 bytes. 08:12:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:12:45 INFO - Return code: 0 08:12: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')]} 08:12:45 INFO - https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 08:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:12:46 INFO - Downloaded 10845168 bytes. 08:12:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:12:47 INFO - Return code: 0 08:12: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')]} 08:12:47 INFO - https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 08:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 08:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 08:12:50 INFO - Downloaded 115247424 bytes. 08:12:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:12:50 INFO - mkdir: /builds/slave/test/properties 08:12:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:50 INFO - Contents: 08:12:50 INFO - build_url:https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 08:12:51 INFO - Running post-action listener: _resource_record_post_action 08:12:51 INFO - Running post-action listener: set_extra_try_arguments 08:12:51 INFO - ##### 08:12:51 INFO - ##### Running populate-webroot step. 08:12:51 INFO - ##### 08:12:51 INFO - Running pre-action listener: _resource_record_pre_action 08:12:51 INFO - Running main action method: populate_webroot 08:12:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:51 INFO - '--tppagecycles', 08:12:51 INFO - '7'], 08:12:51 INFO - 'tests': ['tsvgm']}}, 08:12:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:12:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:12:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'tests': ['damp', 'tps']}, 08:12:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['damp', 'tps']}, 08:12:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:12:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:51 INFO - 'other': {'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'other_l64': {'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'other_nol64': {'tests': ['a11yr', 08:12:51 INFO - 'ts_paint', 08:12:51 INFO - 'tpaint', 08:12:51 INFO - 'sessionrestore', 08:12:51 INFO - 'sessionrestore_no_auto_restore', 08:12:51 INFO - 'tabpaint']}, 08:12:51 INFO - 'svgr': {'tests': ['tsvgx', 08:12:51 INFO - 'tsvgr_opacity', 08:12:51 INFO - 'tart', 08:12:51 INFO - 'tscrollx', 08:12:51 INFO - 'cart']}, 08:12:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['tsvgx', 08:12:51 INFO - 'tsvgr_opacity', 08:12:51 INFO - 'tart', 08:12:51 INFO - 'tscrollx', 08:12:51 INFO - 'cart']}, 08:12:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'tests': ['tp5o']}, 08:12:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'talos_options': ['--e10s'], 08:12:51 INFO - 'tests': ['tp5o']}, 08:12:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'talos_options': ['--xperf_path', 08:12:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:51 INFO - 'tests': ['tp5n']}, 08:12:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:51 INFO - 'talos_options': ['--e10s', 08:12:51 INFO - '--xperf_path', 08:12:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:51 INFO - 'tests': ['tp5n']}}, 08:12:51 INFO - 'talos.zip': {'path': '', 08:12:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:51 INFO - Running post-action listener: _resource_record_post_action 08:12:51 INFO - ##### 08:12:51 INFO - ##### Running create-virtualenv step. 08:12:51 INFO - ##### 08:12:51 INFO - Running pre-action listener: _resource_record_pre_action 08:12:51 INFO - Running main action method: create_virtualenv 08:12:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:51 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 08:12:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:51 INFO - Using real prefix '/tools/python27' 08:12:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:55 INFO - Installing pip.................done. 08:12:55 INFO - Return code: 0 08:12:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:55 INFO - 'HOME': '/Users/cltbld', 08:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:55 INFO - 'LOGNAME': 'cltbld', 08:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:55 INFO - 'MOZ_NO_REMOTE': '1', 08:12:55 INFO - 'NO_EM_RESTART': '1', 08:12:55 INFO - 'PAGER': '/bin/cat', 08:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:55 INFO - 'PWD': '/builds/slave/test', 08:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:55 INFO - 'SHELL': '/bin/bash', 08:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:12:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:55 INFO - 'USER': 'cltbld', 08:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:55 INFO - 'XPC_FLAGS': '0x0', 08:12:55 INFO - 'XPC_SERVICE_NAME': '0', 08:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:55 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 08:12:55 INFO - Cleaning up... 08:12:55 INFO - Return code: 0 08:12:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:12:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:55 INFO - 'HOME': '/Users/cltbld', 08:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:55 INFO - 'LOGNAME': 'cltbld', 08:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:55 INFO - 'MOZ_NO_REMOTE': '1', 08:12:55 INFO - 'NO_EM_RESTART': '1', 08:12:55 INFO - 'PAGER': '/bin/cat', 08:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:55 INFO - 'PWD': '/builds/slave/test', 08:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:55 INFO - 'SHELL': '/bin/bash', 08:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:12:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:55 INFO - 'USER': 'cltbld', 08:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:55 INFO - 'XPC_FLAGS': '0x0', 08:12:55 INFO - 'XPC_SERVICE_NAME': '0', 08:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:55 INFO - Downloading/unpacking psutil>=0.7.1 08:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:58 INFO - Installing collected packages: psutil 08:12:58 INFO - Running setup.py install for psutil 08:12:58 INFO - building 'psutil._psutil_osx' extension 08:12:58 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 08:12:59 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 08:12:59 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 08:12:59 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 08:12:59 INFO - building 'psutil._psutil_posix' extension 08:12:59 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 08:12:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:12:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:12:59 INFO - ^ 08:12:59 INFO - 1 warning generated. 08:12:59 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 08:12:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:59 INFO - Successfully installed psutil 08:12:59 INFO - Cleaning up... 08:12:59 INFO - Return code: 0 08:12:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:59 INFO - 'HOME': '/Users/cltbld', 08:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:59 INFO - 'LOGNAME': 'cltbld', 08:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:59 INFO - 'MOZ_NO_REMOTE': '1', 08:12:59 INFO - 'NO_EM_RESTART': '1', 08:12:59 INFO - 'PAGER': '/bin/cat', 08:12:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:59 INFO - 'PWD': '/builds/slave/test', 08:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:59 INFO - 'SHELL': '/bin/bash', 08:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:12:59 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:59 INFO - 'USER': 'cltbld', 08:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:59 INFO - 'XPC_FLAGS': '0x0', 08:12:59 INFO - 'XPC_SERVICE_NAME': '0', 08:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:13:02 INFO - Installing collected packages: mozsystemmonitor 08:13:02 INFO - Running setup.py install for mozsystemmonitor 08:13:02 INFO - Successfully installed mozsystemmonitor 08:13:02 INFO - Cleaning up... 08:13:02 INFO - Return code: 0 08:13:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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', '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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:13: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 blobuploader==1.2.4 08:13:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:02 INFO - 'HOME': '/Users/cltbld', 08:13:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:02 INFO - 'LOGNAME': 'cltbld', 08:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:02 INFO - 'MOZ_NO_REMOTE': '1', 08:13:02 INFO - 'NO_EM_RESTART': '1', 08:13:02 INFO - 'PAGER': '/bin/cat', 08:13:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:02 INFO - 'PWD': '/builds/slave/test', 08:13:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:02 INFO - 'SHELL': '/bin/bash', 08:13:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:02 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:02 INFO - 'USER': 'cltbld', 08:13:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:02 INFO - 'XPC_FLAGS': '0x0', 08:13:02 INFO - 'XPC_SERVICE_NAME': '0', 08:13:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:06 INFO - Downloading docopt-0.6.1.tar.gz 08:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:06 INFO - Running setup.py install for blobuploader 08:13:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:07 INFO - Running setup.py install for requests 08:13:07 INFO - Running setup.py install for docopt 08:13:07 INFO - Successfully installed blobuploader requests docopt 08:13:07 INFO - Cleaning up... 08:13:07 INFO - Return code: 0 08:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13:07 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 08:13:07 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 08:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:07 INFO - 'HOME': '/Users/cltbld', 08:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:07 INFO - 'LOGNAME': 'cltbld', 08:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:07 INFO - 'MOZ_NO_REMOTE': '1', 08:13:07 INFO - 'NO_EM_RESTART': '1', 08:13:07 INFO - 'PAGER': '/bin/cat', 08:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:07 INFO - 'PWD': '/builds/slave/test', 08:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:07 INFO - 'SHELL': '/bin/bash', 08:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:07 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:07 INFO - 'USER': 'cltbld', 08:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:07 INFO - 'XPC_FLAGS': '0x0', 08:13:07 INFO - 'XPC_SERVICE_NAME': '0', 08:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ev42x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-iW_J0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_roms_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Ix0jQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_PDEIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mZDG3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-w6LFCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WYf_Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-POXsw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:08 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Ut2WEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-TECOdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-kEEP_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qO7Gd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ewOjlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uZt4L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wFDwSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:09 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-RkYyBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:09 INFO - Running setup.py install for manifestparser 08:13:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:09 INFO - Running setup.py install for mozcrash 08:13:10 INFO - Running setup.py install for mozdebug 08:13:10 INFO - Running setup.py install for mozdevice 08:13:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Running setup.py install for mozfile 08:13:10 INFO - Running setup.py install for mozhttpd 08:13:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Running setup.py install for mozinfo 08:13:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Running setup.py install for mozInstall 08:13:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:10 INFO - Running setup.py install for mozleak 08:13:11 INFO - Running setup.py install for mozlog 08:13:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Running setup.py install for moznetwork 08:13:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Running setup.py install for mozprocess 08:13:11 INFO - Running setup.py install for mozprofile 08:13:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Running setup.py install for mozrunner 08:13:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Running setup.py install for mozscreenshot 08:13:11 INFO - Running setup.py install for moztest 08:13:12 INFO - Running setup.py install for mozversion 08:13:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:12 INFO - Cleaning up... 08:13:12 INFO - Return code: 0 08:13:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:12 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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13:12 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 08:13:12 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 08:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:12 INFO - 'HOME': '/Users/cltbld', 08:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:12 INFO - 'LOGNAME': 'cltbld', 08:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:12 INFO - 'MOZ_NO_REMOTE': '1', 08:13:12 INFO - 'NO_EM_RESTART': '1', 08:13:12 INFO - 'PAGER': '/bin/cat', 08:13:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:12 INFO - 'PWD': '/builds/slave/test', 08:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:12 INFO - 'SHELL': '/bin/bash', 08:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:12 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:12 INFO - 'USER': 'cltbld', 08:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:12 INFO - 'XPC_FLAGS': '0x0', 08:13:12 INFO - 'XPC_SERVICE_NAME': '0', 08:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CLnHdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:12 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)) 08:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_Z9tmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:12 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)) 08:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5KEMuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:12 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)) 08:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-k0WARz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:12 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)) 08:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:12 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0_x5tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-nAJUgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-c2ys0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-7MYNLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_JN7qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wJZe4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AHk5RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JadN6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SBKL_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:13 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)) 08:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:13 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FjFIHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:14 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)) 08:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-otRcFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:14 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)) 08:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XiTFPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:14 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)) 08:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:14 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YadqH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:14 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)) 08:13:14 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)) 08:13:14 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)) 08:13:14 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)) 08:13:14 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)) 08:13:14 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)) 08:13:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:17 INFO - Downloading blessings-1.6.tar.gz 08:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:17 INFO - Installing collected packages: blessings 08:13:17 INFO - Running setup.py install for blessings 08:13:18 INFO - Successfully installed blessings 08:13:18 INFO - Cleaning up... 08:13:18 INFO - Return code: 0 08:13:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:18 INFO - Reading from file tmpfile_stdout 08:13:18 INFO - Current package versions: 08:13:18 INFO - blessings == 1.6 08:13:18 INFO - blobuploader == 1.2.4 08:13:18 INFO - docopt == 0.6.1 08:13:18 INFO - manifestparser == 1.1 08:13:18 INFO - mozInstall == 1.12 08:13:18 INFO - mozcrash == 0.17 08:13:18 INFO - mozdebug == 0.1 08:13:18 INFO - mozdevice == 0.48 08:13:18 INFO - mozfile == 1.2 08:13:18 INFO - mozhttpd == 0.7 08:13:18 INFO - mozinfo == 0.9 08:13:18 INFO - mozleak == 0.1 08:13:18 INFO - mozlog == 3.1 08:13:18 INFO - moznetwork == 0.27 08:13:18 INFO - mozprocess == 0.22 08:13:18 INFO - mozprofile == 0.28 08:13:18 INFO - mozrunner == 6.11 08:13:18 INFO - mozscreenshot == 0.1 08:13:18 INFO - mozsystemmonitor == 0.0 08:13:18 INFO - moztest == 0.7 08:13:18 INFO - mozversion == 1.4 08:13:18 INFO - psutil == 3.1.1 08:13:18 INFO - requests == 1.2.3 08:13:18 INFO - wsgiref == 0.1.2 08:13:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13:18 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 08:13:18 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 08:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:18 INFO - 'HOME': '/Users/cltbld', 08:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PAGER': '/bin/cat', 08:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:18 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - 'XPC_FLAGS': '0x0', 08:13:18 INFO - 'XPC_SERVICE_NAME': '0', 08:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 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)) 08:13:18 INFO - Cleaning up... 08:13:18 INFO - Return code: 0 08:13:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:18 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 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13:18 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 08:13:18 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 08:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:18 INFO - 'HOME': '/Users/cltbld', 08:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:18 INFO - 'LOGNAME': 'cltbld', 08:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:18 INFO - 'MOZ_NO_REMOTE': '1', 08:13:18 INFO - 'NO_EM_RESTART': '1', 08:13:18 INFO - 'PAGER': '/bin/cat', 08:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:18 INFO - 'PWD': '/builds/slave/test', 08:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:18 INFO - 'SHELL': '/bin/bash', 08:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:18 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:18 INFO - 'USER': 'cltbld', 08:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:18 INFO - 'XPC_FLAGS': '0x0', 08:13:18 INFO - 'XPC_SERVICE_NAME': '0', 08:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:18 INFO - Downloading/unpacking jsonschema 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:22 INFO - Downloading/unpacking functools32 (from jsonschema) 08:13:22 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 08:13:22 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 08:13:22 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 08:13:22 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 08:13:22 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 08:13:22 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 08:13:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:22 INFO - warning: no files found matching '*.txt' 08:13:22 INFO - no previously-included directories found matching 'build' 08:13:22 INFO - no previously-included directories found matching 'dist' 08:13:22 INFO - no previously-included directories found matching '.git*' 08:13:22 INFO - Installing collected packages: jsonschema, functools32 08:13:22 INFO - Running setup.py install for functools32 08:13:22 INFO - warning: no files found matching '*.txt' 08:13:22 INFO - no previously-included directories found matching 'build' 08:13:22 INFO - no previously-included directories found matching 'dist' 08:13:22 INFO - no previously-included directories found matching '.git*' 08:13:22 INFO - Successfully installed jsonschema functools32 08:13:22 INFO - Cleaning up... 08:13:23 INFO - Return code: 0 08:13:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107e37a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e3e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2dbca1b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, '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.NlCuogOVL1/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.CECoAmv9U9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:23 INFO - 'HOME': '/Users/cltbld', 08:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:23 INFO - 'LOGNAME': 'cltbld', 08:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:23 INFO - 'MOZ_NO_REMOTE': '1', 08:13:23 INFO - 'NO_EM_RESTART': '1', 08:13:23 INFO - 'PAGER': '/bin/cat', 08:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:23 INFO - 'PWD': '/builds/slave/test', 08:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:23 INFO - 'SHELL': '/bin/bash', 08:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:13:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:23 INFO - 'USER': 'cltbld', 08:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:23 INFO - 'XPC_FLAGS': '0x0', 08:13:23 INFO - 'XPC_SERVICE_NAME': '0', 08:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:23 INFO - Downloading/unpacking flake8 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:13:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:13:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 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 08:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:27 INFO - no previously-included directories found matching 'docs/_build' 08:13:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:13:27 INFO - Running setup.py install for pep8 08:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:27 INFO - no previously-included directories found matching 'docs/_build' 08:13:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:13:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:13:27 INFO - Cleaning up... 08:13:27 INFO - Return code: 0 08:13:27 INFO - Running post-action listener: _resource_record_post_action 08:13:27 INFO - Running post-action listener: _start_resource_monitoring 08:13:27 INFO - Starting resource monitoring. 08:13:27 INFO - ##### 08:13:27 INFO - ##### Running install step. 08:13:27 INFO - ##### 08:13:27 INFO - Running pre-action listener: _resource_record_pre_action 08:13:27 INFO - Running main action method: install 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:27 INFO - Reading from file tmpfile_stdout 08:13:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:27 INFO - Reading from file tmpfile_stdout 08:13:27 INFO - Output received: 08:13:27 INFO - Usage: mozinstall [options] installer 08:13:27 INFO - Options: 08:13:27 INFO - -h, --help show this help message and exit 08:13:27 INFO - -d DEST, --destination=DEST 08:13:27 INFO - Directory to install application into. [default: 08:13:27 INFO - "/builds/slave/test"] 08:13:27 INFO - --app=APP Application being installed. [default: firefox] 08:13:27 INFO - mkdir: /builds/slave/test/build/application 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:13:59 INFO - Reading from file tmpfile_stdout 08:13:59 INFO - Output received: 08:13:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:13:59 INFO - Running post-action listener: _resource_record_post_action 08:13:59 INFO - ##### 08:13:59 INFO - ##### Running run-tests step. 08:13:59 INFO - ##### 08:13:59 INFO - Running pre-action listener: _resource_record_pre_action 08:13:59 INFO - Running main action method: run_tests 08:13:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:59 INFO - 2016-04-19 08:13:59.869 screenresolution[1648:7619] starting screenresolution argv=screenresolution get 08:13:59 INFO - 2016-04-19 08:13:59.871 screenresolution[1648:7619] Display 0: 1600x1200x32@60 08:13:59 INFO - 2016-04-19 08:13:59.877 screenresolution[1649:7621] starting screenresolution argv=screenresolution list 08:13:59 INFO - Available Modes on Display 0 08:13:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:00 INFO - Intel Iris: 08:14:00 INFO - Chipset Model: Intel Iris 08:14:00 INFO - Type: GPU 08:14:00 INFO - Bus: Built-In 08:14:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:00 INFO - Vendor: Intel (0x8086) 08:14:00 INFO - Device ID: 0x0a2e 08:14:00 INFO - Revision ID: 0x0009 08:14:00 INFO - Displays: 08:14:00 INFO - Display: 08:14:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:00 INFO - Display Serial Number: 1600x1200 60 08:14:00 INFO - Main Display: Yes 08:14:00 INFO - Mirror: Off 08:14:00 INFO - Online: Yes 08:14:00 INFO - Rotation: Supported 08:14:00 INFO - Return code: 0 08:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:00 INFO - Python 2.7.3 08:14:00 INFO - Return code: 0 08:14:00 INFO - grabbing minidump binary from tooltool 08:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:00 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 0x107cdbd30>, '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 0x107b3fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107cd2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:00 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 08:14:00 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 08:14:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:00 INFO - Return code: 0 08:14:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:14:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:14:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:14:01 INFO - Return code: 0 08:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 08:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 08:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NlCuogOVL1/Render', 08:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:01 INFO - 'HOME': '/Users/cltbld', 08:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:01 INFO - 'LOGNAME': 'cltbld', 08:14:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:01 INFO - 'MOZ_NO_REMOTE': '1', 08:14:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:01 INFO - 'NO_EM_RESTART': '1', 08:14:01 INFO - 'PAGER': '/bin/cat', 08:14:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:01 INFO - 'PWD': '/builds/slave/test', 08:14:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:01 INFO - 'SHELL': '/bin/bash', 08:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CECoAmv9U9/Listeners', 08:14:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:01 INFO - 'USER': 'cltbld', 08:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:01 INFO - 'XPC_FLAGS': '0x0', 08:14:01 INFO - 'XPC_SERVICE_NAME': '0', 08:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 08:14:01 INFO - mozversion application_buildid: 20160419065241 08:14:01 INFO - mozversion application_changeset: 29e500802b47d41effd9755787a5f31d18d79c1c 08:14:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:14:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:01 INFO - mozversion application_name: Firefox 08:14:01 INFO - mozversion application_remotingname: firefox-dev 08:14:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:14:01 INFO - mozversion application_vendor: Mozilla 08:14:01 INFO - mozversion application_version: 47.0a2 08:14:01 INFO - mozversion platform_buildid: 20160419065241 08:14:01 INFO - mozversion platform_changeset: 29e500802b47d41effd9755787a5f31d18d79c1c 08:14:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:14:01 INFO - mozversion platform_version: 47.0a2 08:14:01 INFO - using testdate: 1461078841 08:14:01 INFO - actual date: 1461078841 08:14:01 INFO - starting webserver on 'localhost:49277' 08:14:01 INFO - SUITE-START | Running 2 tests 08:14:01 INFO - TEST-START | dromaeo_css 08:14:01 INFO - operating with platform_type : mac_ 08:14:01 INFO - Initialising browser for dromaeo_css test... 08:14:01 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmprNCYA9/profile http://localhost:49277/getInfo.html) 08:14:03 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 08:14:03 INFO - PROCESS | 1667 | colorDepth:24 08:14:03 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 08:14:03 INFO - PROCESS | 1667 | __metrics 08:14:04 INFO - PROCESS | 1667 | 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" 08:14:04 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:04 INFO - TEST-INFO | 1667: exit 0 08:14:04 INFO - Browser initialized. 08:14:04 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:04 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmprNCYA9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:16 INFO - PROCESS | 1669 | RSS: Main: 207400960 08:14:16 INFO - PROCESS | 1669 | 08:15:07 INFO - PROCESS | 1669 | 1461078907548 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] 08:17:17 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 08:17:18 INFO - PROCESS | 1669 | RSS: Main: 320978944 08:17:18 INFO - PROCESS | 1669 | 08:20:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 08:20:21 INFO - PROCESS | 1669 | RSS: Main: 341868544 08:20:21 INFO - PROCESS | 1669 | 08:23:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 08:23:24 INFO - PROCESS | 1669 | RSS: Main: 344383488 08:23:24 INFO - PROCESS | 1669 | 08:26:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 08:26:27 INFO - PROCESS | 1669 | RSS: Main: 303964160 08:26:27 INFO - PROCESS | 1669 | 08:29:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 08:29:30 INFO - PROCESS | 1669 | RSS: Main: 304717824 08:29:30 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 08:32:33 INFO - PROCESS | 1669 | RSS: Main: 362348544 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | __start_tp_report 08:32:33 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 08:32:33 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 08:32:33 INFO - PROCESS | 1669 | |i|pagename|runs| 08:32:33 INFO - PROCESS | 1669 | |0;dojo.html;3345.682160194781;3437.2781715839674;3470.843812028459;3478.9478157827652;3519.9472007919885;5577.7768889244435;5588.91616625751;5605.01912165371;5605.327360716719;5617.747201375938;5562.499375056244;5563.026470367689;5611.3266408031095;5615.354234263061;5618.522425593819;4984.601231901457;5053.065182941167;5066.822661206858;5078.111330517163;5100.897982040357;5130.38435387754;5147.948520514803;5156.948430515703;5157.839486115631;5171.095058364771;5061.493850614927;5105.259737338084;5111.769970351324;5117.795288188468;5155.922661160085;5056.519630635084;5066.18940969445;5074.746262686851;5083.74581270935;5116.232565115244;4923.310736496894;5005.199168133081;5092.490750924915;5120.820771272987;5139.383274007106;5493.2034854946205;5499.615026948115;5530.5299049580835;5534.308211473566;5549.889002219973;5961.493273071794;6208.689565521706;6219;6222;6241.407066328737;6111.938880611226;6115.571909966304;6130.938690613126;6243.282022567418;6250.281217659982;5694.430556944355;5700.315962084494;5709.486146246816;5721.971390143022;5735.082386818089;6133.028644417115;6151.477124444473;6292.559520833498;6297.307296197415;6307.842303942438;6054.152418661391;6059.909101363483;6066.787662431793;6069.635821850615;6074.210352654127;6168.629882207082;6178.289496707936;6196.225471816023;6207.037909124093;6215.223097112861;5712.11462223356;5732.6847023413275;6023.608465449732;6107.328193898667;6117.510599152057;6112.694365281718;6122.672617327906;6140.8771824563255;6158.04550294705;6174.413430724074;4782.876024134325;4786.593139583105;4798.23228283473;4801.51984801517;4866.099771542276;4261.978690106592;4311.417958575615;4375.7155784873885;4376.715513491613;4434.467863856294;5589.161625756088;5610.354809196994;5612.943870561324;5619.690916999604;5631.211630371751;6191.9690401547705;6208.565400422018;6209;6216.564840461125;6232.345603711545;5441.020616289106;5544.279243698374;5562.16567514876;5573.554115670818;5633.57748168889;5253.816116435906;5288;5290.973545132327;5291.074062039128;5326.627136100513;6258.812235632939;6266.905996410058;6271.404216599416;6276.215473065958;6276.246850377984;6081.787137450168;6111.652512877656;6139.969300153471;6207.596506227081;6230.937690623035;6277.30949595535;6280.0893870389455;6283.497320214463;6285.277193122666;6289.6540690260645;6120.173776540289;6125.9693701531205;6135.07973803933;6144.477719393902;6148.385161483995;5968.507873031742;6035.637861728311;6090.3605121461605;6135.967692822179;6165.630062196283;4740.217864052531;5941.732622031933;5969.283685957713;5973.342932277533;6013.098035294566;5815.738291776965;5982.58121931478;5995.400459953969;6006.939930600813;6008.128821320972;5787.739551720267;5854.414558544111;5867;5938.168656388023;5944.375840536682;5953.404659534012;5970.522358211246;5986;6022.1870047543025;6042.697865106815;5776.306843178845;5776.797812076557;5835.854103647443;5847.707614619167;5866.354700982974 08:32:33 INFO - PROCESS | 1669 | |1;ext.html;470.703456822202;550.7443029891848;581.5870731780436;595.6307089604443;655.5574986883854;31436.371272574535;36603.901882943486;41331.79334103329;41704.16591668168;41911.58088419115;33713;45054.549454505446;45150.09699806002;45218.773906130424;45231.547684523146;9666.130048295634;9894.455804930725;9905.405675659447;9906.108450239477;9915.90084099157;9702.951485242564;9871.012898710143;9877.60489580416;9883.950580247089;10030.247731420137;9982.800343993116;10039.247056470758;10051.346662466953;10055.798884022315;10062.993700629915;9936;10020.599176032987;10024.448655323955;10033.59865605375;10045.54795034218;9869.90130098697;10027.247956403298;10027.548760305805;10031.448270345129;10037.89962100377;42775.786121069505;43225.56774432247;43242.91892702676;43337;43530.78234608838;3215.6623554526905;3398.8640454382044;3412.7099196568074;3758.2107757370713;3962.623550762673;28909.56635650467;29552;29749.107526774016;29818.701812982028;30410.54384184239;2782.8886844526196;2799.7340252675963;2822.1533539937936;2827.2931767058235;2843.559248316514;496394.5180274112;498922;499676;500572;501195;72731;72897.2710272901;72927.27072729311;73030.26969730234;73160;80543.59728201438;81565;81819;81905.59047204845;81921.59039204885;18235.72646410305;18578.814211857978;18621.534461638566;18622.16200270991;18663.81336186648;14156.29218539069;14224.14655120696;14244.43022279118;14256.859451243876;14260.85739142616;22843.657345139836;23177.841107944874;23288.883555582113;23605.409864753517;23625.7637423627;8036.357091432671;9097.772555686028;9214.032526584746;9299.163075323253;9339.953300233456;848.3679658654343;952.7713348796239;1016.7153197104675;1080.4111759091313;1126.9887301127048;31260.374792504477;31596.684033159832;31647.367052658818;32660.51009234816;33377.332453351286;1072.6728347853823;1094.042712626452;1155.306815910464;1169.3217933598662;1191.5114802930757;12504.874951250371;15367.538973830802;15497.14765687898;15680.76478852818;15839.208039597974;663662;664195;672911;676624.6168769124;677691;64816.675916620115;65881.01178482326;65948.34051659518;66132.66933665301;66200.66899665567;1424.886009119268;1550.6123469132717;1583.5407731757662;1594.4100682747226;1617.9352825886833;30098.765309120416;31631.52552711665;31749.682503174674;31982.52026219562;32679.509807353385;54096;54304;54512;54635.180472293745;54700.726496367264;419585;423100;423126;423585;424330;29768.404631907673;31497.527537086502;35196.47205291974;35218.823905881334;35555.82222088873;43794.56205438032;44452.333215001156;44477;44716.32925506185;45174;34876;37012.44481332728;37126.88619341424;37333.6266637341;37932.05169870775;28670.569941450478;36427.45358819673;36777.448338275484;36938.076548086516;37879.81060094682;37783.633800431526;38447;38656.80671596737;40799.38800917929;42433.15133697371;34340.48489272713;35684.28631427409;36118.63881361153;36143.81928090343;36201.45697814482;25883.482330353665;26460.735392645827;26463.104325699805;26560.7343926566;26927.461450771265 08:32:33 INFO - PROCESS | 1669 | |2;jquery.html;373.387644263408;377.903634573184;379.5729803970534;379.9012256813228;385.7010816617123;20078.397648070564;21349.252776152836;21874;22258.443538911535;22262.55474890505;11974.521019159223;12494.000479961604;12561.811572826415;12565.685857853536;12580.119391642565;5011.123053465647;5281.603879709018;5288.5504732097625;5290.1800220965815;5308.469153084699;4073.4704488416464;4243.97878010611;4247.575242475758;7055.717771289143;7410.740624078158;7114.64426778659;7289.671964761598;7388.963055184717;7393.706101432254;7397.63011849408;6664.93335066648;7255.05684261048;7269.963650181769;7302.74440394589;7351.926480735177;6899.517033807636;6965.094537710065;7027.6486175691525;7043.366097051239;7119.21688614252;28383;28646.99735509268;28745.137645870658;28820;29473.410531789243;2233.4304752288226;2287.142321629389;2569.1393383216646;2883.1927060423113;2957.378950420414;14634.56036905938;15949.202539873077;16137.354505819752;16572.337106515726;16969.15154242283;1877.4649224970954;1883.7645294338208;1897.8386837118862;1958.4222654317011;1988.721578978944;124520;124859.37570312181;127430.3628481861;129132;132952.670473295;16516.50450486487;17034.48896533106;19636.21455141807;19949.401517954193;20181.192752290037;25308.74691253101;30964.535531967038;31154.532682009787;31532.054038378887;31814.681853181635;9243.953780231055;10695.251332406813;10888.965548272901;11206.831897521544;11231.494582743633;7645.350145237717;9278.582463789146;9299.070092990647;9350.205232555172;9422.575984080733;8749.387542872066;8821.294296456397;8869.866951995726;8901.73294801157;8966.86549701755;2902.4630443368046;3459.39460594395;3475.913102172415;3497.877574284888;3508.08789714676;893.2139717049085;915.4187091197005;920.4431319052011;974.0794948773341;996.1881066930429;20409.897950510152;20923.058462368925;21371.145154193968;21832.563348732936;22027.559448810935;974.6686126716809;1013.7313611892854;1019.1897441533998;1045.3988956350129;1077.380506208933;11019.338839669645;11433.485493152828;11467.77064458706;11493.138014648935;11516.769664606829;500793;504593;505362.4731876317;507494;701162;102429;119968;122961.38519307526;132141;132951.68765717978;1037.6886933919945;1062.5006247063868;1075.6181555547823;1075.9354438733858;1081.1404933078222;18228.635427291647;18306.359277425225;18316.81683183151;18446.90776546109;19171.233150673816;49803.25295120504;49840.75079624579;51313;51941.48058519366;52223.21665175101;70227;71918.56162876818;72041;72297;73529.63235183789;7546.434017448603;8307.335413166811;8381.37139714536;8492;8735.650573977224;12837.439702783306;13529;13582.660433489242;13978.930105349407;14013.43946242139;10681.626143084955;11793.823092653445;11832.585859494877;11982.760344793229;11996.820047699117;11508.59719909799;11598.420078996185;11739.178257522233;11853.170278080452;11930.22453540517;11478.426078696199;11935.701607459883;11953.462094205608;12056.156069075432;12091.455884485043;8255.380846436661;8382.287505561852;8421.95789021051;8498.02272738643;8667.523286219319;11562.595309164475;11785.351805650771;11831.46758395857;12009.279443233434;12047.75904481923 08:32:33 INFO - PROCESS | 1669 | |3;mootools.html;1500;1622.805263368396;1650.3481124955647;1990.6715391960327;2078.355709729984;8262.545559994198;8737.781555461117;8886.86669699955;8891.333150013743;8903.643854245822;8630.654773809056;8905.599248033837;8908.643654253838;8918.554072296376;8920.197182253596;2068.7517497900235;2130.7549631792385;2270.409693479699;2485.2792690119845;2554.297568168759;2575.098715449587;2582.5738753105716;2584.7544483274155;2584.935376615581;2586.043164029312;2464.18681834994;2558.5906254999204;2559.795216382685;2560.3855074782105;2563.705173905006;2265.648824432224;2482.900683972639;2548.8725563721923;2551.1708694674303;2551.2346296111186;2530.8101892358145;2537.961930571043;2580.7935365170742;2582.295684847991;2585.2761226856323;8925.509096999662;8995.190432861074;9021.458712477272;9041.276697864156;9050.77373065672;5564.276644036249;5686.715664216814;5694.743736531825;5705.229793977802;5737.168110623936;3148.464760990637;3642.4354225095153;3750.887473375803;3759.4924685167425;3801.239752049601;917.7659696777346;1060.9363438193734;1086.0876863434753;1103.4813637590319;1103.9448027598587;12232.204906681038;12385.566505172275;12408.069394795517;12434.937825310906;12456.128071035031;4934.5312195341385;4989.650724449326;5022.773975171126;5036.143855544567;5063.240513922868;10665.893341066645;10682.305650132717;10685.412302323446;10686.679399618024;10706.571737130584;5688.687122208318;5690.118031705092;5744.712764361765;5749.568782341341;5759.0209664356325;4527.094581083797;4639.304104384302;4640.700603830933;4709.529047095263;4896.436909755353;4027.1140349123148;4086.713930024929;4112.074783173762;4130.876073717734;4149.128682976549;1161.7502237018912;1350.567818298135;1364.5701603994908;1373.3545233740126;1377.497213517059;1386.5493714542813;1397.8532254113172;1452.825660920675;1454.7308747881675;1458.9197594132213;7316.0489136411925;8280.04779450359;8383.28742056932;8426.789330266793;8471;487.86095962651183;493.8591852819997;517.1441264706916;526.231701715492;531.2562412622283;6090.177825993523;6172.783952561728;6176;6186.319504854462;6204.7828326008375;10287.691369258935;10591.099756520627;10592;10721.463926803784;10757.731056723644;10298.742531436774;10432.478376081166;10481.318714283547;10495.895041049493;10577.788444231226;8241.217084376975;8410.957945210357;8468.661253549912;8471.322294216448;8474.322054235647;8309.210624990616;8329.916700832913;8372.790680233044;8438.53588052663;8445;8570.314374850122;9431.528423578657;9737.367071140354;9857.014298570373;10044.598216071276;10001.049900259464;10144.036316549917;10195.847062293924;10325.432101234504;10372.377657340281;6923.515353925177;7395.408367330493;7643.388528917562;7662.655180516778;7788.92211077882;8431;8440.324774018187;8469.915300847159;8481.194286542768;8488.15118488171;7331.303526165006;7389.7413590524075;7431.205892445874;7569.886451703119;7590.127135379502;7376.631168441664;7386.2613738625705;7392.963035185005;7491.73778917757;7537.698492060256;7906.881396779168;7919.445638805229;7928.881066783887;7954.840903181788;7956.562389068657;7128.108986376703;7160.892586611101;7216.603086830275;7219.963900180465;7228.277172282729;7304.63476826146;7319.707211711472;7376.7786966391095;7379.040724705968;7382.778516644509 08:32:33 INFO - PROCESS | 1669 | |4;prototype.html;332.95784195468184;336.7777267003778;341.52357461341427;341.60032761668845;347.83304014073246;6147.354527774586;6703.765368212107;6749.763758268462;6767.42476889465;6792.762253321135;6668.266490686021;6687.69905354259;6688.63212523311;6693.69878355474;6706.262311145782;4693.671442998992;4795.304680821278;4817.470078291385;4910.41075070992;4952.999999999991;4889.657723959324;4942.654014219006;4949.133901567229;4954.058728841508;4956.529129732688;4926.11329960607;4931.852044438655;4933.309336692866;4934.851954441372;4938.283948827418;4625.468071171807;4730.2431610942085;4871.56155945963;4880.755962201875;4897.730624815634;4151.73013754105;4161.417401563784;4181.602747738991;4190.832366705358;4202.201581699498;6332.33510481402;6440.388163124496;6450.580712253689;6460.353964603549;6474.773382931575;5863.149843272744;5886.6468011919;5891.7054147292465;5913.024350982083;5929.851753706149;7127.92872071283;7141.67862446186;7163.785086447415;7165.713371465135;7205.4595905307315;4434.17967675981;4600.2978897808025;4617.976910115428;4621.907561848778;4626.30605409188;6849.623270720109;7333.706651733924;7554.433417493655;7568.281013303727;7568.659410326549;3890.7471014383973;4707.129181101439;4709.882252943636;4730.124926888537;4735.076660051257;4786.138495070921;4786.688865223749;4791.496892826272;4793.856184314476;4799.496052914464;5731.942680573141;5752.856178595569;5800.984827655144;5819.854503637443;5823.854403639943;5937.139114828412;6981.511294209458;7157.284271572905;7226.92773072273;7242.963785181146;1634.517817243916;1650.7371860526707;1668.382698401599;1669.190442635321;1670.7827982362458;991.9801603968025;1035.440861934547;1045.9738506537396;1061.177587369779;1064.164630764846;6514.3811337922825;6567.9014814776865;6653.301403352578;6695.966520167368;6773.762918297934;6692.59844409337;7435.367993720594;7445.664945077485;7446.59043752588;7449.292317229854;6643.734250630017;6656.167979002625;6665.333466653296;6748.966255168692;6776.2546119926765;3198.392305461955;3966.0679740261016;3976.224636195972;3982.1637456134536;3986.7009974252046;7527.736529221451;7797.454178207585;7812.843743125106;7821.765347039598;7839.960800195962;6325.430711235919;7798.5710785906185;7803.180666030099;7806.843863122705;7815.921840781633;7903.960480197562;7913.920860791319;7914.525128492309;7922.4850384724805;7929.801754956172;6142.600730952474;6921.446284297345;7266;7554.546727196386;7566.281203285679;7358.374538164316;7396.4082873368925;7405;7417.777466676009;7431.777046688608;7829.843403132019;7833;7864.410169237216;7884.172161923145;7886.72396466121;4892.2661600760175;4952.257161425815;4956.801727930842;4956.950430495649;4964.726940018189;5521.426468313135;7343.70625174987;7374.262573742797;7426.183119856703;7609.581473019037;5786.971065144648;7107.857842843217;7160.319769621878;7165.820854478679;7190.352868241884;7147.2852714728115;7158.570485770871;7164.355208031302;7181.712731490682;7211.927880721336;7015.6842942066705;7022.789316320519;7031.296870312928;7038.753643622448;7046;6958.269381714847;7182.281771822776;7182.533135346186;7207.207207207308;7207.387372073433;6779.322067793181;6942;6945.20130185015;7121.287871212838;7169.426445884421 08:32:33 INFO - PROCESS | 1669 | |5;yui.html;705.9939586089821;740.4890625468427;771.2249189564487;794.9284564389208;796.1799346672925;12997.740045199114;15352.692946141084;15622.687546249068;15627.374905003815;15634.452794152192;14174.71650566988;14302.927280453956;14304.141751494917;14309;14309.499167529139;777.60342225465;780.235369338049;974.8099120671471;975.8633791269228;980.691082309074;962.1869520255408;969.7914948286117;971.3346357744967;974.201155052857;985.5318723606266;816.5713000674634;1031.2471895516278;1032.0195813976752;1032.127851965092;1038.6987773545663;1013.1894484412477;1017.8371460566274;1026.933249338798;1028.295617502006;1028.382970217867;649.6491894377031;764.9617519124077;765.8583162114971;766.5439063757055;769.253823790922;15207.163606001666;15294.388224471119;15392.538223853302;15412.922935385364;15482.071075735492;13075.54235601759;13359.998000150028;13365.799513007312;13501.797473037912;13531.661708457268;9931.65239216624;9977.650782222587;10007.199424046059;10189.847152292721;10389;3532.5054492371087;3543.3799085160254;3588.982055089708;3636.090977255686;3794.298054859832;74015;76534.61732691356;76702.61648691776;79052.41895162122;79136;9718.736048414989;9733.513324333755;9785.706428807147;9790.265730070274;10287.125594324567;18982.620347592972;23186.884065579565;23207.3037808866;23274;23274.95262713182;7693.07683078023;7704.6918123274445;7725.575093369806;7735.071791385069;7769.106552746393;3469.323481921001;4078.877633670995;4178.185253875526;4213.115245798416;4276.978615106905;3535.363634545755;3590.1922067534597;3591.425371940477;3591.982040089783;3592;575.5223164773228;648.3840351665937;661.9640262988504;673.3468535520537;687.4569090418613;491.2582001178175;567.7785663591203;571.674145736926;579.1486514823204;591.9256549362892;8147.714829980922;8405.705800297083;8437.746867593982;8476.364272679573;8535.598102758897;604.3925854516183;608.4341562347059;613.622622087422;616.0543565626831;622.1259130921063;3740.1584643455003;3886.067343837515;3939.7045221607923;3951.644352008333;3957.3866050762176;91268.54365728261;91614.08385916188;92711;93716.5942510863;93729.0627093734;80741;82655;84239;84347.57826210829;85500.14499855046;69986.65006675036;70299.64850175717;70599.64700176466;72394.55210895752;73892.63053684698;8500.57497125129;8701.347398944978;8746.125387461203;8756.912430875864;8784.297256219616;46973.825654358916;47700;48362.75818620884;49361.259581105594;51403.48596513987;62374;66444.33555664575;67896;67931.98102028572;74163.887541688;10904.291221070605;11162.065076439436;11287.887121128684;11532.538698452303;11580.594679186188;11943.940280298542;12171.330576818005;12203;12311.938440307742;12763.93618031941;11178.608748693756;11280.7743845121;11342.092632589538;11561.687662467708;11753.47109380097;11599.376087347946;11680.415979200836;12110.970567501508;12277;12293.56972505958;11106.055985241344;11495.827562586735;11690.415479226174;11737.413129343327;11780.70548236301;9241.353105282566;9298.674546390845;9386.624535018796;9420.387674801115;9463.195628371666;9787;9787.559559819683;9797.804043918939;9835.754106147404;10023 08:32:33 INFO - PROCESS | 1669 | __end_tp_report 08:32:33 INFO - PROCESS | 1669 | __start_cc_report 08:32:33 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1031 08:32:33 INFO - PROCESS | 1669 | __end_cc_report 08:32:33 INFO - PROCESS | 1669 | __startTimestamp1461079953549__endTimestamp 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | ------- Summary: start ------- 08:32:33 INFO - PROCESS | 1669 | Number of tests: 6 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5647.82 Median:5835.85 stddev:631.14 (10.8%) stddev-sans-first:606.68 08:32:33 INFO - PROCESS | 1669 | Values: 3345.7 3437.3 3470.8 3478.9 3519.9 5577.8 5588.9 5605.0 5605.3 5617.7 5562.5 5563.0 5611.3 5615.4 5618.5 4984.6 5053.1 5066.8 5078.1 5100.9 5130.4 5147.9 5156.9 5157.8 5171.1 5061.5 5105.3 5111.8 5117.8 5155.9 5056.5 5066.2 5074.7 5083.7 5116.2 4923.3 5005.2 5092.5 5120.8 5139.4 5493.2 5499.6 5530.5 5534.3 5549.9 5961.5 6208.7 6219.0 6222.0 6241.4 6111.9 6115.6 6130.9 6243.3 6250.3 5694.4 5700.3 5709.5 5722.0 5735.1 6133.0 6151.5 6292.6 6297.3 6307.8 6054.2 6059.9 6066.8 6069.6 6074.2 6168.6 6178.3 6196.2 6207.0 6215.2 5712.1 5732.7 6023.6 6107.3 6117.5 6112.7 6122.7 6140.9 6158.0 6174.4 4782.9 4786.6 4798.2 4801.5 4866.1 4262.0 4311.4 4375.7 4376.7 4434.5 5589.2 5610.4 5612.9 5619.7 5631.2 6192.0 6208.6 6209.0 6216.6 6232.3 5441.0 5544.3 5562.2 5573.6 5633.6 5253.8 5288.0 5291.0 5291.1 5326.6 6258.8 6266.9 6271.4 6276.2 6276.2 6081.8 6111.7 6140.0 6207.6 6230.9 6277.3 6280.1 6283.5 6285.3 6289.7 6120.2 6126.0 6135.1 6144.5 6148.4 5968.5 6035.6 6090.4 6136.0 6165.6 4740.2 5941.7 5969.3 5973.3 6013.1 5815.7 5982.6 5995.4 6006.9 6008.1 5787.7 5854.4 5867.0 5938.2 5944.4 5953.4 5970.5 5986.0 6022.2 6042.7 5776.3 5776.8 5835.9 5847.7 5866.4 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:68844.22 Median:36857.76 stddev:144388.05 (391.7%) stddev-sans-first:144701.84 08:32:33 INFO - PROCESS | 1669 | Values: 470.7 550.7 581.6 595.6 655.6 31436.4 36603.9 41331.8 41704.2 41911.6 33713.0 45054.5 45150.1 45218.8 45231.5 9666.1 9894.5 9905.4 9906.1 9915.9 9703.0 9871.0 9877.6 9884.0 10030.2 9982.8 10039.2 10051.3 10055.8 10063.0 9936.0 10020.6 10024.4 10033.6 10045.5 9869.9 10027.2 10027.5 10031.4 10037.9 42775.8 43225.6 43242.9 43337.0 43530.8 3215.7 3398.9 3412.7 3758.2 3962.6 28909.6 29552.0 29749.1 29818.7 30410.5 2782.9 2799.7 2822.2 2827.3 2843.6 496394.5 498922.0 499676.0 500572.0 501195.0 72731.0 72897.3 72927.3 73030.3 73160.0 80543.6 81565.0 81819.0 81905.6 81921.6 18235.7 18578.8 18621.5 18622.2 18663.8 14156.3 14224.1 14244.4 14256.9 14260.9 22843.7 23177.8 23288.9 23605.4 23625.8 8036.4 9097.8 9214.0 9299.2 9340.0 848.4 952.8 1016.7 1080.4 1127.0 31260.4 31596.7 31647.4 32660.5 33377.3 1072.7 1094.0 1155.3 1169.3 1191.5 12504.9 15367.5 15497.1 15680.8 15839.2 663662.0 664195.0 672911.0 676624.6 677691.0 64816.7 65881.0 65948.3 66132.7 66200.7 1424.9 1550.6 1583.5 1594.4 1617.9 30098.8 31631.5 31749.7 31982.5 32679.5 54096.0 54304.0 54512.0 54635.2 54700.7 419585.0 423100.0 423126.0 423585.0 424330.0 29768.4 31497.5 35196.5 35218.8 35555.8 43794.6 44452.3 44477.0 44716.3 45174.0 34876.0 37012.4 37126.9 37333.6 37932.1 28670.6 36427.5 36777.4 36938.1 37879.8 37783.6 38447.0 38656.8 40799.4 42433.2 34340.5 35684.3 36118.6 36143.8 36201.5 25883.5 26460.7 26463.1 26560.7 26927.5 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34584.87 Median:13938.94 stddev:92056.75 (660.4%) stddev-sans-first:92279.16 08:32:33 INFO - PROCESS | 1669 | Values: 373.4 377.9 379.6 379.9 385.7 20078.4 21349.3 21874.0 22258.4 22262.6 11974.5 12494.0 12561.8 12565.7 12580.1 5011.1 5281.6 5288.6 5290.2 5308.5 4073.5 4244.0 4247.6 7055.7 7410.7 7114.6 7289.7 7389.0 7393.7 7397.6 6664.9 7255.1 7270.0 7302.7 7351.9 6899.5 6965.1 7027.6 7043.4 7119.2 28383.0 28647.0 28745.1 28820.0 29473.4 2233.4 2287.1 2569.1 2883.2 2957.4 14634.6 15949.2 16137.4 16572.3 16969.2 1877.5 1883.8 1897.8 1958.4 1988.7 124520.0 124859.4 127430.4 129132.0 132952.7 16516.5 17034.5 19636.2 19949.4 20181.2 25308.7 30964.5 31154.5 31532.1 31814.7 9244.0 10695.3 10889.0 11206.8 11231.5 7645.4 9278.6 9299.1 9350.2 9422.6 8749.4 8821.3 8869.9 8901.7 8966.9 2902.5 3459.4 3475.9 3497.9 3508.1 893.2 915.4 920.4 974.1 996.2 20409.9 20923.1 21371.1 21832.6 22027.6 974.7 1013.7 1019.2 1045.4 1077.4 11019.3 11433.5 11467.8 11493.1 11516.8 500793.0 504593.0 505362.5 507494.0 701162.0 102429.0 119968.0 122961.4 132141.0 132951.7 1037.7 1062.5 1075.6 1075.9 1081.1 18228.6 18306.4 18316.8 18446.9 19171.2 49803.3 49840.8 51313.0 51941.5 52223.2 70227.0 71918.6 72041.0 72297.0 73529.6 7546.4 8307.3 8381.4 8492.0 8735.7 12837.4 13529.0 13582.7 13978.9 14013.4 10681.6 11793.8 11832.6 11982.8 11996.8 11508.6 11598.4 11739.2 11853.2 11930.2 11478.4 11935.7 11953.5 12056.2 12091.5 8255.4 8382.3 8422.0 8498.0 8667.5 11562.6 11785.4 11831.5 12009.3 12047.8 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6174.55 Median:5049.69 stddev:3270.38 (64.8%) stddev-sans-first:3260.67 08:32:33 INFO - PROCESS | 1669 | Values: 1500.0 1622.8 1650.3 1990.7 2078.4 8262.5 8737.8 8886.9 8891.3 8903.6 8630.7 8905.6 8908.6 8918.6 8920.2 2068.8 2130.8 2270.4 2485.3 2554.3 2575.1 2582.6 2584.8 2584.9 2586.0 2464.2 2558.6 2559.8 2560.4 2563.7 2265.6 2482.9 2548.9 2551.2 2551.2 2530.8 2538.0 2580.8 2582.3 2585.3 8925.5 8995.2 9021.5 9041.3 9050.8 5564.3 5686.7 5694.7 5705.2 5737.2 3148.5 3642.4 3750.9 3759.5 3801.2 917.8 1060.9 1086.1 1103.5 1103.9 12232.2 12385.6 12408.1 12434.9 12456.1 4934.5 4989.7 5022.8 5036.1 5063.2 10665.9 10682.3 10685.4 10686.7 10706.6 5688.7 5690.1 5744.7 5749.6 5759.0 4527.1 4639.3 4640.7 4709.5 4896.4 4027.1 4086.7 4112.1 4130.9 4149.1 1161.8 1350.6 1364.6 1373.4 1377.5 1386.5 1397.9 1452.8 1454.7 1458.9 7316.0 8280.0 8383.3 8426.8 8471.0 487.9 493.9 517.1 526.2 531.3 6090.2 6172.8 6176.0 6186.3 6204.8 10287.7 10591.1 10592.0 10721.5 10757.7 10298.7 10432.5 10481.3 10495.9 10577.8 8241.2 8411.0 8468.7 8471.3 8474.3 8309.2 8329.9 8372.8 8438.5 8445.0 8570.3 9431.5 9737.4 9857.0 10044.6 10001.0 10144.0 10195.8 10325.4 10372.4 6923.5 7395.4 7643.4 7662.7 7788.9 8431.0 8440.3 8469.9 8481.2 8488.2 7331.3 7389.7 7431.2 7569.9 7590.1 7376.6 7386.3 7393.0 7491.7 7537.7 7906.9 7919.4 7928.9 7954.8 7956.6 7128.1 7160.9 7216.6 7220.0 7228.3 7304.6 7319.7 7376.8 7379.0 7382.8 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5854.10 Median:6666.80 stddev:1882.51 (28.2%) stddev-sans-first:1841.61 08:32:33 INFO - PROCESS | 1669 | Values: 333.0 336.8 341.5 341.6 347.8 6147.4 6703.8 6749.8 6767.4 6792.8 6668.3 6687.7 6688.6 6693.7 6706.3 4693.7 4795.3 4817.5 4910.4 4953.0 4889.7 4942.7 4949.1 4954.1 4956.5 4926.1 4931.9 4933.3 4934.9 4938.3 4625.5 4730.2 4871.6 4880.8 4897.7 4151.7 4161.4 4181.6 4190.8 4202.2 6332.3 6440.4 6450.6 6460.4 6474.8 5863.1 5886.6 5891.7 5913.0 5929.9 7127.9 7141.7 7163.8 7165.7 7205.5 4434.2 4600.3 4618.0 4621.9 4626.3 6849.6 7333.7 7554.4 7568.3 7568.7 3890.7 4707.1 4709.9 4730.1 4735.1 4786.1 4786.7 4791.5 4793.9 4799.5 5731.9 5752.9 5801.0 5819.9 5823.9 5937.1 6981.5 7157.3 7226.9 7243.0 1634.5 1650.7 1668.4 1669.2 1670.8 992.0 1035.4 1046.0 1061.2 1064.2 6514.4 6567.9 6653.3 6696.0 6773.8 6692.6 7435.4 7445.7 7446.6 7449.3 6643.7 6656.2 6665.3 6749.0 6776.3 3198.4 3966.1 3976.2 3982.2 3986.7 7527.7 7797.5 7812.8 7821.8 7840.0 6325.4 7798.6 7803.2 7806.8 7815.9 7904.0 7913.9 7914.5 7922.5 7929.8 6142.6 6921.4 7266.0 7554.5 7566.3 7358.4 7396.4 7405.0 7417.8 7431.8 7829.8 7833.0 7864.4 7884.2 7886.7 4892.3 4952.3 4956.8 4957.0 4964.7 5521.4 7343.7 7374.3 7426.2 7609.6 5787.0 7107.9 7160.3 7165.8 7190.4 7147.3 7158.6 7164.4 7181.7 7211.9 7015.7 7022.8 7031.3 7038.8 7046.0 6958.3 7182.3 7182.5 7207.2 7207.4 6779.3 6942.0 6945.2 7121.3 7169.4 08:32:33 INFO - PROCESS | 1669 | 08:32:33 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18513.32 Median:569.73 stddev:25859.66 (4539.0%) stddev-sans-first:25897.63 08:32:33 INFO - PROCESS | 1669 | Values: 706.0 740.5 771.2 794.9 796.2 12997.7 15352.7 15622.7 15627.4 15634.5 14174.7 14302.9 14304.1 14309.0 14309.5 777.6 780.2 974.8 975.9 980.7 962.2 969.8 971.3 974.2 985.5 816.6 1031.2 1032.0 1032.1 1038.7 1013.2 1017.8 1026.9 1028.3 1028.4 649.6 765.0 765.9 766.5 769.3 15207.2 15294.4 15392.5 15412.9 15482.1 13075.5 13360.0 13365.8 13501.8 13531.7 9931.7 9977.7 10007.2 10189.8 10389.0 3532.5 3543.4 3589.0 3636.1 3794.3 74015.0 76534.6 76702.6 79052.4 79136.0 9718.7 9733.5 9785.7 9790.3 10287.1 18982.6 23186.9 23207.3 23274.0 23275.0 7693.1 7704.7 7725.6 7735.1 7769.1 3469.3 4078.9 4178.2 4213.1 4277.0 3535.4 3590.2 3591.4 3592.0 3592.0 575.5 648.4 662.0 673.3 687.5 491.3 567.8 571.7 579.1 591.9 8147.7 8405.7 8437.7 8476.4 8535.6 604.4 608.4 613.6 616.1 622.1 3740.2 3886.1 3939.7 3951.6 3957.4 91268.5 91614.1 92711.0 93716.6 93729.1 80741.0 82655.0 84239.0 84347.6 85500.1 69986.7 70299.6 70599.6 72394.6 73892.6 8500.6 8701.3 8746.1 8756.9 8784.3 46973.8 47700.0 48362.8 49361.3 51403.5 62374.0 66444.3 67896.0 67932.0 74163.9 10904.3 11162.1 11287.9 11532.5 11580.6 11943.9 12171.3 12203.0 12311.9 12763.9 11178.6 11280.8 11342.1 11561.7 11753.5 11599.4 11680.4 12111.0 12277.0 12293.6 11106.1 11495.8 11690.4 11737.4 11780.7 9241.4 9298.7 9386.6 9420.4 9463.2 9787.0 9787.6 9797.8 9835.8 10023.0 08:32:33 INFO - PROCESS | 1669 | -------- Summary: end -------- 08:32:33 INFO - PROCESS | 1669 | 08:32:34 INFO - TEST-INFO | 1669: exit 0 08:32:34 INFO - TEST-OK | dromaeo_css | took 1112435ms 08:32:34 INFO - TEST-START | kraken 08:32:34 INFO - operating with platform_type : mac_ 08:32:34 INFO - Initialising browser for kraken test... 08:32:34 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp9jbpmc/profile http://localhost:49277/getInfo.html) 08:32:36 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 08:32:36 INFO - PROCESS | 1680 | colorDepth:24 08:32:36 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 08:32:36 INFO - PROCESS | 1680 | __metrics 08:32:36 INFO - PROCESS | 1680 | 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" 08:32:36 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:36 INFO - TEST-INFO | 1680: exit 0 08:32:36 INFO - Browser initialized. 08:32:36 INFO - Running cycle 1/1 for kraken test... 08:32:36 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp9jbpmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:48 INFO - PROCESS | 1682 | RSS: Main: 207708160 08:32:48 INFO - PROCESS | 1682 | 08:32:51 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:52 INFO - PROCESS | 1682 | RSS: Main: 262381568 08:32:52 INFO - PROCESS | 1682 | 08:32:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 08:32:55 INFO - PROCESS | 1682 | RSS: Main: 272871424 08:32:55 INFO - PROCESS | 1682 | 08:32:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 08:32:59 INFO - PROCESS | 1682 | RSS: Main: 263069696 08:32:59 INFO - PROCESS | 1682 | 08:33:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 08:33:01 INFO - PROCESS | 1682 | RSS: Main: 264597504 08:33:01 INFO - PROCESS | 1682 | 08:33:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:04 INFO - PROCESS | 1682 | RSS: Main: 265445376 08:33:04 INFO - PROCESS | 1682 | 08:33:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:07 INFO - PROCESS | 1682 | RSS: Main: 265424896 08:33:07 INFO - PROCESS | 1682 | 08:33:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:11 INFO - PROCESS | 1682 | RSS: Main: 265523200 08:33:11 INFO - PROCESS | 1682 | 08:33:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 08:33:14 INFO - PROCESS | 1682 | RSS: Main: 265846784 08:33:14 INFO - PROCESS | 1682 | 08:33:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:16 INFO - PROCESS | 1682 | RSS: Main: 299253760 08:33:16 INFO - PROCESS | 1682 | 08:33:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:18 INFO - PROCESS | 1682 | RSS: Main: 300371968 08:33:18 INFO - PROCESS | 1682 | 08:33:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:21 INFO - PROCESS | 1682 | RSS: Main: 305098752 08:33:21 INFO - PROCESS | 1682 | 08:33:23 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:24 INFO - PROCESS | 1682 | RSS: Main: 307159040 08:33:24 INFO - PROCESS | 1682 | 08:33:27 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:27 INFO - PROCESS | 1682 | RSS: Main: 307257344 08:33:27 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 08:33:29 INFO - PROCESS | 1682 | RSS: Main: 370343936 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | __start_tp_report 08:33:29 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 08:33:29 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 08:33:29 INFO - PROCESS | 1682 | |i|pagename|runs| 08:33:29 INFO - PROCESS | 1682 | |0;ai-astar;112;110;110;109;114;110;121;111;110;109 08:33:29 INFO - PROCESS | 1682 | |1;audio-beat-detection;174;154;186;147;122;138;117;138;167;146 08:33:29 INFO - PROCESS | 1682 | |2;audio-dft;187;183;183;189;186;187;181;185;186;185 08:33:29 INFO - PROCESS | 1682 | |3;audio-fft;71;76;77;118;56;57;57;57;122;56 08:33:29 INFO - PROCESS | 1682 | |4;audio-oscillator;91;98;133;79;79;82;116;76;79;116 08:33:29 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;89;86;88;86;87;84;88;85;88;130 08:33:29 INFO - PROCESS | 1682 | |6;imaging-darkroom;93;93;93;93;92;93;93;93;93;93 08:33:29 INFO - PROCESS | 1682 | |7;imaging-desaturate;88;88;87;84;84;85;87;87;83;84 08:33:29 INFO - PROCESS | 1682 | |8;json-parse-financial;55;58;58;57;58;58;57;69;53;51 08:33:29 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;61;64;66;70;74;68;65;66;67;66 08:33:29 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;81;79;80;82;83;81;79;79;79;85 08:33:29 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;121;118;127;121;131;115;117;117;119;118 08:33:29 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;133;131;134;132;135;122;132;133;131;132 08:33:29 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;66;65;67;65;79;93;93;95;91;64 08:33:29 INFO - PROCESS | 1682 | __end_tp_report 08:33:29 INFO - PROCESS | 1682 | __start_cc_report 08:33:29 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1220 08:33:29 INFO - PROCESS | 1682 | __end_cc_report 08:33:29 INFO - PROCESS | 1682 | __startTimestamp1461080009714__endTimestamp 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | ------- Summary: start ------- 08:33:29 INFO - PROCESS | 1682 | Number of tests: 14 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:111.60 Median:110.50 stddev:3.63 (3.3%) stddev-sans-first:3.84 08:33:29 INFO - PROCESS | 1682 | Values: 112.0 110.0 110.0 109.0 114.0 110.0 121.0 111.0 110.0 109.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:150.50 stddev:21.99 (14.6%) stddev-sans-first:21.36 08:33:29 INFO - PROCESS | 1682 | Values: 174.0 154.0 186.0 147.0 122.0 138.0 117.0 138.0 167.0 146.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:185.20 Median:186.00 stddev:2.35 (1.3%) stddev-sans-first:2.40 08:33:29 INFO - PROCESS | 1682 | Values: 187.0 183.0 183.0 189.0 186.0 187.0 181.0 185.0 186.0 185.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:74.70 Median:57.00 stddev:25.32 (44.4%) stddev-sans-first:26.83 08:33:29 INFO - PROCESS | 1682 | Values: 71.0 76.0 77.0 118.0 56.0 57.0 57.0 57.0 122.0 56.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.00 stddev:20.14 (25.5%) stddev-sans-first:21.31 08:33:29 INFO - PROCESS | 1682 | Values: 91.0 98.0 133.0 79.0 79.0 82.0 116.0 76.0 79.0 116.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:87.50 stddev:13.76 (15.7%) stddev-sans-first:14.57 08:33:29 INFO - PROCESS | 1682 | Values: 89.0 86.0 88.0 86.0 87.0 84.0 88.0 85.0 88.0 130.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:33:29 INFO - PROCESS | 1682 | Values: 93.0 93.0 93.0 93.0 92.0 93.0 93.0 93.0 93.0 93.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.81 08:33:29 INFO - PROCESS | 1682 | Values: 88.0 88.0 87.0 84.0 84.0 85.0 87.0 87.0 83.0 84.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:4.74 (8.2%) stddev-sans-first:4.95 08:33:29 INFO - PROCESS | 1682 | Values: 55.0 58.0 58.0 57.0 58.0 58.0 57.0 69.0 53.0 51.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:3.50 (5.3%) stddev-sans-first:3.04 08:33:29 INFO - PROCESS | 1682 | Values: 61.0 64.0 66.0 70.0 74.0 68.0 65.0 66.0 67.0 66.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:2.04 (2.5%) stddev-sans-first:2.17 08:33:29 INFO - PROCESS | 1682 | Values: 81.0 79.0 80.0 82.0 83.0 81.0 79.0 79.0 79.0 85.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.00 stddev:4.97 (4.1%) stddev-sans-first:5.27 08:33:29 INFO - PROCESS | 1682 | Values: 121.0 118.0 127.0 121.0 131.0 115.0 117.0 117.0 119.0 118.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.50 Median:132.50 stddev:3.57 (2.7%) stddev-sans-first:3.74 08:33:29 INFO - PROCESS | 1682 | Values: 133.0 131.0 134.0 132.0 135.0 122.0 132.0 133.0 131.0 132.0 08:33:29 INFO - PROCESS | 1682 | 08:33:29 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:85.00 stddev:13.77 (16.2%) stddev-sans-first:13.93 08:33:29 INFO - PROCESS | 1682 | Values: 66.0 65.0 67.0 65.0 79.0 93.0 93.0 95.0 91.0 64.0 08:33:29 INFO - PROCESS | 1682 | -------- Summary: end -------- 08:33:29 INFO - PROCESS | 1682 | 08:33:30 INFO - TEST-INFO | 1682: exit 0 08:33:30 INFO - TEST-OK | kraken | took 56419ms 08:33:30 INFO - SUITE-END | took 1168s 08:33:30 INFO - Completed test suite (00:19:29) 08:33:30 INFO - javascript benchmark 08:33:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3345.682160194781, 3437.2781715839674, 3470.843812028459, 3478.9478157827652, 3519.9472007919885, 5577.7768889244435, 5588.91616625751, 5605.01912165371, 5605.327360716719, 5617.747201375938, 5562.499375056244, 5563.026470367689, 5611.3266408031095, 5615.354234263061, 5618.522425593819, 4984.601231901457, 5053.065182941167, 5066.822661206858, 5078.111330517163, 5100.897982040357, 5130.38435387754, 5147.948520514803, 5156.948430515703, 5157.839486115631, 5171.095058364771, 5061.493850614927, 5105.259737338084, 5111.769970351324, 5117.795288188468, 5155.922661160085, 5056.519630635084, 5066.18940969445, 5074.746262686851, 5083.74581270935, 5116.232565115244, 4923.310736496894, 5005.199168133081, 5092.490750924915, 5120.820771272987, 5139.383274007106, 5493.2034854946205, 5499.615026948115, 5530.5299049580835, 5534.308211473566, 5549.889002219973, 5961.493273071794, 6208.689565521706, 6219.0, 6222.0, 6241.407066328737, 6111.938880611226, 6115.571909966304, 6130.938690613126, 6243.282022567418, 6250.281217659982, 5694.430556944355, 5700.315962084494, 5709.486146246816, 5721.971390143022, 5735.082386818089, 6133.028644417115, 6151.477124444473, 6292.559520833498, 6297.307296197415, 6307.842303942438, 6054.152418661391, 6059.909101363483, 6066.787662431793, 6069.635821850615, 6074.210352654127, 6168.629882207082, 6178.289496707936, 6196.225471816023, 6207.037909124093, 6215.223097112861, 5712.11462223356, 5732.6847023413275, 6023.608465449732, 6107.328193898667, 6117.510599152057, 6112.694365281718, 6122.672617327906, 6140.8771824563255, 6158.04550294705, 6174.413430724074, 4782.876024134325, 4786.593139583105, 4798.23228283473, 4801.51984801517, 4866.099771542276, 4261.978690106592, 4311.417958575615, 4375.7155784873885, 4376.715513491613, 4434.467863856294, 5589.161625756088, 5610.354809196994, 5612.943870561324, 5619.690916999604, 5631.211630371751, 6191.9690401547705, 6208.565400422018, 6209.0, 6216.564840461125, 6232.345603711545, 5441.020616289106, 5544.279243698374, 5562.16567514876, 5573.554115670818, 5633.57748168889, 5253.816116435906, 5288.0, 5290.973545132327, 5291.074062039128, 5326.627136100513, 6258.812235632939, 6266.905996410058, 6271.404216599416, 6276.215473065958, 6276.246850377984, 6081.787137450168, 6111.652512877656, 6139.969300153471, 6207.596506227081, 6230.937690623035, 6277.30949595535, 6280.0893870389455, 6283.497320214463, 6285.277193122666, 6289.6540690260645, 6120.173776540289, 6125.9693701531205, 6135.07973803933, 6144.477719393902, 6148.385161483995, 5968.507873031742, 6035.637861728311, 6090.3605121461605, 6135.967692822179, 6165.630062196283, 4740.217864052531, 5941.732622031933, 5969.283685957713, 5973.342932277533, 6013.098035294566, 5815.738291776965, 5982.58121931478, 5995.400459953969, 6006.939930600813, 6008.128821320972, 5787.739551720267, 5854.414558544111, 5867.0, 5938.168656388023, 5944.375840536682, 5953.404659534012, 5970.522358211246, 5986.0, 6022.1870047543025, 6042.697865106815, 5776.306843178845, 5776.797812076557, 5835.854103647443, 5847.707614619167, 5866.354700982974], "unit": "score", "name": "dojo.html", "value": 5608.260086484519}, {"lowerIsBetter": false, "replicates": [470.703456822202, 550.7443029891848, 581.5870731780436, 595.6307089604443, 655.5574986883854, 31436.371272574535, 36603.901882943486, 41331.79334103329, 41704.16591668168, 41911.58088419115, 33713.0, 45054.549454505446, 45150.09699806002, 45218.773906130424, 45231.547684523146, 9666.130048295634, 9894.455804930725, 9905.405675659447, 9906.108450239477, 9915.90084099157, 9702.951485242564, 9871.012898710143, 9877.60489580416, 9883.950580247089, 10030.247731420137, 9982.800343993116, 10039.247056470758, 10051.346662466953, 10055.798884022315, 10062.993700629915, 9936.0, 10020.599176032987, 10024.448655323955, 10033.59865605375, 10045.54795034218, 9869.90130098697, 10027.247956403298, 10027.548760305805, 10031.448270345129, 10037.89962100377, 42775.786121069505, 43225.56774432247, 43242.91892702676, 43337.0, 43530.78234608838, 3215.6623554526905, 3398.8640454382044, 3412.7099196568074, 3758.2107757370713, 3962.623550762673, 28909.56635650467, 29552.0, 29749.107526774016, 29818.701812982028, 30410.54384184239, 2782.8886844526196, 2799.7340252675963, 2822.1533539937936, 2827.2931767058235, 2843.559248316514, 496394.5180274112, 498922.0, 499676.0, 500572.0, 501195.0, 72731.0, 72897.2710272901, 72927.27072729311, 73030.26969730234, 73160.0, 80543.59728201438, 81565.0, 81819.0, 81905.59047204845, 81921.59039204885, 18235.72646410305, 18578.814211857978, 18621.534461638566, 18622.16200270991, 18663.81336186648, 14156.29218539069, 14224.14655120696, 14244.43022279118, 14256.859451243876, 14260.85739142616, 22843.657345139836, 23177.841107944874, 23288.883555582113, 23605.409864753517, 23625.7637423627, 8036.357091432671, 9097.772555686028, 9214.032526584746, 9299.163075323253, 9339.953300233456, 848.3679658654343, 952.7713348796239, 1016.7153197104675, 1080.4111759091313, 1126.9887301127048, 31260.374792504477, 31596.684033159832, 31647.367052658818, 32660.51009234816, 33377.332453351286, 1072.6728347853823, 1094.042712626452, 1155.306815910464, 1169.3217933598662, 1191.5114802930757, 12504.874951250371, 15367.538973830802, 15497.14765687898, 15680.76478852818, 15839.208039597974, 663662.0, 664195.0, 672911.0, 676624.6168769124, 677691.0, 64816.675916620115, 65881.01178482326, 65948.34051659518, 66132.66933665301, 66200.66899665567, 1424.886009119268, 1550.6123469132717, 1583.5407731757662, 1594.4100682747226, 1617.9352825886833, 30098.765309120416, 31631.52552711665, 31749.682503174674, 31982.52026219562, 32679.509807353385, 54096.0, 54304.0, 54512.0, 54635.180472293745, 54700.726496367264, 419585.0, 423100.0, 423126.0, 423585.0, 424330.0, 29768.404631907673, 31497.527537086502, 35196.47205291974, 35218.823905881334, 35555.82222088873, 43794.56205438032, 44452.333215001156, 44477.0, 44716.32925506185, 45174.0, 34876.0, 37012.44481332728, 37126.88619341424, 37333.6266637341, 37932.05169870775, 28670.569941450478, 36427.45358819673, 36777.448338275484, 36938.076548086516, 37879.81060094682, 37783.633800431526, 38447.0, 38656.80671596737, 40799.38800917929, 42433.15133697371, 34340.48489272713, 35684.28631427409, 36118.63881361153, 36143.81928090343, 36201.45697814482, 25883.482330353665, 26460.735392645827, 26463.104325699805, 26560.7343926566, 26927.461450771265], "unit": "score", "name": "ext.html", "value": 20987.716573834292}, {"lowerIsBetter": false, "replicates": [373.387644263408, 377.903634573184, 379.5729803970534, 379.9012256813228, 385.7010816617123, 20078.397648070564, 21349.252776152836, 21874.0, 22258.443538911535, 22262.55474890505, 11974.521019159223, 12494.000479961604, 12561.811572826415, 12565.685857853536, 12580.119391642565, 5011.123053465647, 5281.603879709018, 5288.5504732097625, 5290.1800220965815, 5308.469153084699, 4073.4704488416464, 4243.97878010611, 4247.575242475758, 7055.717771289143, 7410.740624078158, 7114.64426778659, 7289.671964761598, 7388.963055184717, 7393.706101432254, 7397.63011849408, 6664.93335066648, 7255.05684261048, 7269.963650181769, 7302.74440394589, 7351.926480735177, 6899.517033807636, 6965.094537710065, 7027.6486175691525, 7043.366097051239, 7119.21688614252, 28383.0, 28646.99735509268, 28745.137645870658, 28820.0, 29473.410531789243, 2233.4304752288226, 2287.142321629389, 2569.1393383216646, 2883.1927060423113, 2957.378950420414, 14634.56036905938, 15949.202539873077, 16137.354505819752, 16572.337106515726, 16969.15154242283, 1877.4649224970954, 1883.7645294338208, 1897.8386837118862, 1958.4222654317011, 1988.721578978944, 124520.0, 124859.37570312181, 127430.3628481861, 129132.0, 132952.670473295, 16516.50450486487, 17034.48896533106, 19636.21455141807, 19949.401517954193, 20181.192752290037, 25308.74691253101, 30964.535531967038, 31154.532682009787, 31532.054038378887, 31814.681853181635, 9243.953780231055, 10695.251332406813, 10888.965548272901, 11206.831897521544, 11231.494582743633, 7645.350145237717, 9278.582463789146, 9299.070092990647, 9350.205232555172, 9422.575984080733, 8749.387542872066, 8821.294296456397, 8869.866951995726, 8901.73294801157, 8966.86549701755, 2902.4630443368046, 3459.39460594395, 3475.913102172415, 3497.877574284888, 3508.08789714676, 893.2139717049085, 915.4187091197005, 920.4431319052011, 974.0794948773341, 996.1881066930429, 20409.897950510152, 20923.058462368925, 21371.145154193968, 21832.563348732936, 22027.559448810935, 974.6686126716809, 1013.7313611892854, 1019.1897441533998, 1045.3988956350129, 1077.380506208933, 11019.338839669645, 11433.485493152828, 11467.77064458706, 11493.138014648935, 11516.769664606829, 500793.0, 504593.0, 505362.4731876317, 507494.0, 701162.0, 102429.0, 119968.0, 122961.38519307526, 132141.0, 132951.68765717978, 1037.6886933919945, 1062.5006247063868, 1075.6181555547823, 1075.9354438733858, 1081.1404933078222, 18228.635427291647, 18306.359277425225, 18316.81683183151, 18446.90776546109, 19171.233150673816, 49803.25295120504, 49840.75079624579, 51313.0, 51941.48058519366, 52223.21665175101, 70227.0, 71918.56162876818, 72041.0, 72297.0, 73529.63235183789, 7546.434017448603, 8307.335413166811, 8381.37139714536, 8492.0, 8735.650573977224, 12837.439702783306, 13529.0, 13582.660433489242, 13978.930105349407, 14013.43946242139, 10681.626143084955, 11793.823092653445, 11832.585859494877, 11982.760344793229, 11996.820047699117, 11508.59719909799, 11598.420078996185, 11739.178257522233, 11853.170278080452, 11930.22453540517, 11478.426078696199, 11935.701607459883, 11953.462094205608, 12056.156069075432, 12091.455884485043, 8255.380846436661, 8382.287505561852, 8421.95789021051, 8498.02272738643, 8667.523286219319, 11562.595309164475, 11785.351805650771, 11831.46758395857, 12009.279443233434, 12047.75904481923], "unit": "score", "name": "jquery.html", "value": 10672.27954541757}, {"lowerIsBetter": false, "replicates": [1500.0, 1622.805263368396, 1650.3481124955647, 1990.6715391960327, 2078.355709729984, 8262.545559994198, 8737.781555461117, 8886.86669699955, 8891.333150013743, 8903.643854245822, 8630.654773809056, 8905.599248033837, 8908.643654253838, 8918.554072296376, 8920.197182253596, 2068.7517497900235, 2130.7549631792385, 2270.409693479699, 2485.2792690119845, 2554.297568168759, 2575.098715449587, 2582.5738753105716, 2584.7544483274155, 2584.935376615581, 2586.043164029312, 2464.18681834994, 2558.5906254999204, 2559.795216382685, 2560.3855074782105, 2563.705173905006, 2265.648824432224, 2482.900683972639, 2548.8725563721923, 2551.1708694674303, 2551.2346296111186, 2530.8101892358145, 2537.961930571043, 2580.7935365170742, 2582.295684847991, 2585.2761226856323, 8925.509096999662, 8995.190432861074, 9021.458712477272, 9041.276697864156, 9050.77373065672, 5564.276644036249, 5686.715664216814, 5694.743736531825, 5705.229793977802, 5737.168110623936, 3148.464760990637, 3642.4354225095153, 3750.887473375803, 3759.4924685167425, 3801.239752049601, 917.7659696777346, 1060.9363438193734, 1086.0876863434753, 1103.4813637590319, 1103.9448027598587, 12232.204906681038, 12385.566505172275, 12408.069394795517, 12434.937825310906, 12456.128071035031, 4934.5312195341385, 4989.650724449326, 5022.773975171126, 5036.143855544567, 5063.240513922868, 10665.893341066645, 10682.305650132717, 10685.412302323446, 10686.679399618024, 10706.571737130584, 5688.687122208318, 5690.118031705092, 5744.712764361765, 5749.568782341341, 5759.0209664356325, 4527.094581083797, 4639.304104384302, 4640.700603830933, 4709.529047095263, 4896.436909755353, 4027.1140349123148, 4086.713930024929, 4112.074783173762, 4130.876073717734, 4149.128682976549, 1161.7502237018912, 1350.567818298135, 1364.5701603994908, 1373.3545233740126, 1377.497213517059, 1386.5493714542813, 1397.8532254113172, 1452.825660920675, 1454.7308747881675, 1458.9197594132213, 7316.0489136411925, 8280.04779450359, 8383.28742056932, 8426.789330266793, 8471.0, 487.86095962651183, 493.8591852819997, 517.1441264706916, 526.231701715492, 531.2562412622283, 6090.177825993523, 6172.783952561728, 6176.0, 6186.319504854462, 6204.7828326008375, 10287.691369258935, 10591.099756520627, 10592.0, 10721.463926803784, 10757.731056723644, 10298.742531436774, 10432.478376081166, 10481.318714283547, 10495.895041049493, 10577.788444231226, 8241.217084376975, 8410.957945210357, 8468.661253549912, 8471.322294216448, 8474.322054235647, 8309.210624990616, 8329.916700832913, 8372.790680233044, 8438.53588052663, 8445.0, 8570.314374850122, 9431.528423578657, 9737.367071140354, 9857.014298570373, 10044.598216071276, 10001.049900259464, 10144.036316549917, 10195.847062293924, 10325.432101234504, 10372.377657340281, 6923.515353925177, 7395.408367330493, 7643.388528917562, 7662.655180516778, 7788.92211077882, 8431.0, 8440.324774018187, 8469.915300847159, 8481.194286542768, 8488.15118488171, 7331.303526165006, 7389.7413590524075, 7431.205892445874, 7569.886451703119, 7590.127135379502, 7376.631168441664, 7386.2613738625705, 7392.963035185005, 7491.73778917757, 7537.698492060256, 7906.881396779168, 7919.445638805229, 7928.881066783887, 7954.840903181788, 7956.562389068657, 7128.108986376703, 7160.892586611101, 7216.603086830275, 7219.963900180465, 7228.277172282729, 7304.63476826146, 7319.707211711472, 7376.7786966391095, 7379.040724705968, 7382.778516644509], "unit": "score", "name": "mootools.html", "value": 4951.710542650991}, {"lowerIsBetter": false, "replicates": [332.95784195468184, 336.7777267003778, 341.52357461341427, 341.60032761668845, 347.83304014073246, 6147.354527774586, 6703.765368212107, 6749.763758268462, 6767.42476889465, 6792.762253321135, 6668.266490686021, 6687.69905354259, 6688.63212523311, 6693.69878355474, 6706.262311145782, 4693.671442998992, 4795.304680821278, 4817.470078291385, 4910.41075070992, 4952.999999999991, 4889.657723959324, 4942.654014219006, 4949.133901567229, 4954.058728841508, 4956.529129732688, 4926.11329960607, 4931.852044438655, 4933.309336692866, 4934.851954441372, 4938.283948827418, 4625.468071171807, 4730.2431610942085, 4871.56155945963, 4880.755962201875, 4897.730624815634, 4151.73013754105, 4161.417401563784, 4181.602747738991, 4190.832366705358, 4202.201581699498, 6332.33510481402, 6440.388163124496, 6450.580712253689, 6460.353964603549, 6474.773382931575, 5863.149843272744, 5886.6468011919, 5891.7054147292465, 5913.024350982083, 5929.851753706149, 7127.92872071283, 7141.67862446186, 7163.785086447415, 7165.713371465135, 7205.4595905307315, 4434.17967675981, 4600.2978897808025, 4617.976910115428, 4621.907561848778, 4626.30605409188, 6849.623270720109, 7333.706651733924, 7554.433417493655, 7568.281013303727, 7568.659410326549, 3890.7471014383973, 4707.129181101439, 4709.882252943636, 4730.124926888537, 4735.076660051257, 4786.138495070921, 4786.688865223749, 4791.496892826272, 4793.856184314476, 4799.496052914464, 5731.942680573141, 5752.856178595569, 5800.984827655144, 5819.854503637443, 5823.854403639943, 5937.139114828412, 6981.511294209458, 7157.284271572905, 7226.92773072273, 7242.963785181146, 1634.517817243916, 1650.7371860526707, 1668.382698401599, 1669.190442635321, 1670.7827982362458, 991.9801603968025, 1035.440861934547, 1045.9738506537396, 1061.177587369779, 1064.164630764846, 6514.3811337922825, 6567.9014814776865, 6653.301403352578, 6695.966520167368, 6773.762918297934, 6692.59844409337, 7435.367993720594, 7445.664945077485, 7446.59043752588, 7449.292317229854, 6643.734250630017, 6656.167979002625, 6665.333466653296, 6748.966255168692, 6776.2546119926765, 3198.392305461955, 3966.0679740261016, 3976.224636195972, 3982.1637456134536, 3986.7009974252046, 7527.736529221451, 7797.454178207585, 7812.843743125106, 7821.765347039598, 7839.960800195962, 6325.430711235919, 7798.5710785906185, 7803.180666030099, 7806.843863122705, 7815.921840781633, 7903.960480197562, 7913.920860791319, 7914.525128492309, 7922.4850384724805, 7929.801754956172, 6142.600730952474, 6921.446284297345, 7266.0, 7554.546727196386, 7566.281203285679, 7358.374538164316, 7396.4082873368925, 7405.0, 7417.777466676009, 7431.777046688608, 7829.843403132019, 7833.0, 7864.410169237216, 7884.172161923145, 7886.72396466121, 4892.2661600760175, 4952.257161425815, 4956.801727930842, 4956.950430495649, 4964.726940018189, 5521.426468313135, 7343.70625174987, 7374.262573742797, 7426.183119856703, 7609.581473019037, 5786.971065144648, 7107.857842843217, 7160.319769621878, 7165.820854478679, 7190.352868241884, 7147.2852714728115, 7158.570485770871, 7164.355208031302, 7181.712731490682, 7211.927880721336, 7015.6842942066705, 7022.789316320519, 7031.296870312928, 7038.753643622448, 7046.0, 6958.269381714847, 7182.281771822776, 7182.533135346186, 7207.207207207308, 7207.387372073433, 6779.322067793181, 6942.0, 6945.20130185015, 7121.287871212838, 7169.426445884421], "unit": "score", "name": "prototype.html", "value": 5223.931108563088}, {"lowerIsBetter": false, "replicates": [705.9939586089821, 740.4890625468427, 771.2249189564487, 794.9284564389208, 796.1799346672925, 12997.740045199114, 15352.692946141084, 15622.687546249068, 15627.374905003815, 15634.452794152192, 14174.71650566988, 14302.927280453956, 14304.141751494917, 14309.0, 14309.499167529139, 777.60342225465, 780.235369338049, 974.8099120671471, 975.8633791269228, 980.691082309074, 962.1869520255408, 969.7914948286117, 971.3346357744967, 974.201155052857, 985.5318723606266, 816.5713000674634, 1031.2471895516278, 1032.0195813976752, 1032.127851965092, 1038.6987773545663, 1013.1894484412477, 1017.8371460566274, 1026.933249338798, 1028.295617502006, 1028.382970217867, 649.6491894377031, 764.9617519124077, 765.8583162114971, 766.5439063757055, 769.253823790922, 15207.163606001666, 15294.388224471119, 15392.538223853302, 15412.922935385364, 15482.071075735492, 13075.54235601759, 13359.998000150028, 13365.799513007312, 13501.797473037912, 13531.661708457268, 9931.65239216624, 9977.650782222587, 10007.199424046059, 10189.847152292721, 10389.0, 3532.5054492371087, 3543.3799085160254, 3588.982055089708, 3636.090977255686, 3794.298054859832, 74015.0, 76534.61732691356, 76702.61648691776, 79052.41895162122, 79136.0, 9718.736048414989, 9733.513324333755, 9785.706428807147, 9790.265730070274, 10287.125594324567, 18982.620347592972, 23186.884065579565, 23207.3037808866, 23274.0, 23274.95262713182, 7693.07683078023, 7704.6918123274445, 7725.575093369806, 7735.071791385069, 7769.106552746393, 3469.323481921001, 4078.877633670995, 4178.185253875526, 4213.115245798416, 4276.978615106905, 3535.363634545755, 3590.1922067534597, 3591.425371940477, 3591.982040089783, 3592.0, 575.5223164773228, 648.3840351665937, 661.9640262988504, 673.3468535520537, 687.4569090418613, 491.2582001178175, 567.7785663591203, 571.674145736926, 579.1486514823204, 591.9256549362892, 8147.714829980922, 8405.705800297083, 8437.746867593982, 8476.364272679573, 8535.598102758897, 604.3925854516183, 608.4341562347059, 613.622622087422, 616.0543565626831, 622.1259130921063, 3740.1584643455003, 3886.067343837515, 3939.7045221607923, 3951.644352008333, 3957.3866050762176, 91268.54365728261, 91614.08385916188, 92711.0, 93716.5942510863, 93729.0627093734, 80741.0, 82655.0, 84239.0, 84347.57826210829, 85500.14499855046, 69986.65006675036, 70299.64850175717, 70599.64700176466, 72394.55210895752, 73892.63053684698, 8500.57497125129, 8701.347398944978, 8746.125387461203, 8756.912430875864, 8784.297256219616, 46973.825654358916, 47700.0, 48362.75818620884, 49361.259581105594, 51403.48596513987, 62374.0, 66444.33555664575, 67896.0, 67931.98102028572, 74163.887541688, 10904.291221070605, 11162.065076439436, 11287.887121128684, 11532.538698452303, 11580.594679186188, 11943.940280298542, 12171.330576818005, 12203.0, 12311.938440307742, 12763.93618031941, 11178.608748693756, 11280.7743845121, 11342.092632589538, 11561.687662467708, 11753.47109380097, 11599.376087347946, 11680.415979200836, 12110.970567501508, 12277.0, 12293.56972505958, 11106.055985241344, 11495.827562586735, 11690.415479226174, 11737.413129343327, 11780.70548236301, 9241.353105282566, 9298.674546390845, 9386.624535018796, 9420.387674801115, 9463.195628371666, 9787.0, 9787.559559819683, 9797.804043918939, 9835.754106147404, 10023.0], "unit": "score", "name": "yui.html", "value": 7061.74095954668}], "name": "dromaeo_css", "value": 7824.540732785509}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 110.0, 109.0, 114.0, 110.0, 121.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [174.0, 154.0, 186.0, 147.0, 122.0, 138.0, 117.0, 138.0, 167.0, 146.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [187.0, 183.0, 183.0, 189.0, 186.0, 187.0, 181.0, 185.0, 186.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [71.0, 76.0, 77.0, 118.0, 56.0, 57.0, 57.0, 57.0, 122.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.7}, {"lowerIsBetter": true, "replicates": [91.0, 98.0, 133.0, 79.0, 79.0, 82.0, 116.0, 76.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.9}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 86.0, 87.0, 84.0, 88.0, 85.0, 88.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 87.0, 84.0, 84.0, 85.0, 87.0, 87.0, 83.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 69.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [61.0, 64.0, 66.0, 70.0, 74.0, 68.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 80.0, 82.0, 83.0, 81.0, 79.0, 79.0, 79.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 127.0, 121.0, 131.0, 115.0, 117.0, 117.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [133.0, 131.0, 134.0, 132.0, 135.0, 122.0, 132.0, 133.0, 131.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 65.0, 79.0, 93.0, 93.0, 95.0, 91.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.8}], "name": "kraken", "value": 1419.6000000000001}]} 08:33:30 INFO - Return code: 0 08:33:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:33:31 INFO - # TBPL SUCCESS # 08:33:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:31 INFO - 2016-04-19 08:33:31.035 screenresolution[1686:10162] starting screenresolution argv=screenresolution get 08:33:31 INFO - 2016-04-19 08:33:31.037 screenresolution[1686:10162] Display 0: 1600x1200x32@60 08:33:31 INFO - 2016-04-19 08:33:31.043 screenresolution[1687:10165] starting screenresolution argv=screenresolution list 08:33:31 INFO - Available Modes on Display 0 08:33:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:31 INFO - Intel Iris: 08:33:31 INFO - Chipset Model: Intel Iris 08:33:31 INFO - Type: GPU 08:33:31 INFO - Bus: Built-In 08:33:31 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:31 INFO - Vendor: Intel (0x8086) 08:33:31 INFO - Device ID: 0x0a2e 08:33:31 INFO - Revision ID: 0x0009 08:33:31 INFO - Displays: 08:33:31 INFO - Display: 08:33:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:31 INFO - Display Serial Number: 1600x1200 60 08:33:31 INFO - Main Display: Yes 08:33:31 INFO - Mirror: Off 08:33:31 INFO - Online: Yes 08:33:31 INFO - Rotation: Supported 08:33:31 INFO - Return code: 0 08:33:31 INFO - Running post-action listener: _resource_record_post_action 08:33:31 INFO - Running post-run listener: _resource_record_post_run 08:33:32 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37692928; Write bytes: 666393600; Read time: 418; Write time: 1942 08:33:32 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358590976; Write bytes: 353835008; Read time: 27633; Write time: 627 08:33:32 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 35870208; Write bytes: 301380608; Read time: 398; Write time: 1280 08:33:32 INFO - Running post-run listener: _upload_blobber_files 08:33:32 INFO - Blob upload gear active. 08:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:33 INFO - (blobuploader) - INFO - Done attempting. 08:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:34 INFO - (blobuploader) - INFO - Done attempting. 08:33:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:34 INFO - Return code: 0 08:33:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6c070e8d8eb1e7bcecbd80292670bf862fe7993d52886ea471254ea7f7646300da874e20066e194f5addc8500384b1e6381bb7bc2e3357c1536e2ab38ea6930", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f496f50ee46288070a8b96f24b439ec28f88ebf2c8b383c4f2fbad369af2aa9113ec48f2e9eb9f679fcc49f0667d050efdc030fccffd1b353394269e298c0ee"} 08:33:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:34 INFO - Contents: 08:33:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6c070e8d8eb1e7bcecbd80292670bf862fe7993d52886ea471254ea7f7646300da874e20066e194f5addc8500384b1e6381bb7bc2e3357c1536e2ab38ea6930", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f496f50ee46288070a8b96f24b439ec28f88ebf2c8b383c4f2fbad369af2aa9113ec48f2e9eb9f679fcc49f0667d050efdc030fccffd1b353394269e298c0ee"} 08:33:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:34 INFO - Copying logs to upload dir... 08:33:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.609881 ========= master_lag: 9.77 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-19 08:33:44.598900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-04-19 08:33:44.602084) ========= 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.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-Aurora/sha512/e6c070e8d8eb1e7bcecbd80292670bf862fe7993d52886ea471254ea7f7646300da874e20066e194f5addc8500384b1e6381bb7bc2e3357c1536e2ab38ea6930", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f496f50ee46288070a8b96f24b439ec28f88ebf2c8b383c4f2fbad369af2aa9113ec48f2e9eb9f679fcc49f0667d050efdc030fccffd1b353394269e298c0ee"} build_url:https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/StKteAGHTJ6wKStCWukbwg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6c070e8d8eb1e7bcecbd80292670bf862fe7993d52886ea471254ea7f7646300da874e20066e194f5addc8500384b1e6381bb7bc2e3357c1536e2ab38ea6930", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f496f50ee46288070a8b96f24b439ec28f88ebf2c8b383c4f2fbad369af2aa9113ec48f2e9eb9f679fcc49f0667d050efdc030fccffd1b353394269e298c0ee"}' ========= master_lag: 19.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 19 secs) (at 2016-04-19 08:34:04.169768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-19 08:34:04.170064) ========= 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.NlCuogOVL1/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.CECoAmv9U9/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.006037 ========= master_lag: 4.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-04-19 08:34:09.065790) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-19 08:34:09.066065) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-19 08:34:10.228580) ========= ========= Total master_lag: 34.27 =========