builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0198 starttime: 1461419414.09 results: success (0) buildid: 20160423050248 builduid: 7dea74687f704e61be54fffc88399692 revision: 32e9b18217afb665d570621b11363854b1da0a54 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.094369) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.094920) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.095232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.114120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.114577) ========= 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.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-23 06:50:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.69M=0.002s 2016-04-23 06:50:14 (7.69 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.540075 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.682942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.683277) ========= 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.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.020174 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.733360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:14.733820) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 32e9b18217afb665d570621b11363854b1da0a54 --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 32e9b18217afb665d570621b11363854b1da0a54 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-23 06:50:14,804 truncating revision to first 12 chars 2016-04-23 06:50:14,804 Setting DEBUG logging. 2016-04-23 06:50:14,804 attempt 1/10 2016-04-23 06:50:14,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/32e9b18217af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 06:50:15,503 unpacking tar archive at: mozilla-aurora-32e9b18217af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.950289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:15.706043) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:15.706784) ========= script_repo_revision: 32e9b18217afb665d570621b11363854b1da0a54 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:15.707252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:15.707545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 06:50:15.730305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-04-23 06:50:15.730659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:15 INFO - MultiFileLogger online at 20160423 06:50:15 in /builds/slave/test 06:50:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:50:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:15 INFO - {'append_to_log': False, 06:50:15 INFO - 'base_work_dir': '/builds/slave/test', 06:50:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:15 INFO - 'branch': 'Mozilla-Aurora', 06:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:15 INFO - 'config_files': ('talos/mac_config.py',), 06:50:15 INFO - 'default_actions': ('clobber', 06:50:15 INFO - 'read-buildbot-config', 06:50:15 INFO - 'download-and-extract', 06:50:15 INFO - 'populate-webroot', 06:50:15 INFO - 'create-virtualenv', 06:50:15 INFO - 'install', 06:50:15 INFO - 'run-tests'), 06:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:15 INFO - 'download_minidump_stackwalk': True, 06:50:15 INFO - 'download_symbols': 'ondemand', 06:50:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:15 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:15 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:15 INFO - 'installer_path': 'installer.exe', 06:50:15 INFO - 'log_level': 'info', 06:50:15 INFO - 'log_name': 'talos', 06:50:15 INFO - 'log_to_console': True, 06:50:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:50:15 INFO - 'opt_config_files': (), 06:50:15 INFO - 'pip_index': False, 06:50:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:15 INFO - 'cmd': ('bash', 06:50:15 INFO - '-c', 06:50:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:15 INFO - 'enabled': True, 06:50:15 INFO - 'halt_on_failure': False, 06:50:15 INFO - 'name': 'check_screen_resolution'},), 06:50:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:15 INFO - 'cmd': ('bash', 06:50:15 INFO - '-c', 06:50:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:15 INFO - 'enabled': True, 06:50:15 INFO - 'halt_on_failure': False, 06:50:15 INFO - 'name': 'check_screen_resolution'},), 06:50:15 INFO - 'run_cmd_checks_enabled': True, 06:50:15 INFO - 'sps_profile': False, 06:50:15 INFO - 'sps_profile_interval': 0, 06:50:15 INFO - 'suite': 'dromaeojs-e10s', 06:50:15 INFO - 'system_bits': '32', 06:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:15 INFO - 'title': 't-yosemite-r7-0198', 06:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:15 INFO - 'use_talos_json': True, 06:50:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:15 INFO - 'work_dir': 'build'} 06:50:15 INFO - ##### 06:50:15 INFO - ##### Running clobber step. 06:50:15 INFO - ##### 06:50:15 INFO - Running pre-action listener: _resource_record_pre_action 06:50:15 INFO - Running main action method: clobber 06:50:15 INFO - rmtree: /builds/slave/test/build 06:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:16 INFO - Running post-action listener: _resource_record_post_action 06:50:16 INFO - ##### 06:50:16 INFO - ##### Running read-buildbot-config step. 06:50:16 INFO - ##### 06:50:16 INFO - Running pre-action listener: _resource_record_pre_action 06:50:16 INFO - Running main action method: read_buildbot_config 06:50:16 INFO - Using buildbot properties: 06:50:16 INFO - { 06:50:16 INFO - "project": "", 06:50:16 INFO - "product": "firefox", 06:50:16 INFO - "script_repo_revision": "production", 06:50:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 06:50:16 INFO - "repository": "", 06:50:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 06:50:16 INFO - "buildid": "20160423050248", 06:50:16 INFO - "pgo_build": "False", 06:50:16 INFO - "basedir": "/builds/slave/test", 06:50:16 INFO - "buildnumber": 290, 06:50:16 INFO - "slavename": "t-yosemite-r7-0198", 06:50:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:50:16 INFO - "platform": "yosemite_r7", 06:50:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:50:16 INFO - "branch": "mozilla-aurora", 06:50:16 INFO - "repo_path": "releases/mozilla-aurora", 06:50:16 INFO - "revision": "32e9b18217afb665d570621b11363854b1da0a54", 06:50:16 INFO - "stage_platform": "macosx64", 06:50:16 INFO - "builduid": "7dea74687f704e61be54fffc88399692", 06:50:16 INFO - "slavebuilddir": "test" 06:50:16 INFO - } 06:50:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 06:50:16 INFO - Running post-action listener: _resource_record_post_action 06:50:16 INFO - ##### 06:50:16 INFO - ##### Running download-and-extract step. 06:50:16 INFO - ##### 06:50:16 INFO - Running pre-action listener: _resource_record_pre_action 06:50:16 INFO - Running main action method: download_and_extract 06:50:16 INFO - mkdir: /builds/slave/test/build/tests 06:50:16 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')]} 06:50:16 INFO - https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 06:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 06:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:18 INFO - Downloaded 1277 bytes. 06:50:18 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 06:50:18 INFO - Using the following test package requirements: 06:50:18 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:50:18 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 06:50:18 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 06:50:18 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'jsshell-mac.zip'], 06:50:18 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 06:50:18 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:50:18 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 06:50:18 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 06:50:18 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 06:50:18 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 06:50:18 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 06:50:18 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 06:50:18 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:50: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')]} 06:50:18 INFO - https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:20 INFO - Downloaded 17917627 bytes. 06:50:20 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'] 06:50:20 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 06:50:23 INFO - Return code: 0 06:50:23 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 06:50: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')]} 06:50:23 INFO - https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 06:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:25 INFO - Downloaded 17917627 bytes. 06:50:25 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'] 06:50:25 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 06:50:29 INFO - Return code: 0 06:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:29 INFO - https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 06:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 06:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:30 INFO - Downloaded 10845194 bytes. 06:50:30 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'] 06:50:30 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 06:50:30 INFO - Return code: 0 06:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:30 INFO - https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 06:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 06:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmDX6eWIT2ikma9FAfdOPw/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 06:50:34 INFO - Downloaded 115775791 bytes. 06:50:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:50:34 INFO - mkdir: /builds/slave/test/properties 06:50:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:34 INFO - Contents: 06:50:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 06:50:35 INFO - Running post-action listener: _resource_record_post_action 06:50:35 INFO - Running post-action listener: set_extra_try_arguments 06:50:35 INFO - ##### 06:50:35 INFO - ##### Running populate-webroot step. 06:50:35 INFO - ##### 06:50:35 INFO - Running pre-action listener: _resource_record_pre_action 06:50:35 INFO - Running main action method: populate_webroot 06:50:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:35 INFO - '--tppagecycles', 06:50:35 INFO - '7'], 06:50:35 INFO - 'tests': ['tsvgm']}}, 06:50:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:50:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:50:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'tests': ['damp', 'tps']}, 06:50:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['damp', 'tps']}, 06:50:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:50:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:35 INFO - 'other': {'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'other_l64': {'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'other_nol64': {'tests': ['a11yr', 06:50:35 INFO - 'ts_paint', 06:50:35 INFO - 'tpaint', 06:50:35 INFO - 'sessionrestore', 06:50:35 INFO - 'sessionrestore_no_auto_restore', 06:50:35 INFO - 'tabpaint']}, 06:50:35 INFO - 'svgr': {'tests': ['tsvgx', 06:50:35 INFO - 'tsvgr_opacity', 06:50:35 INFO - 'tart', 06:50:35 INFO - 'tscrollx', 06:50:35 INFO - 'cart']}, 06:50:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['tsvgx', 06:50:35 INFO - 'tsvgr_opacity', 06:50:35 INFO - 'tart', 06:50:35 INFO - 'tscrollx', 06:50:35 INFO - 'cart']}, 06:50:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'tests': ['tp5o']}, 06:50:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'talos_options': ['--e10s'], 06:50:35 INFO - 'tests': ['tp5o']}, 06:50:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'talos_options': ['--xperf_path', 06:50:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:35 INFO - 'tests': ['tp5n']}, 06:50:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:35 INFO - 'talos_options': ['--e10s', 06:50:35 INFO - '--xperf_path', 06:50:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:35 INFO - 'tests': ['tp5n']}}, 06:50:35 INFO - 'talos.zip': {'path': '', 06:50:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:35 INFO - Running post-action listener: _resource_record_post_action 06:50:35 INFO - ##### 06:50:35 INFO - ##### Running create-virtualenv step. 06:50:35 INFO - ##### 06:50:35 INFO - Running pre-action listener: _resource_record_pre_action 06:50:35 INFO - Running main action method: create_virtualenv 06:50:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:35 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 06:50:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:36 INFO - Using real prefix '/tools/python27' 06:50:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:39 INFO - Installing pip.................done. 06:50:39 INFO - Return code: 0 06:50:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:39 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')]} 06:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:39 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')]} 06:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:39 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 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:39 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 06:50:39 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 06:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:39 INFO - 'HOME': '/Users/cltbld', 06:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:39 INFO - 'LOGNAME': 'cltbld', 06:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:39 INFO - 'MOZ_NO_REMOTE': '1', 06:50:39 INFO - 'NO_EM_RESTART': '1', 06:50:39 INFO - 'PAGER': '/bin/cat', 06:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:39 INFO - 'PWD': '/builds/slave/test', 06:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:39 INFO - 'SHELL': '/bin/bash', 06:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:39 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:39 INFO - 'USER': 'cltbld', 06:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:39 INFO - 'XPC_FLAGS': '0x0', 06:50:39 INFO - 'XPC_SERVICE_NAME': '0', 06:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:50:40 INFO - Cleaning up... 06:50:40 INFO - Return code: 0 06:50:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:50:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:40 INFO - 'HOME': '/Users/cltbld', 06:50:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:40 INFO - 'LOGNAME': 'cltbld', 06:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:40 INFO - 'MOZ_NO_REMOTE': '1', 06:50:40 INFO - 'NO_EM_RESTART': '1', 06:50:40 INFO - 'PAGER': '/bin/cat', 06:50:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:40 INFO - 'PWD': '/builds/slave/test', 06:50:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:40 INFO - 'SHELL': '/bin/bash', 06:50:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:40 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:40 INFO - 'USER': 'cltbld', 06:50:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:40 INFO - 'XPC_FLAGS': '0x0', 06:50:40 INFO - 'XPC_SERVICE_NAME': '0', 06:50:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:40 INFO - Downloading/unpacking psutil>=0.7.1 06:50:40 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 06:50:40 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 06:50:40 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 06:50:40 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 06:50:40 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 06:50:40 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 06:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:43 INFO - Installing collected packages: psutil 06:50:43 INFO - Running setup.py install for psutil 06:50:43 INFO - building 'psutil._psutil_osx' extension 06:50:43 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 06:50:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:50:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:50:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:50:44 INFO - building 'psutil._psutil_posix' extension 06:50:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:50:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:50:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:50:44 INFO - ^ 06:50:44 INFO - 1 warning generated. 06:50:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:50:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:44 INFO - Successfully installed psutil 06:50:44 INFO - Cleaning up... 06:50:44 INFO - Return code: 0 06:50:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:50:44 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')]} 06:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:44 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')]} 06:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:44 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 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:44 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 06:50:44 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 06:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:44 INFO - 'HOME': '/Users/cltbld', 06:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:44 INFO - 'LOGNAME': 'cltbld', 06:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:44 INFO - 'MOZ_NO_REMOTE': '1', 06:50:44 INFO - 'NO_EM_RESTART': '1', 06:50:44 INFO - 'PAGER': '/bin/cat', 06:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:44 INFO - 'PWD': '/builds/slave/test', 06:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:44 INFO - 'SHELL': '/bin/bash', 06:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:44 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:44 INFO - 'USER': 'cltbld', 06:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:44 INFO - 'XPC_FLAGS': '0x0', 06:50:44 INFO - 'XPC_SERVICE_NAME': '0', 06:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:44 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 06:50:44 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 06:50:44 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 06:50:44 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 06:50:44 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 06:50:44 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 06:50:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:47 INFO - Installing collected packages: mozsystemmonitor 06:50:47 INFO - Running setup.py install for mozsystemmonitor 06:50:47 INFO - Successfully installed mozsystemmonitor 06:50:47 INFO - Cleaning up... 06:50:47 INFO - Return code: 0 06:50:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:47 INFO - 'HOME': '/Users/cltbld', 06:50:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:47 INFO - 'LOGNAME': 'cltbld', 06:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:47 INFO - 'MOZ_NO_REMOTE': '1', 06:50:47 INFO - 'NO_EM_RESTART': '1', 06:50:47 INFO - 'PAGER': '/bin/cat', 06:50:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:47 INFO - 'PWD': '/builds/slave/test', 06:50:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:47 INFO - 'SHELL': '/bin/bash', 06:50:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:47 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:47 INFO - 'USER': 'cltbld', 06:50:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:47 INFO - 'XPC_FLAGS': '0x0', 06:50:47 INFO - 'XPC_SERVICE_NAME': '0', 06:50:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:47 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 06:50:47 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 06:50:47 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 06:50:47 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 06:50:47 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 06:50:47 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 06:50:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:51 INFO - Downloading docopt-0.6.1.tar.gz 06:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:51 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:51 INFO - Running setup.py install for blobuploader 06:50:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:51 INFO - Running setup.py install for requests 06:50:52 INFO - Running setup.py install for docopt 06:50:52 INFO - Successfully installed blobuploader requests docopt 06:50:52 INFO - Cleaning up... 06:50:52 INFO - Return code: 0 06:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:52 INFO - 'HOME': '/Users/cltbld', 06:50:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:52 INFO - 'LOGNAME': 'cltbld', 06:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:52 INFO - 'MOZ_NO_REMOTE': '1', 06:50:52 INFO - 'NO_EM_RESTART': '1', 06:50:52 INFO - 'PAGER': '/bin/cat', 06:50:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:52 INFO - 'PWD': '/builds/slave/test', 06:50:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:52 INFO - 'SHELL': '/bin/bash', 06:50:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:52 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:52 INFO - 'USER': 'cltbld', 06:50:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:52 INFO - 'XPC_FLAGS': '0x0', 06:50:52 INFO - 'XPC_SERVICE_NAME': '0', 06:50:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:52 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-zZA0Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:52 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-HKxPI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:52 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QrmsuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:52 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-JdVSnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:52 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-2Ss9xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-hNsOS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9e4qsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-z4ORXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-sR7CbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ihuuiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Dkseox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-99OIES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-JaaEdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-_MI6rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:53 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-m7ROGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-oklPkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:54 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-t_sAy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:54 INFO - Running setup.py install for manifestparser 06:50:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:54 INFO - Running setup.py install for mozcrash 06:50:54 INFO - Running setup.py install for mozdebug 06:50:54 INFO - Running setup.py install for mozdevice 06:50:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:54 INFO - Running setup.py install for mozfile 06:50:55 INFO - Running setup.py install for mozhttpd 06:50:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Running setup.py install for mozinfo 06:50:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Running setup.py install for mozInstall 06:50:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Running setup.py install for mozleak 06:50:55 INFO - Running setup.py install for mozlog 06:50:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Running setup.py install for moznetwork 06:50:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:55 INFO - Running setup.py install for mozprocess 06:50:56 INFO - Running setup.py install for mozprofile 06:50:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:56 INFO - Running setup.py install for mozrunner 06:50:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:56 INFO - Running setup.py install for mozscreenshot 06:50:56 INFO - Running setup.py install for moztest 06:50:56 INFO - Running setup.py install for mozversion 06:50:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:56 INFO - Cleaning up... 06:50:56 INFO - Return code: 0 06:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:56 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')]} 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:56 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')]} 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:56 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 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:50:56 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 06:50:56 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 06:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:56 INFO - 'HOME': '/Users/cltbld', 06:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:56 INFO - 'LOGNAME': 'cltbld', 06:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:56 INFO - 'MOZ_NO_REMOTE': '1', 06:50:56 INFO - 'NO_EM_RESTART': '1', 06:50:56 INFO - 'PAGER': '/bin/cat', 06:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:56 INFO - 'PWD': '/builds/slave/test', 06:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:56 INFO - 'SHELL': '/bin/bash', 06:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:50:56 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:56 INFO - 'USER': 'cltbld', 06:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:56 INFO - 'XPC_FLAGS': '0x0', 06:50:56 INFO - 'XPC_SERVICE_NAME': '0', 06:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-O1GWJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-oI0mES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-DUqY0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-NxWvKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-yoarCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-c5zjbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-5Uuy4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9v5kvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:57 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)) 06:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:57 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Zqwe8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Zc7iBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QPOvkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-VwPxUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-wpvypd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:58 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)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-dMRfQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:58 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)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-01Ns2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:58 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)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-89KWqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:58 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)) 06:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:58 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-z8SBaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:58 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)) 06:50:58 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)) 06:50:58 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)) 06:50:58 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)) 06:50:58 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)) 06:50:58 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)) 06:50:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:01 INFO - Downloading blessings-1.6.tar.gz 06:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:51:01 INFO - Installing collected packages: blessings 06:51:01 INFO - Running setup.py install for blessings 06:51:01 INFO - Successfully installed blessings 06:51:01 INFO - Cleaning up... 06:51:01 INFO - Return code: 0 06:51:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:51:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:01 INFO - Reading from file tmpfile_stdout 06:51:01 INFO - Current package versions: 06:51:01 INFO - blessings == 1.6 06:51:01 INFO - blobuploader == 1.2.4 06:51:01 INFO - docopt == 0.6.1 06:51:01 INFO - manifestparser == 1.1 06:51:01 INFO - mozInstall == 1.12 06:51:01 INFO - mozcrash == 0.17 06:51:01 INFO - mozdebug == 0.1 06:51:01 INFO - mozdevice == 0.48 06:51:01 INFO - mozfile == 1.2 06:51:01 INFO - mozhttpd == 0.7 06:51:01 INFO - mozinfo == 0.9 06:51:01 INFO - mozleak == 0.1 06:51:01 INFO - mozlog == 3.1 06:51:01 INFO - moznetwork == 0.27 06:51:01 INFO - mozprocess == 0.22 06:51:01 INFO - mozprofile == 0.28 06:51:01 INFO - mozrunner == 6.11 06:51:01 INFO - mozscreenshot == 0.1 06:51:01 INFO - mozsystemmonitor == 0.0 06:51:01 INFO - moztest == 0.7 06:51:01 INFO - mozversion == 1.4 06:51:01 INFO - psutil == 3.1.1 06:51:01 INFO - requests == 1.2.3 06:51:01 INFO - wsgiref == 0.1.2 06:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:51:01 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')]} 06:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:01 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')]} 06:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:01 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 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:51:01 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 06:51:01 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 06:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:01 INFO - 'HOME': '/Users/cltbld', 06:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:01 INFO - 'LOGNAME': 'cltbld', 06:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:01 INFO - 'MOZ_NO_REMOTE': '1', 06:51:01 INFO - 'NO_EM_RESTART': '1', 06:51:01 INFO - 'PAGER': '/bin/cat', 06:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:01 INFO - 'PWD': '/builds/slave/test', 06:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:01 INFO - 'SHELL': '/bin/bash', 06:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:51:01 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:01 INFO - 'USER': 'cltbld', 06:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:01 INFO - 'XPC_FLAGS': '0x0', 06:51:01 INFO - 'XPC_SERVICE_NAME': '0', 06:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:51:02 INFO - Cleaning up... 06:51:02 INFO - Return code: 0 06:51:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:51: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')]} 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51: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')]} 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:02 INFO - 'HOME': '/Users/cltbld', 06:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:02 INFO - 'LOGNAME': 'cltbld', 06:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:02 INFO - 'MOZ_NO_REMOTE': '1', 06:51:02 INFO - 'NO_EM_RESTART': '1', 06:51:02 INFO - 'PAGER': '/bin/cat', 06:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:02 INFO - 'PWD': '/builds/slave/test', 06:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:02 INFO - 'SHELL': '/bin/bash', 06:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:51:02 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:02 INFO - 'USER': 'cltbld', 06:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:02 INFO - 'XPC_FLAGS': '0x0', 06:51:02 INFO - 'XPC_SERVICE_NAME': '0', 06:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:02 INFO - Downloading/unpacking jsonschema 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:51:04 INFO - Downloading/unpacking functools32 (from jsonschema) 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:51:05 INFO - warning: no files found matching '*.txt' 06:51:05 INFO - no previously-included directories found matching 'build' 06:51:05 INFO - no previously-included directories found matching 'dist' 06:51:05 INFO - no previously-included directories found matching '.git*' 06:51:05 INFO - Installing collected packages: jsonschema, functools32 06:51:05 INFO - Running setup.py install for functools32 06:51:05 INFO - warning: no files found matching '*.txt' 06:51:05 INFO - no previously-included directories found matching 'build' 06:51:05 INFO - no previously-included directories found matching 'dist' 06:51:05 INFO - no previously-included directories found matching '.git*' 06:51:05 INFO - Successfully installed jsonschema functools32 06:51:05 INFO - Cleaning up... 06:51:05 INFO - Return code: 0 06:51:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:51:05 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')]} 06:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:05 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')]} 06:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:05 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 0x10ebe8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebef4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f894347ec00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, '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.AAersr0PUW/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.VRwfkHxS2s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 06:51:05 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 06:51:05 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 06:51:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:51:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:05 INFO - 'HOME': '/Users/cltbld', 06:51:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:05 INFO - 'LOGNAME': 'cltbld', 06:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:05 INFO - 'MOZ_NO_REMOTE': '1', 06:51:05 INFO - 'NO_EM_RESTART': '1', 06:51:05 INFO - 'PAGER': '/bin/cat', 06:51:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:05 INFO - 'PWD': '/builds/slave/test', 06:51:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:05 INFO - 'SHELL': '/bin/bash', 06:51:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:51:05 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:51:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:05 INFO - 'USER': 'cltbld', 06:51:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:05 INFO - 'XPC_FLAGS': '0x0', 06:51:05 INFO - 'XPC_SERVICE_NAME': '0', 06:51:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:06 INFO - Downloading/unpacking flake8 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51: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 06:51:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:08 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 06:51:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:09 INFO - no previously-included directories found matching 'docs/_build' 06:51:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:09 INFO - Running setup.py install for pep8 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:09 INFO - no previously-included directories found matching 'docs/_build' 06:51:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:51:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:09 INFO - Cleaning up... 06:51:10 INFO - Return code: 0 06:51:10 INFO - Running post-action listener: _resource_record_post_action 06:51:10 INFO - Running post-action listener: _start_resource_monitoring 06:51:10 INFO - Starting resource monitoring. 06:51:10 INFO - ##### 06:51:10 INFO - ##### Running install step. 06:51:10 INFO - ##### 06:51:10 INFO - Running pre-action listener: _resource_record_pre_action 06:51:10 INFO - Running main action method: install 06:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:10 INFO - Reading from file tmpfile_stdout 06:51:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:10 INFO - Reading from file tmpfile_stdout 06:51:10 INFO - Output received: 06:51:10 INFO - Usage: mozinstall [options] installer 06:51:10 INFO - Options: 06:51:10 INFO - -h, --help show this help message and exit 06:51:10 INFO - -d DEST, --destination=DEST 06:51:10 INFO - Directory to install application into. [default: 06:51:10 INFO - "/builds/slave/test"] 06:51:10 INFO - --app=APP Application being installed. [default: firefox] 06:51:10 INFO - mkdir: /builds/slave/test/build/application 06:51:10 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'] 06:51:10 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 06:51:42 INFO - Reading from file tmpfile_stdout 06:51:42 INFO - Output received: 06:51:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:51:42 INFO - Running post-action listener: _resource_record_post_action 06:51:42 INFO - ##### 06:51:42 INFO - ##### Running run-tests step. 06:51:42 INFO - ##### 06:51:42 INFO - Running pre-action listener: _resource_record_pre_action 06:51:42 INFO - Running main action method: run_tests 06:51:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:51:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:51:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:51:42 INFO - 2016-04-23 06:51:42.642 screenresolution[2292:18787] starting screenresolution argv=screenresolution get 06:51:42 INFO - 2016-04-23 06:51:42.644 screenresolution[2292:18787] Display 0: 1600x1200x32@60 06:51:42 INFO - 2016-04-23 06:51:42.650 screenresolution[2293:18789] starting screenresolution argv=screenresolution list 06:51:42 INFO - Available Modes on Display 0 06:51:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:51:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:51:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:51:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:51:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:51:42 INFO - Intel Iris: 06:51:42 INFO - Chipset Model: Intel Iris 06:51:42 INFO - Type: GPU 06:51:42 INFO - Bus: Built-In 06:51:42 INFO - VRAM (Dynamic, Max): 1536 MB 06:51:42 INFO - Vendor: Intel (0x8086) 06:51:42 INFO - Device ID: 0x0a2e 06:51:42 INFO - Revision ID: 0x0009 06:51:42 INFO - Displays: 06:51:42 INFO - Display: 06:51:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:51:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:51:42 INFO - Display Serial Number: 1600x1200 60 06:51:42 INFO - Main Display: Yes 06:51:42 INFO - Mirror: Off 06:51:42 INFO - Online: Yes 06:51:42 INFO - Rotation: Supported 06:51:42 INFO - Return code: 0 06:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:42 INFO - Python 2.7.3 06:51:42 INFO - Return code: 0 06:51:42 INFO - grabbing minidump binary from tooltool 06:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:42 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 0x10ea8cd30>, '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 0x10e8f0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea83b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:42 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 06:51:42 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 06:51:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:42 INFO - Return code: 0 06:51:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:51:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:51:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:51:44 INFO - Return code: 0 06:51:44 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-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:51:44 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-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0198 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AAersr0PUW/Render', 06:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:44 INFO - 'HOME': '/Users/cltbld', 06:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:44 INFO - 'LOGNAME': 'cltbld', 06:51:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:44 INFO - 'MOZ_NO_REMOTE': '1', 06:51:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:44 INFO - 'NO_EM_RESTART': '1', 06:51:44 INFO - 'PAGER': '/bin/cat', 06:51:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:44 INFO - 'PWD': '/builds/slave/test', 06:51:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:44 INFO - 'SHELL': '/bin/bash', 06:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRwfkHxS2s/Listeners', 06:51:44 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 06:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:44 INFO - 'USER': 'cltbld', 06:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:44 INFO - 'XPC_FLAGS': '0x0', 06:51:44 INFO - 'XPC_SERVICE_NAME': '0', 06:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:51:44 INFO - mozversion application_buildid: 20160423050248 06:51:44 INFO - mozversion application_changeset: 32e9b18217afb665d570621b11363854b1da0a54 06:51:44 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:51:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:44 INFO - mozversion application_name: Firefox 06:51:44 INFO - mozversion application_remotingname: firefox-dev 06:51:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:51:44 INFO - mozversion application_vendor: Mozilla 06:51:44 INFO - mozversion application_version: 47.0a2 06:51:44 INFO - mozversion platform_buildid: 20160423050248 06:51:44 INFO - mozversion platform_changeset: 32e9b18217afb665d570621b11363854b1da0a54 06:51:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:51:44 INFO - mozversion platform_version: 47.0a2 06:51:44 INFO - using testdate: 1461419504 06:51:44 INFO - actual date: 1461419504 06:51:44 INFO - starting webserver on 'localhost:50121' 06:51:44 INFO - SUITE-START | Running 2 tests 06:51:44 INFO - TEST-START | dromaeo_css 06:51:44 INFO - operating with platform_type : mac_ 06:51:44 INFO - Initialising browser for dromaeo_css test... 06:51:44 INFO - TEST-INFO | started process 2311 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpoy9Amy/profile http://localhost:50121/getInfo.html) 06:51:47 INFO - PROCESS | 2311 | __metrics Screen width/height:1600/1200 06:51:47 INFO - PROCESS | 2311 | colorDepth:24 06:51:47 INFO - PROCESS | 2311 | Browser inner width/height: 1024/689 06:51:47 INFO - PROCESS | 2311 | __metrics 06:51:47 ERROR - PROCESS | 2311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 06:51:47 INFO - TEST-INFO | 2311: exit 0 06:51:47 INFO - Browser initialized. 06:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:47 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpoy9Amy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:59 INFO - PROCESS | 2314 | RSS: Main: 218009600 06:51:59 INFO - PROCESS | 2314 | 06:52:49 INFO - PROCESS | 2314 | 1461419569473 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] 06:55:00 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50121/tests/dromaeo/cssquery-ext.html) 06:55:02 INFO - PROCESS | 2314 | RSS: Main: 229146624 06:55:02 INFO - PROCESS | 2314 | 06:58:04 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-ext.html (next: http://localhost:50121/tests/dromaeo/cssquery-jquery.html) 06:58:04 INFO - PROCESS | 2314 | RSS: Main: 240828416 06:58:04 INFO - PROCESS | 2314 | 07:01:06 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50121/tests/dromaeo/cssquery-mootools.html) 07:01:06 INFO - PROCESS | 2314 | RSS: Main: 242790400 07:01:06 INFO - PROCESS | 2314 | 07:04:08 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50121/tests/dromaeo/cssquery-prototype.html) 07:04:09 INFO - PROCESS | 2314 | RSS: Main: 244494336 07:04:09 INFO - PROCESS | 2314 | 07:07:11 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50121/tests/dromaeo/cssquery-yui.html) 07:07:12 INFO - PROCESS | 2314 | RSS: Main: 247353344 07:07:12 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:50121/tests/dromaeo/cssquery-yui.html (next: http://localhost:50121/tests/dromaeo/cssquery-dojo.html) 07:10:14 INFO - PROCESS | 2314 | RSS: Main: 248651776 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | __start_tp_report 07:10:14 INFO - PROCESS | 2314 | _x_x_mozilla_page_load 07:10:14 INFO - PROCESS | 2314 | _x_x_mozilla_page_load_details 07:10:14 INFO - PROCESS | 2314 | |i|pagename|runs| 07:10:14 INFO - PROCESS | 2314 | |0;dojo.html;3476.113591034287;3479.217176135369;3484.1289677580603;3567.9464808027883;3586.713062954964;5199.870003249921;5792.913106303404;5893.970530147354;5923.778583031363;5967.791127310534;5834.5915785895;5861.853453663661;5878.177055212263;5948.256467941507;5948.286205655317;4877.780554861285;4917.3607431033915;5320.467953204688;5395.947790180916;5425.647332923367;4123.9793801030955;5301.549368303698;5380.811671591495;5434.510894019538;5487.75305111269;5355.250264962909;5378.704171270579;5402.432744561824;5405.648632838873;5411.675299482044;4633.745144017078;5147.305113809644;5423.159410291411;5425;5432.972835135839;5283.934413188943;5358.892822143535;5392.541633961118;5400.108982017962;5459.972700136514;5677.460641239076;5705.77176912923;5735.684537350444;5862.091375836752;6008.909866352008;6160.722767475474;6172.783952561639;6191;6210.472109870667;6228.532860035515;6286.874262514724;6290.056491526262;6291.02489114188;6318.020706790455;6318.810435686937;4840.854774356811;5882.617629854046;6037.939620603782;6045.576809623284;6111.816645500642;5393.164059570773;6260.812175634738;6322.841928951813;6336.334684858116;6374.553781235269;4988.501149885055;6213.440790328892;6217.067439884054;6225.782097626652;6233.407826256498;6111.105587097633;6183.690815459209;6222.439980401695;6257.561970662101;6279;6201.255849298113;6227.439530442282;6245.469135123565;6250;6262.2172228471445;6139.386061393825;6222.284437289679;6234.812955611339;6296.307406185316;6308.116863639094;4964.230544265644;4983.825566105169;5010.498950105033;5019.347484826949;5065.696058236444;4448.377227188196;4484.663650226246;4504.797284122157;4506.211413002711;4509.909801803946;5822.184894114827;5954.672493012839;6075.088736689532;6079.179310793074;6105.694715264219;6190.41191086846;6242.812715618538;6274.560780745395;6336.112944187817;6358.713857876407;5010.724410157476;5600.627846177631;6052.697365131814;6065.484433823086;6071.6660583667435;5102.107131252016;5381.650192737459;5503.504684578327;5505.201745746845;5541.2796336476;6124.136831511461;6417.486601071903;6497.740090396331;6531.412172904462;6565.310642382481;5990.311114221746;6263.906041409291;6271.78048768291;6319.842003949938;6330.335314791881;5426.891462170655;6332.588381755171;6460.903086453613;6530.967345163243;6579.17760279965;6132.324915438508;6164;6181.35095814933;6190.783322583688;6214.5028397727165;6233.532485063548;6243.406876346921;6249.218847644044;6265.342139075331;6286.4342209201395;6032.54755893301;6115.605440958429;6128.808691620048;6152.846178845564;6218.9378106218355;5091.338126043591;6130.581587307835;6187.938120618736;6201.379862013762;6205.193324867739;6088.147659327609;6092.086187071797;6106.2061931948565;6114.938850611437;6139.29398119222;6010.909836352545;6117.816465506042;6118.724657390517;6130.275842464065;6146.108814221823;6089.5737298388685;6110.663913484801;6143.293521244936;6151.046587778901;6175.59858609189 07:10:14 INFO - PROCESS | 2314 | |1;ext.html;563.4534501533511;594.3759052994354;616.3312805605917;668.5926125505811;671.8511345599027;38726.838194854165;39614.00964975877;39696;39813.60186398135;39837.80081099594;41425.378619320734;41795.95510112241;41910.58089419105;41983.950401239985;42009;9467.90532094679;9774.804503909918;9812.705618831447;9826.213902887752;9894.604215831394;9599.280053995943;9702;9716.417014979088;9718.979507151753;9755.317127801056;8439.776232446291;9636.759081022996;9699.757506062335;9711.368761030546;9732.562034708455;9430.811383772321;9610.66362677303;9694.660686875926;9697.806043879084;9703.660371886985;9583.712488625353;9732.07545283197;9740.366876153099;9741.951290243504;9791.363561368487;40149.799251003555;40290.395644065364;40412.79793601043;40581.59418405808;40659.98350041243;2791.52544067509;2992.8204307741607;3348.96651033489;3381.881634142818;3957.485526881487;28027.019054333203;28097.876084956577;28183.57724634132;28203;28212.730427130828;2792.0786140573564;2798.174538511124;2804.761595264405;2818.8449635270053;2899;421985;422288;425533.9999999969;426085;426569;47953;57897;65404.672976634814;65638.67180664066;66171;47137.528624714;47529.287060694114;47533.52466475291;47694;47695.523044769805;13746.312684365741;16636.33454661824;17010.914945425193;17018.744718829228;17040.233189506253;13352.933235333761;13683.657908552366;13736.93131534336;13740;13751.243681597409;14925.925370373296;15048.021878577858;15341.156236407105;15513.689726205414;15631.452899148702;6566.704498297588;6706.966465167643;6724.831879202961;6729.69716362755;6762.560433571802;822.8560001999626;883.8453270677605;913.6482454255159;1108.955641774336;1203.9946644551896;30602.693973060428;30864.38271234563;30950.53574196389;31180;31192;1116.3078891087416;1161.3438407299848;1200.2978257719333;1233.3894722112611;1321.0158431968246;12854.871451285555;15416.691666166838;15449.304781284869;15725.685486290438;16116.355345786038;541710;547156;548480;549456;552389;49653.50346496561;52506.21240681393;61998.69000654968;63427.682861585396;63547.682261588394;1390.6940473095904;1428.8497759303652;1520.8327084020748;1545.2891669832004;1555.883308751848;30346.937857174893;30348.323368858815;30590.08229753111;30747.846260768554;30868.845655771576;52710;52768.73615631897;53177.7341113292;53295.20057199222;53484.05837678965;520229;523026;526066;526963;528485;35268.29463410769;35795.463068053476;45907.770461147484;46473.53526464692;47851;44869.65391038274;45140.54859451363;46002.53997460116;47294.05411891674;48530.5146948526;39060.80469597634;39291;39457;39619.81140565788;40173.598264018154;38447.23105537818;38488.6151138485;38621.841344759705;38773.41839872461;39193.82418527449;38945.63690270827;39271.41092883552;39523.40714889336;39883.20233595254;40656.79671601623;31842.522362164123;33013;33017.834910825295;33108;33274.33451330911;24854.627180591942;25158.119465818607;25318.240452786446;25462.490750184523;25525.106621268165 07:10:14 INFO - PROCESS | 2314 | |2;jquery.html;376.59704116595236;382.33473755665153;386.25645632158097;386.48404380152493;387.3937288144056;19618.607627847436;19807.702884456743;20233.089510972004;20712.171513139456;20746.273880414188;21247.893760531177;21363.67954480684;21640;21664.458388540294;21673.783262167373;5704.714764261791;5792.131180322943;6008.369121242272;6011;6036.12476190952;5083.79664813407;5897.7346019429015;5977.671228082454;5978.103284507337;6000.429959153896;5659.094544872821;5794.942050579503;5804.535637149039;5943.167956486095;5947.6134051286745;5782.595218334718;5853.76584936602;5871.295444546639;5881.705914704247;5881.70591470429;5039.949600503985;5064.290999260106;5074.82238121664;5118.974405127988;5143.897122057575;23370.7662923372;24618.753812461826;25643;25834;25942.740572594223;1875.8686891917434;2334.334714606346;2340.9180678676166;2406.1818981546357;2834.5606431003225;9937.254705897087;10090.142337901287;10173.84739228912;12897.613071607866;14721;1770.6543027299217;1781.403229917979;1827.6070644811296;1836.2287839107607;1836.6602178597002;99307.50346248294;112108;114945.42527287394;116256;118442;11741.647750567497;11776.234544754734;11793;11793.646190614296;11802.822957655642;14540.563783086523;14606.196659183846;14616.976811623084;14623.341949612293;14629.92685036568;7724.420668449889;8746.12538746133;9022.413543119676;9081.909180908238;9162.358634895627;9083.45499270046;9217.861732074025;9249.676261330822;9287.164155226063;9294.581743821544;4501.437320334958;4588;4597.586217240464;4634.72191668501;4647.512011238839;1943.6598595246057;1949.385943427844;1959.2848610257154;1961.460598335469;1977.7725561560317;928.8513837785922;1000.6297669862198;1045.9320144190756;1093.1528065749108;1097.4786976186408;20229;20841;20883.24174454211;21013.369598912057;21051.368458946257;861.3023451004706;1002.6991902429243;1018.4602160854758;1040.7138037039724;1061.6231237910586;10774.138068954464;11266;11272.774544509064;11275.718107047225;11297.71755706114;660542;668207;670021;672161.6391918107;681887;76214.23785762182;116598.41700791611;117247.8275217237;119829.40085299518;128596;992.5434300221979;995.6017592962872;1009.7273736091214;1012.9493525323704;1031.7162780235644;18154.819936704072;18263.269469221083;18318.17568209407;18426.907865460587;18457.35399261073;46341.53658463372;48006.039879202915;50370.49629503804;54302.45697542974;54902.45097549133;72592.27407725855;79350;80219;81200;81360.59319703364;7508.887366689613;8331.250187483156;8406.453580517247;8411.663533458594;8688.956555217184;11720;13472;13606.795898061735;13774.380152893344;13841.37713802861;11489.023433007953;11642.126840487166;11709.803960464822;11749;12067.637970860887;9998.804923714344;11173.497192626513;11472.713182170513;11762.647120586396;11903.40482975865;10072.395656260647;11611.013063889326;11691.473883675086;11823.586174483851;12067.517299307929;8182.713605023796;8273.54495502729;8461.788455288666;8468.153184681483;8495.872561911452;10024.548895299584;10915;11252.774944501229;11873.109516786448;12175.817362739388 07:10:14 INFO - PROCESS | 2314 | |3;mootools.html;1565.436442880563;1679.2695177597745;1990.7013947907813;2055.6710926251812;2077.698733683615;8381.119982401851;9068.41055331403;9207.539623018847;9436.811263774729;9438.85841712373;9202.861957070649;9208.263338932886;9293.488858112802;9297.302702297338;9311.95344023279;2576.6779152605923;2577.90977315794;2579.896804127837;2595.039835260956;2598.5322641924445;2544.8345857519203;2604.192700262915;2604.8437093774432;2613.098481024053;2624.606309053638;2583.754543318382;2583.9741602584018;2604.960925586118;2615.3853844346563;2616.4113074558263;2581.2127301173136;2583.6124581312765;2583.6875995983582;2603.0238660502314;2611.569091099966;2561.8334808237405;2580.2259322203263;2596.974030259692;2603.5183491054217;2608.1523504860997;9160.496172710498;9188;9193.862092068624;9254.398464099879;9280.35037547372;5701.515371193454;5791.768329266824;5802.361740208574;5857.7949771757785;5859.941400585983;3691.8892433227047;3750.549934007909;3806.7525610835205;3817.4464702617965;3821.885343439701;1009.3489699144085;1068.3803394031443;1069.9679009629647;1110.0120892405766;1111.0278506306981;11998.160128790989;12140;12229.205101668274;12370.938145309306;12380.752384952251;5057.468965758616;5090.08378491875;5112.974435127875;5148.768305426265;5216.008958297912;10591.735206619896;10599.682009539727;10625.893741062646;10636.202284828514;10652.201084918663;4908.846421091041;5715.514181294637;5819.6508209507565;5832;5870.501007414332;4704.317873908264;5169.172932330809;5220.321358223483;5252.684838909678;5283.128283833202;4026.416169655384;4206.390073439334;4216.789160541961;4245.320748680197;4266.360045993126;1250.7748605251143;1402.8947828912872;1405.8313002439568;1414.5119933622884;1419.4038503828417;1416.1361569442631;1437.3029080895758;1442.939439511958;1462.5539210540887;1463.0270869871417;8672.479651220947;8689.13108689126;8717.564121793885;8718.215360617574;8727.258183054511;464.42179486539476;464.87448388935474;474.8243150034509;519.4908989190615;533.9626226164131;6399.680015999182;6424.743010279536;6500.707468163944;6501.252355979028;6540.967295163494;10974.122070234362;11170.888291116984;11326.830097548544;11341.773164536664;11412.029977451844;10866.239363244496;11165.162612804072;11168.66494005181;11231.045361144394;11287.943560282147;8723.956380218186;8726.520041397784;8761.780955476037;8768.912310876809;8799.69201077972;6333.904991425225;8215;8252.546109964009;8331.375146864131;8394.370422218235;8848.823023539364;9288.58201380953;9726.15816752393;9959.651412200537;10041.949790251001;9442.575084121094;10367.170626349724;10487.213458990454;10546.683599492027;10582.841257380991;7849;7858.5677787722225;7923.247291507298;7946.64240109208;7978.4415090945395;8642.913570864463;8661.783455413664;8672.566371681516;8694;8735.519546424754;7631.580263085583;7680.193579674054;7756.92243077562;7776.144624091458;7842.137364889743;6523.151990241238;7511.849763004819;7542.208068152984;7598.924010759822;7658.463907526642;8043.758687239392;8151.673933042849;8230.794230144294;8230.876536851832;8261.669533218605;7247.891281630675;7344.449166312441;7346.853062938818;7355.7057717690695;7388.076490438695;7401.555906645618;7405.7778266652085;7434.070741157356;7458.5151965122095;7461.701531938662 07:10:14 INFO - PROCESS | 2314 | |4;prototype.html;324.4144319503297;329.57155697593123;338.2507745344062;343.5842630417195;349.6730556929271;6984.755533556327;6986.650667466625;7023.754168604093;7037.472189585782;7071.752488662898;6962.373386395224;6982.301769823015;7007.824804379893;7019.157701075866;7019.719211231544;4940.184869496528;5030.597552195815;5106.285120083173;5142.588592912558;5237.528622423981;5107.233914912774;5128.53843154116;5146.922796158042;5162.483751624845;5165.018646457161;5083.567896728782;5089.949100508985;5091.7708703108265;5092.694438333712;5146.176611742122;4381.298992161255;5089.083964886319;5094.668846525001;5111.309973153614;5117.8464646060675;4448.266036104072;4449.354843547668;4450.243458612012;4462.642988560908;4485.573870482299;6543.672816359211;6687.431568316699;6722.29415911332;6761.830954226134;6813.863722725568;5968.492678122365;5994.310654274771;6003.609765365237;6034.09488576717;6049.213602231725;5944.7324870380935;7432.256774322578;7439.3676537494375;7464.664090115958;7489.138749043876;4955.479674634147;4958.107540642683;4958.305837182797;4961.553460188564;4999.075171093359;6070.9982852829235;7660.693572257103;7728.420368472331;7934.642941067666;7971.441999060068;5067.391912970467;5087.796488140507;5108.514691104339;5110.514501122388;5115.258287548285;5132.640715149903;5174.379074511083;5201.2198170274005;5204.713740744295;5205.29728486657;5176;5180.352455943007;6024.608400453956;6049.425304596057;6052.182955301066;7486.401087912954;7495.287947644965;7507.0240868687815;7533.54798712079;7546;1747.2050217151166;1787.3922866225546;1815.4735126813341;1819.7998220196032;1821.0166510084407;1142.4230763464564;1150.4477850631577;1164.959226427071;1167.9357635329968;1168.4917061078288;6952.895706564405;6984.825379365557;6993.335633114846;7013.789586312419;7021.964890175516;6899.551529150589;7136.571805691675;7507.962460187664;7765.378769698411;7797.181295963956;5635.267415236075;6908.205556360982;6994.4404447644065;7002.614856182857;7026.9648651756415;4084.795760212037;4091.8338273591885;4101.52832424275;4106.3429851224255;4115.71190016696;8106;8108.391870609727;8126.146754590801;8126.471779334324;8156.143604921516;7700.306972372513;7964.402669799788;8007.639656215484;8122.025356957203;8123.837523249502;8184.386171037196;8216.055153657286;8222.547759873265;8229.547374894439;8244.711435099744;7845.333146682367;7854.882176767239;7865.095514015733;7879.763607091796;7886.0536735592095;7690.230976902265;7712.416340525987;7718.764997600357;7731.497452665559;7751.379889608705;7873.37013038944;8219.9589002057;8237.382196335178;8242.093369729206;8254.050784159659;5075.746212689277;5112.71880046601;5116.539511443988;5122.436531981404;5123.282740416419;7856.528608283521;7861.646225919733;7863.21367863232;7867.252611001945;7875.881861772193;7165.605891676008;7504.061992250969;7521.736739214101;7522.097348318237;7533.39732821362;6722.663866806738;7339.192688804121;7477.88783168242;7489.700411983677;7490.250974902466;7330.780076597711;7338.853222935405;7357.301056399633;7364.116306043309;7380.630968451448;7540.622968851426;7565.508241964255;7574.394048476219;7576.204498527575;7607.163212046781;7161.176464706417;7322.450816188913;7357.484976051625;7372.262773722585;7379.077615298088 07:10:14 INFO - PROCESS | 2314 | |5;yui.html;667.9866402671944;675.8209074595236;775.0815283888593;785.1873311122989;789.0846617923206;15426.84573154268;15551.688966220669;15655.843441565581;15689.137097459636;15695.84304156958;11852.466639001244;14509.347079381427;14589.854101458983;14633.634159146;14871.958962872603;774.8062984253936;947.8767760191165;952.6475204174466;963.036963036963;964.2527041542791;801.4670244287541;927.6335847340297;963.6338191487225;965.826151292767;967.3567077893192;904.9638014479445;1009.3590569988037;1021;1022.2997246885869;1024.8872624011353;861.9008813986409;973.5181085362719;987.6296388854215;1010.7220514358573;1014.2393205096178;746.9215732348134;761.2425636491727;761.6724808332415;763.412172627074;764.9120351159632;15444.150571718552;15455.149966751824;15515.224238788016;15516.767248491282;15532.378704851792;13091.41088651013;13231.603051908362;13382.598522044354;13385.933070334586;13547.661308467268;10040.096391324743;10267.537960791782;10354.430506322149;10374.325668831501;10390.27268091234;3043.4978228592254;3415.64135765746;3510.596281427643;3550.680438760524;3580.0333909844458;80571;81474.59262703708;85795;86243.70634440488;88052.55973720155;9502.429854208769;9843;9849.409035457895;9919.950400247953;9963.501824908726;23992.28023159308;24052.759472405403;24065.63901541478;24081.879590601933;24099.397515062265;6570.8028759137305;7827.217278272127;7839.568823714751;7872.370210383156;8048.59757012147;3897.902552436155;4066.2883995300704;4122.464079669624;4123.278426275389;4155.729877558009;3856.325143099946;3896.6687831534637;3901.804909754501;3905.3556163233316;3909.6285852843935;675.9763408280785;679.0255982664892;688.2085601558248;702.7364738223166;708.1148564294632;540.5675459632279;557.6681874284794;558.4052983572483;595.675356930474;615.3692465223182;8364.707235246737;8474.110218426977;8477.915220847835;8602.483850968962;8639.784005399915;507.9282713474566;563.3633993587221;596.9492593129632;604.3835288006297;617.949485874016;3868.9806550967064;3924.8822535323984;3980.442738016622;4116.670666346685;4127.133302006552;103002.45496317561;103846.96153038523;104282.47858760657;104780.42829357566;105648.47175764071;82828;83021.58489207637;83471;84935;88127;63577.36422635807;77994.2200577987;79395;79902.80631758917;79929.60035199903;7944.6822127114265;8059.113497515152;8079.555624440713;8137.593120344078;8211.71259005932;51248.23127653014;52029.7398513005;52173.478265216865;52781.7360913193;55943;75508;76053;76363.47273054397;77012.61493692496;77030.61484692765;9431.717048488556;10984.491899123088;11091.5563377464;11319.09447244235;11565;11948.283103013848;11962.162648614514;12286.078544109048;12314.876851231373;12654.936725316682;9696.563654635418;11607.303561785982;12050.156489046034;12099.57651482194;12271.509139634314;11553.711157221136;11567.826482602935;11851.407429628656;11902.821457677968;11954.222975506564;8751.977403949257;11236.325820450798;11849.933505984503;11948.223365481215;11955.462004209658;8436.620352084294;9264.768380790534;9564.330496865152;9766.169875560658;9772.169365603719;6666.533342665967;8279.254867061993;8911.2425443838;9202.815943681222;9624.422534647943 07:10:14 INFO - PROCESS | 2314 | __end_tp_report 07:10:14 INFO - PROCESS | 2314 | __start_cc_report 07:10:14 INFO - PROCESS | 2314 | _x_x_mozilla_cycle_collect,363 07:10:14 INFO - PROCESS | 2314 | __end_cc_report 07:10:14 INFO - PROCESS | 2314 | __startTimestamp1461420614772__endTimestamp 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | ------- Summary: start ------- 07:10:14 INFO - PROCESS | 2314 | Number of tests: 6 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#0] dojo.html Cycles:165 Average:5791.40 Median:6092.09 stddev:652.01 (10.7%) stddev-sans-first:628.20 07:10:14 INFO - PROCESS | 2314 | Values: 3476.1 3479.2 3484.1 3567.9 3586.7 5199.9 5792.9 5894.0 5923.8 5967.8 5834.6 5861.9 5878.2 5948.3 5948.3 4877.8 4917.4 5320.5 5395.9 5425.6 4124.0 5301.5 5380.8 5434.5 5487.8 5355.3 5378.7 5402.4 5405.6 5411.7 4633.7 5147.3 5423.2 5425.0 5433.0 5283.9 5358.9 5392.5 5400.1 5460.0 5677.5 5705.8 5735.7 5862.1 6008.9 6160.7 6172.8 6191.0 6210.5 6228.5 6286.9 6290.1 6291.0 6318.0 6318.8 4840.9 5882.6 6037.9 6045.6 6111.8 5393.2 6260.8 6322.8 6336.3 6374.6 4988.5 6213.4 6217.1 6225.8 6233.4 6111.1 6183.7 6222.4 6257.6 6279.0 6201.3 6227.4 6245.5 6250.0 6262.2 6139.4 6222.3 6234.8 6296.3 6308.1 4964.2 4983.8 5010.5 5019.3 5065.7 4448.4 4484.7 4504.8 4506.2 4509.9 5822.2 5954.7 6075.1 6079.2 6105.7 6190.4 6242.8 6274.6 6336.1 6358.7 5010.7 5600.6 6052.7 6065.5 6071.7 5102.1 5381.7 5503.5 5505.2 5541.3 6124.1 6417.5 6497.7 6531.4 6565.3 5990.3 6263.9 6271.8 6319.8 6330.3 5426.9 6332.6 6460.9 6531.0 6579.2 6132.3 6164.0 6181.4 6190.8 6214.5 6233.5 6243.4 6249.2 6265.3 6286.4 6032.5 6115.6 6128.8 6152.8 6218.9 5091.3 6130.6 6187.9 6201.4 6205.2 6088.1 6092.1 6106.2 6114.9 6139.3 6010.9 6117.8 6118.7 6130.3 6146.1 6089.6 6110.7 6143.3 6151.0 6175.6 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#1] ext.html Cycles:180 Average:64403.54 Median:40497.20 stddev:133520.11 (329.7%) stddev-sans-first:133808.63 07:10:14 INFO - PROCESS | 2314 | Values: 563.5 594.4 616.3 668.6 671.9 38726.8 39614.0 39696.0 39813.6 39837.8 41425.4 41796.0 41910.6 41984.0 42009.0 9467.9 9774.8 9812.7 9826.2 9894.6 9599.3 9702.0 9716.4 9719.0 9755.3 8439.8 9636.8 9699.8 9711.4 9732.6 9430.8 9610.7 9694.7 9697.8 9703.7 9583.7 9732.1 9740.4 9742.0 9791.4 40149.8 40290.4 40412.8 40581.6 40660.0 2791.5 2992.8 3349.0 3381.9 3957.5 28027.0 28097.9 28183.6 28203.0 28212.7 2792.1 2798.2 2804.8 2818.8 2899.0 421985.0 422288.0 425534.0 426085.0 426569.0 47953.0 57897.0 65404.7 65638.7 66171.0 47137.5 47529.3 47533.5 47694.0 47695.5 13746.3 16636.3 17010.9 17018.7 17040.2 13352.9 13683.7 13736.9 13740.0 13751.2 14925.9 15048.0 15341.2 15513.7 15631.5 6566.7 6707.0 6724.8 6729.7 6762.6 822.9 883.8 913.6 1109.0 1204.0 30602.7 30864.4 30950.5 31180.0 31192.0 1116.3 1161.3 1200.3 1233.4 1321.0 12854.9 15416.7 15449.3 15725.7 16116.4 541710.0 547156.0 548480.0 549456.0 552389.0 49653.5 52506.2 61998.7 63427.7 63547.7 1390.7 1428.8 1520.8 1545.3 1555.9 30346.9 30348.3 30590.1 30747.8 30868.8 52710.0 52768.7 53177.7 53295.2 53484.1 520229.0 523026.0 526066.0 526963.0 528485.0 35268.3 35795.5 45907.8 46473.5 47851.0 44869.7 45140.5 46002.5 47294.1 48530.5 39060.8 39291.0 39457.0 39619.8 40173.6 38447.2 38488.6 38621.8 38773.4 39193.8 38945.6 39271.4 39523.4 39883.2 40656.8 31842.5 33013.0 33017.8 33108.0 33274.3 24854.6 25158.1 25318.2 25462.5 25525.1 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#2] jquery.html Cycles:180 Average:36541.41 Median:21652.23 stddev:110862.53 (512.0%) stddev-sans-first:111140.27 07:10:14 INFO - PROCESS | 2314 | Values: 376.6 382.3 386.3 386.5 387.4 19618.6 19807.7 20233.1 20712.2 20746.3 21247.9 21363.7 21640.0 21664.5 21673.8 5704.7 5792.1 6008.4 6011.0 6036.1 5083.8 5897.7 5977.7 5978.1 6000.4 5659.1 5794.9 5804.5 5943.2 5947.6 5782.6 5853.8 5871.3 5881.7 5881.7 5039.9 5064.3 5074.8 5119.0 5143.9 23370.8 24618.8 25643.0 25834.0 25942.7 1875.9 2334.3 2340.9 2406.2 2834.6 9937.3 10090.1 10173.8 12897.6 14721.0 1770.7 1781.4 1827.6 1836.2 1836.7 99307.5 112108.0 114945.4 116256.0 118442.0 11741.6 11776.2 11793.0 11793.6 11802.8 14540.6 14606.2 14617.0 14623.3 14629.9 7724.4 8746.1 9022.4 9081.9 9162.4 9083.5 9217.9 9249.7 9287.2 9294.6 4501.4 4588.0 4597.6 4634.7 4647.5 1943.7 1949.4 1959.3 1961.5 1977.8 928.9 1000.6 1045.9 1093.2 1097.5 20229.0 20841.0 20883.2 21013.4 21051.4 861.3 1002.7 1018.5 1040.7 1061.6 10774.1 11266.0 11272.8 11275.7 11297.7 660542.0 668207.0 670021.0 672161.6 681887.0 76214.2 116598.4 117247.8 119829.4 128596.0 992.5 995.6 1009.7 1012.9 1031.7 18154.8 18263.3 18318.2 18426.9 18457.4 46341.5 48006.0 50370.5 54302.5 54902.5 72592.3 79350.0 80219.0 81200.0 81360.6 7508.9 8331.3 8406.5 8411.7 8689.0 11720.0 13472.0 13606.8 13774.4 13841.4 11489.0 11642.1 11709.8 11749.0 12067.6 9998.8 11173.5 11472.7 11762.6 11903.4 10072.4 11611.0 11691.5 11823.6 12067.5 8182.7 8273.5 8461.8 8468.2 8495.9 10024.5 10915.0 11252.8 11873.1 12175.8 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#3] mootools.html Cycles:180 Average:6334.70 Median:2867.75 stddev:3335.33 (116.3%) stddev-sans-first:3325.42 07:10:14 INFO - PROCESS | 2314 | Values: 1565.4 1679.3 1990.7 2055.7 2077.7 8381.1 9068.4 9207.5 9436.8 9438.9 9202.9 9208.3 9293.5 9297.3 9312.0 2576.7 2577.9 2579.9 2595.0 2598.5 2544.8 2604.2 2604.8 2613.1 2624.6 2583.8 2584.0 2605.0 2615.4 2616.4 2581.2 2583.6 2583.7 2603.0 2611.6 2561.8 2580.2 2597.0 2603.5 2608.2 9160.5 9188.0 9193.9 9254.4 9280.4 5701.5 5791.8 5802.4 5857.8 5859.9 3691.9 3750.5 3806.8 3817.4 3821.9 1009.3 1068.4 1070.0 1110.0 1111.0 11998.2 12140.0 12229.2 12370.9 12380.8 5057.5 5090.1 5113.0 5148.8 5216.0 10591.7 10599.7 10625.9 10636.2 10652.2 4908.8 5715.5 5819.7 5832.0 5870.5 4704.3 5169.2 5220.3 5252.7 5283.1 4026.4 4206.4 4216.8 4245.3 4266.4 1250.8 1402.9 1405.8 1414.5 1419.4 1416.1 1437.3 1442.9 1462.6 1463.0 8672.5 8689.1 8717.6 8718.2 8727.3 464.4 464.9 474.8 519.5 534.0 6399.7 6424.7 6500.7 6501.3 6541.0 10974.1 11170.9 11326.8 11341.8 11412.0 10866.2 11165.2 11168.7 11231.0 11287.9 8724.0 8726.5 8761.8 8768.9 8799.7 6333.9 8215.0 8252.5 8331.4 8394.4 8848.8 9288.6 9726.2 9959.7 10041.9 9442.6 10367.2 10487.2 10546.7 10582.8 7849.0 7858.6 7923.2 7946.6 7978.4 8642.9 8661.8 8672.6 8694.0 8735.5 7631.6 7680.2 7756.9 7776.1 7842.1 6523.2 7511.8 7542.2 7598.9 7658.5 8043.8 8151.7 8230.8 8230.9 8261.7 7247.9 7344.4 7346.9 7355.7 7388.1 7401.6 7405.8 7434.1 7458.5 7461.7 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#4] prototype.html Cycles:180 Average:6143.04 Median:6985.74 stddev:1954.17 (28.0%) stddev-sans-first:1910.23 07:10:14 INFO - PROCESS | 2314 | Values: 324.4 329.6 338.3 343.6 349.7 6984.8 6986.7 7023.8 7037.5 7071.8 6962.4 6982.3 7007.8 7019.2 7019.7 4940.2 5030.6 5106.3 5142.6 5237.5 5107.2 5128.5 5146.9 5162.5 5165.0 5083.6 5089.9 5091.8 5092.7 5146.2 4381.3 5089.1 5094.7 5111.3 5117.8 4448.3 4449.4 4450.2 4462.6 4485.6 6543.7 6687.4 6722.3 6761.8 6813.9 5968.5 5994.3 6003.6 6034.1 6049.2 5944.7 7432.3 7439.4 7464.7 7489.1 4955.5 4958.1 4958.3 4961.6 4999.1 6071.0 7660.7 7728.4 7934.6 7971.4 5067.4 5087.8 5108.5 5110.5 5115.3 5132.6 5174.4 5201.2 5204.7 5205.3 5176.0 5180.4 6024.6 6049.4 6052.2 7486.4 7495.3 7507.0 7533.5 7546.0 1747.2 1787.4 1815.5 1819.8 1821.0 1142.4 1150.4 1165.0 1167.9 1168.5 6952.9 6984.8 6993.3 7013.8 7022.0 6899.6 7136.6 7508.0 7765.4 7797.2 5635.3 6908.2 6994.4 7002.6 7027.0 4084.8 4091.8 4101.5 4106.3 4115.7 8106.0 8108.4 8126.1 8126.5 8156.1 7700.3 7964.4 8007.6 8122.0 8123.8 8184.4 8216.1 8222.5 8229.5 8244.7 7845.3 7854.9 7865.1 7879.8 7886.1 7690.2 7712.4 7718.8 7731.5 7751.4 7873.4 8220.0 8237.4 8242.1 8254.1 5075.7 5112.7 5116.5 5122.4 5123.3 7856.5 7861.6 7863.2 7867.3 7875.9 7165.6 7504.1 7521.7 7522.1 7533.4 6722.7 7339.2 7477.9 7489.7 7490.3 7330.8 7338.9 7357.3 7364.1 7380.6 7540.6 7565.5 7574.4 7576.2 7607.2 7161.2 7322.5 7357.5 7372.3 7379.1 07:10:14 INFO - PROCESS | 2314 | 07:10:14 INFO - PROCESS | 2314 | [#5] yui.html Cycles:180 Average:19542.28 Median:28250.70 stddev:28271.21 (100.1%) stddev-sans-first:28315.00 07:10:14 INFO - PROCESS | 2314 | Values: 668.0 675.8 775.1 785.2 789.1 15426.8 15551.7 15655.8 15689.1 15695.8 11852.5 14509.3 14589.9 14633.6 14872.0 774.8 947.9 952.6 963.0 964.3 801.5 927.6 963.6 965.8 967.4 905.0 1009.4 1021.0 1022.3 1024.9 861.9 973.5 987.6 1010.7 1014.2 746.9 761.2 761.7 763.4 764.9 15444.2 15455.1 15515.2 15516.8 15532.4 13091.4 13231.6 13382.6 13385.9 13547.7 10040.1 10267.5 10354.4 10374.3 10390.3 3043.5 3415.6 3510.6 3550.7 3580.0 80571.0 81474.6 85795.0 86243.7 88052.6 9502.4 9843.0 9849.4 9920.0 9963.5 23992.3 24052.8 24065.6 24081.9 24099.4 6570.8 7827.2 7839.6 7872.4 8048.6 3897.9 4066.3 4122.5 4123.3 4155.7 3856.3 3896.7 3901.8 3905.4 3909.6 676.0 679.0 688.2 702.7 708.1 540.6 557.7 558.4 595.7 615.4 8364.7 8474.1 8477.9 8602.5 8639.8 507.9 563.4 596.9 604.4 617.9 3869.0 3924.9 3980.4 4116.7 4127.1 103002.5 103847.0 104282.5 104780.4 105648.5 82828.0 83021.6 83471.0 84935.0 88127.0 63577.4 77994.2 79395.0 79902.8 79929.6 7944.7 8059.1 8079.6 8137.6 8211.7 51248.2 52029.7 52173.5 52781.7 55943.0 75508.0 76053.0 76363.5 77012.6 77030.6 9431.7 10984.5 11091.6 11319.1 11565.0 11948.3 11962.2 12286.1 12314.9 12654.9 9696.6 11607.3 12050.2 12099.6 12271.5 11553.7 11567.8 11851.4 11902.8 11954.2 8752.0 11236.3 11849.9 11948.2 11955.5 8436.6 9264.8 9564.3 9766.2 9772.2 6666.5 8279.3 8911.2 9202.8 9624.4 07:10:14 INFO - PROCESS | 2314 | -------- Summary: end -------- 07:10:14 INFO - PROCESS | 2314 | 07:10:15 INFO - TEST-INFO | 2314: exit 0 07:10:15 INFO - TEST-OK | dromaeo_css | took 1110918ms 07:10:15 INFO - TEST-START | kraken 07:10:15 INFO - operating with platform_type : mac_ 07:10:15 INFO - Initialising browser for kraken test... 07:10:15 INFO - TEST-INFO | started process 2318 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpBTH7I9/profile http://localhost:50121/getInfo.html) 07:10:17 INFO - PROCESS | 2318 | __metrics Screen width/height:1600/1200 07:10:17 INFO - PROCESS | 2318 | colorDepth:24 07:10:17 INFO - PROCESS | 2318 | Browser inner width/height: 1024/689 07:10:17 INFO - PROCESS | 2318 | __metrics 07:10:18 ERROR - PROCESS | 2318 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:10:18 INFO - TEST-INFO | 2318: exit 0 07:10:18 INFO - Browser initialized. 07:10:18 INFO - Running cycle 1/1 for kraken test... 07:10:18 INFO - TEST-INFO | started process 2321 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpBTH7I9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:30 INFO - PROCESS | 2321 | RSS: Main: 218030080 07:10:30 INFO - PROCESS | 2321 | 07:10:33 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50121/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:33 INFO - PROCESS | 2321 | RSS: Main: 230301696 07:10:33 INFO - PROCESS | 2321 | 07:10:36 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50121/tests/kraken/driver.html?testName=audio-dft) 07:10:37 INFO - PROCESS | 2321 | RSS: Main: 239173632 07:10:37 INFO - PROCESS | 2321 | 07:10:40 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50121/tests/kraken/driver.html?testName=audio-fft) 07:10:41 INFO - PROCESS | 2321 | RSS: Main: 242683904 07:10:41 INFO - PROCESS | 2321 | 07:10:42 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50121/tests/kraken/driver.html?testName=audio-oscillator) 07:10:43 INFO - PROCESS | 2321 | RSS: Main: 243290112 07:10:43 INFO - PROCESS | 2321 | 07:10:45 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:46 INFO - PROCESS | 2321 | RSS: Main: 243683328 07:10:46 INFO - PROCESS | 2321 | 07:10:48 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50121/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:49 INFO - PROCESS | 2321 | RSS: Main: 244195328 07:10:49 INFO - PROCESS | 2321 | 07:10:52 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50121/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:52 INFO - PROCESS | 2321 | RSS: Main: 244908032 07:10:52 INFO - PROCESS | 2321 | 07:10:55 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50121/tests/kraken/driver.html?testName=json-parse-financial) 07:10:56 INFO - PROCESS | 2321 | RSS: Main: 244875264 07:10:56 INFO - PROCESS | 2321 | 07:10:57 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:58 INFO - PROCESS | 2321 | RSS: Main: 244830208 07:10:58 INFO - PROCESS | 2321 | 07:11:00 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:01 INFO - PROCESS | 2321 | RSS: Main: 245039104 07:11:01 INFO - PROCESS | 2321 | 07:11:03 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:03 INFO - PROCESS | 2321 | RSS: Main: 245170176 07:11:03 INFO - PROCESS | 2321 | 07:11:06 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:06 INFO - PROCESS | 2321 | RSS: Main: 245297152 07:11:06 INFO - PROCESS | 2321 | 07:11:09 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:10 INFO - PROCESS | 2321 | RSS: Main: 245325824 07:11:10 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | Cycle 1(1): loaded http://localhost:50121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50121/tests/kraken/driver.html?testName=ai-astar) 07:11:11 INFO - PROCESS | 2321 | RSS: Main: 247119872 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | __start_tp_report 07:11:11 INFO - PROCESS | 2321 | _x_x_mozilla_page_load 07:11:11 INFO - PROCESS | 2321 | _x_x_mozilla_page_load_details 07:11:11 INFO - PROCESS | 2321 | |i|pagename|runs| 07:11:11 INFO - PROCESS | 2321 | |0;ai-astar;117;111;114;114;115;136;168;164;112;113 07:11:11 INFO - PROCESS | 2321 | |1;audio-beat-detection;152;121;163;185;152;140;117;154;183;154 07:11:11 INFO - PROCESS | 2321 | |2;audio-dft;195;191;198;202;196;197;193;195;196;200 07:11:11 INFO - PROCESS | 2321 | |3;audio-fft;65;76;70;112;55;56;61;64;128;58 07:11:11 INFO - PROCESS | 2321 | |4;audio-oscillator;83;85;119;80;83;85;120;80;81;121 07:11:11 INFO - PROCESS | 2321 | |5;imaging-gaussian-blur;134;123;90;88;89;87;90;88;88;86 07:11:11 INFO - PROCESS | 2321 | |6;imaging-darkroom;95;96;95;94;95;96;93;95;103;94 07:11:11 INFO - PROCESS | 2321 | |7;imaging-desaturate;90;92;90;92;91;91;97;144;137;89 07:11:11 INFO - PROCESS | 2321 | |8;json-parse-financial;54;60;59;59;60;60;60;62;55;50 07:11:11 INFO - PROCESS | 2321 | |9;json-stringify-tinderbox;64;69;66;72;76;95;61;84;97;99 07:11:11 INFO - PROCESS | 2321 | |10;stanford-crypto-aes;84;81;82;84;82;83;84;82;84;84 07:11:11 INFO - PROCESS | 2321 | |11;stanford-crypto-ccm;103;132;114;133;130;120;131;131;162;135 07:11:11 INFO - PROCESS | 2321 | |12;stanford-crypto-pbkdf2;124;136;140;133;135;136;137;140;134;136 07:11:11 INFO - PROCESS | 2321 | |13;stanford-crypto-sha256-iterative;67;65;67;65;68;64;65;71;66;67 07:11:11 INFO - PROCESS | 2321 | __end_tp_report 07:11:11 INFO - PROCESS | 2321 | __start_cc_report 07:11:11 INFO - PROCESS | 2321 | _x_x_mozilla_cycle_collect,932 07:11:11 INFO - PROCESS | 2321 | __end_cc_report 07:11:11 INFO - PROCESS | 2321 | __startTimestamp1461420671939__endTimestamp 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | ------- Summary: start ------- 07:11:11 INFO - PROCESS | 2321 | Number of tests: 14 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#0] ai-astar Cycles:10 Average:126.40 Median:116.00 stddev:22.08 (19.0%) stddev-sans-first:23.15 07:11:11 INFO - PROCESS | 2321 | Values: 117.0 111.0 114.0 114.0 115.0 136.0 168.0 164.0 112.0 113.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:154.00 stddev:22.38 (14.5%) stddev-sans-first:23.74 07:11:11 INFO - PROCESS | 2321 | Values: 152.0 121.0 163.0 185.0 152.0 140.0 117.0 154.0 183.0 154.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#2] audio-dft Cycles:10 Average:196.30 Median:196.50 stddev:3.20 (1.6%) stddev-sans-first:3.36 07:11:11 INFO - PROCESS | 2321 | Values: 195.0 191.0 198.0 202.0 196.0 197.0 193.0 195.0 196.0 200.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#3] audio-fft Cycles:10 Average:74.50 Median:62.50 stddev:25.10 (40.2%) stddev-sans-first:26.38 07:11:11 INFO - PROCESS | 2321 | Values: 65.0 76.0 70.0 112.0 55.0 56.0 61.0 64.0 128.0 58.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:82.00 stddev:18.24 (22.2%) stddev-sans-first:18.93 07:11:11 INFO - PROCESS | 2321 | Values: 83.0 85.0 119.0 80.0 83.0 85.0 120.0 80.0 81.0 121.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.00 stddev:17.21 (19.6%) stddev-sans-first:11.66 07:11:11 INFO - PROCESS | 2321 | Values: 134.0 123.0 90.0 88.0 89.0 87.0 90.0 88.0 88.0 86.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:95.00 stddev:2.76 (2.9%) stddev-sans-first:2.92 07:11:11 INFO - PROCESS | 2321 | Values: 95.0 96.0 95.0 94.0 95.0 96.0 93.0 95.0 103.0 94.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:91.00 stddev:20.84 (22.9%) stddev-sans-first:21.70 07:11:11 INFO - PROCESS | 2321 | Values: 90.0 92.0 90.0 92.0 91.0 91.0 97.0 144.0 137.0 89.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:60.00 stddev:3.70 (6.2%) stddev-sans-first:3.64 07:11:11 INFO - PROCESS | 2321 | Values: 54.0 60.0 59.0 59.0 60.0 60.0 60.0 62.0 55.0 50.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:80.00 stddev:14.44 (18.0%) stddev-sans-first:14.36 07:11:11 INFO - PROCESS | 2321 | Values: 64.0 69.0 66.0 72.0 76.0 95.0 61.0 84.0 97.0 99.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:84.00 stddev:1.15 (1.4%) stddev-sans-first:1.17 07:11:11 INFO - PROCESS | 2321 | Values: 84.0 81.0 82.0 84.0 82.0 83.0 84.0 82.0 84.0 84.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:131.50 stddev:15.42 (11.7%) stddev-sans-first:13.15 07:11:11 INFO - PROCESS | 2321 | Values: 103.0 132.0 114.0 133.0 130.0 120.0 131.0 131.0 162.0 135.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:136.00 stddev:4.51 (3.3%) stddev-sans-first:2.40 07:11:11 INFO - PROCESS | 2321 | Values: 124.0 136.0 140.0 133.0 135.0 136.0 137.0 140.0 134.0 136.0 07:11:11 INFO - PROCESS | 2321 | 07:11:11 INFO - PROCESS | 2321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.01 (3.0%) stddev-sans-first:2.13 07:11:11 INFO - PROCESS | 2321 | Values: 67.0 65.0 67.0 65.0 68.0 64.0 65.0 71.0 66.0 67.0 07:11:11 INFO - PROCESS | 2321 | -------- Summary: end -------- 07:11:11 INFO - PROCESS | 2321 | 07:11:12 INFO - TEST-INFO | 2321: exit 0 07:11:12 INFO - TEST-OK | kraken | took 57421ms 07:11:12 INFO - SUITE-END | took 1168s 07:11:13 INFO - Completed test suite (00:19:28) 07:11:13 INFO - javascript benchmark 07:11:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3476.113591034287, 3479.217176135369, 3484.1289677580603, 3567.9464808027883, 3586.713062954964, 5199.870003249921, 5792.913106303404, 5893.970530147354, 5923.778583031363, 5967.791127310534, 5834.5915785895, 5861.853453663661, 5878.177055212263, 5948.256467941507, 5948.286205655317, 4877.780554861285, 4917.3607431033915, 5320.467953204688, 5395.947790180916, 5425.647332923367, 4123.9793801030955, 5301.549368303698, 5380.811671591495, 5434.510894019538, 5487.75305111269, 5355.250264962909, 5378.704171270579, 5402.432744561824, 5405.648632838873, 5411.675299482044, 4633.745144017078, 5147.305113809644, 5423.159410291411, 5425.0, 5432.972835135839, 5283.934413188943, 5358.892822143535, 5392.541633961118, 5400.108982017962, 5459.972700136514, 5677.460641239076, 5705.77176912923, 5735.684537350444, 5862.091375836752, 6008.909866352008, 6160.722767475474, 6172.783952561639, 6191.0, 6210.472109870667, 6228.532860035515, 6286.874262514724, 6290.056491526262, 6291.02489114188, 6318.020706790455, 6318.810435686937, 4840.854774356811, 5882.617629854046, 6037.939620603782, 6045.576809623284, 6111.816645500642, 5393.164059570773, 6260.812175634738, 6322.841928951813, 6336.334684858116, 6374.553781235269, 4988.501149885055, 6213.440790328892, 6217.067439884054, 6225.782097626652, 6233.407826256498, 6111.105587097633, 6183.690815459209, 6222.439980401695, 6257.561970662101, 6279.0, 6201.255849298113, 6227.439530442282, 6245.469135123565, 6250.0, 6262.2172228471445, 6139.386061393825, 6222.284437289679, 6234.812955611339, 6296.307406185316, 6308.116863639094, 4964.230544265644, 4983.825566105169, 5010.498950105033, 5019.347484826949, 5065.696058236444, 4448.377227188196, 4484.663650226246, 4504.797284122157, 4506.211413002711, 4509.909801803946, 5822.184894114827, 5954.672493012839, 6075.088736689532, 6079.179310793074, 6105.694715264219, 6190.41191086846, 6242.812715618538, 6274.560780745395, 6336.112944187817, 6358.713857876407, 5010.724410157476, 5600.627846177631, 6052.697365131814, 6065.484433823086, 6071.6660583667435, 5102.107131252016, 5381.650192737459, 5503.504684578327, 5505.201745746845, 5541.2796336476, 6124.136831511461, 6417.486601071903, 6497.740090396331, 6531.412172904462, 6565.310642382481, 5990.311114221746, 6263.906041409291, 6271.78048768291, 6319.842003949938, 6330.335314791881, 5426.891462170655, 6332.588381755171, 6460.903086453613, 6530.967345163243, 6579.17760279965, 6132.324915438508, 6164.0, 6181.35095814933, 6190.783322583688, 6214.5028397727165, 6233.532485063548, 6243.406876346921, 6249.218847644044, 6265.342139075331, 6286.4342209201395, 6032.54755893301, 6115.605440958429, 6128.808691620048, 6152.846178845564, 6218.9378106218355, 5091.338126043591, 6130.581587307835, 6187.938120618736, 6201.379862013762, 6205.193324867739, 6088.147659327609, 6092.086187071797, 6106.2061931948565, 6114.938850611437, 6139.29398119222, 6010.909836352545, 6117.816465506042, 6118.724657390517, 6130.275842464065, 6146.108814221823, 6089.5737298388685, 6110.663913484801, 6143.293521244936, 6151.046587778901, 6175.59858609189], "unit": "score", "name": "dojo.html", "value": 5753.787640631063}, {"lowerIsBetter": false, "replicates": [563.4534501533511, 594.3759052994354, 616.3312805605917, 668.5926125505811, 671.8511345599027, 38726.838194854165, 39614.00964975877, 39696.0, 39813.60186398135, 39837.80081099594, 41425.378619320734, 41795.95510112241, 41910.58089419105, 41983.950401239985, 42009.0, 9467.90532094679, 9774.804503909918, 9812.705618831447, 9826.213902887752, 9894.604215831394, 9599.280053995943, 9702.0, 9716.417014979088, 9718.979507151753, 9755.317127801056, 8439.776232446291, 9636.759081022996, 9699.757506062335, 9711.368761030546, 9732.562034708455, 9430.811383772321, 9610.66362677303, 9694.660686875926, 9697.806043879084, 9703.660371886985, 9583.712488625353, 9732.07545283197, 9740.366876153099, 9741.951290243504, 9791.363561368487, 40149.799251003555, 40290.395644065364, 40412.79793601043, 40581.59418405808, 40659.98350041243, 2791.52544067509, 2992.8204307741607, 3348.96651033489, 3381.881634142818, 3957.485526881487, 28027.019054333203, 28097.876084956577, 28183.57724634132, 28203.0, 28212.730427130828, 2792.0786140573564, 2798.174538511124, 2804.761595264405, 2818.8449635270053, 2899.0, 421985.0, 422288.0, 425533.9999999969, 426085.0, 426569.0, 47953.0, 57897.0, 65404.672976634814, 65638.67180664066, 66171.0, 47137.528624714, 47529.287060694114, 47533.52466475291, 47694.0, 47695.523044769805, 13746.312684365741, 16636.33454661824, 17010.914945425193, 17018.744718829228, 17040.233189506253, 13352.933235333761, 13683.657908552366, 13736.93131534336, 13740.0, 13751.243681597409, 14925.925370373296, 15048.021878577858, 15341.156236407105, 15513.689726205414, 15631.452899148702, 6566.704498297588, 6706.966465167643, 6724.831879202961, 6729.69716362755, 6762.560433571802, 822.8560001999626, 883.8453270677605, 913.6482454255159, 1108.955641774336, 1203.9946644551896, 30602.693973060428, 30864.38271234563, 30950.53574196389, 31180.0, 31192.0, 1116.3078891087416, 1161.3438407299848, 1200.2978257719333, 1233.3894722112611, 1321.0158431968246, 12854.871451285555, 15416.691666166838, 15449.304781284869, 15725.685486290438, 16116.355345786038, 541710.0, 547156.0, 548480.0, 549456.0, 552389.0, 49653.50346496561, 52506.21240681393, 61998.69000654968, 63427.682861585396, 63547.682261588394, 1390.6940473095904, 1428.8497759303652, 1520.8327084020748, 1545.2891669832004, 1555.883308751848, 30346.937857174893, 30348.323368858815, 30590.08229753111, 30747.846260768554, 30868.845655771576, 52710.0, 52768.73615631897, 53177.7341113292, 53295.20057199222, 53484.05837678965, 520229.0, 523026.0, 526066.0, 526963.0, 528485.0, 35268.29463410769, 35795.463068053476, 45907.770461147484, 46473.53526464692, 47851.0, 44869.65391038274, 45140.54859451363, 46002.53997460116, 47294.05411891674, 48530.5146948526, 39060.80469597634, 39291.0, 39457.0, 39619.81140565788, 40173.598264018154, 38447.23105537818, 38488.6151138485, 38621.841344759705, 38773.41839872461, 39193.82418527449, 38945.63690270827, 39271.41092883552, 39523.40714889336, 39883.20233595254, 40656.79671601623, 31842.522362164123, 33013.0, 33017.834910825295, 33108.0, 33274.33451330911, 24854.627180591942, 25158.119465818607, 25318.240452786446, 25462.490750184523, 25525.106621268165], "unit": "score", "name": "ext.html", "value": 19892.916008157543}, {"lowerIsBetter": false, "replicates": [376.59704116595236, 382.33473755665153, 386.25645632158097, 386.48404380152493, 387.3937288144056, 19618.607627847436, 19807.702884456743, 20233.089510972004, 20712.171513139456, 20746.273880414188, 21247.893760531177, 21363.67954480684, 21640.0, 21664.458388540294, 21673.783262167373, 5704.714764261791, 5792.131180322943, 6008.369121242272, 6011.0, 6036.12476190952, 5083.79664813407, 5897.7346019429015, 5977.671228082454, 5978.103284507337, 6000.429959153896, 5659.094544872821, 5794.942050579503, 5804.535637149039, 5943.167956486095, 5947.6134051286745, 5782.595218334718, 5853.76584936602, 5871.295444546639, 5881.705914704247, 5881.70591470429, 5039.949600503985, 5064.290999260106, 5074.82238121664, 5118.974405127988, 5143.897122057575, 23370.7662923372, 24618.753812461826, 25643.0, 25834.0, 25942.740572594223, 1875.8686891917434, 2334.334714606346, 2340.9180678676166, 2406.1818981546357, 2834.5606431003225, 9937.254705897087, 10090.142337901287, 10173.84739228912, 12897.613071607866, 14721.0, 1770.6543027299217, 1781.403229917979, 1827.6070644811296, 1836.2287839107607, 1836.6602178597002, 99307.50346248294, 112108.0, 114945.42527287394, 116256.0, 118442.0, 11741.647750567497, 11776.234544754734, 11793.0, 11793.646190614296, 11802.822957655642, 14540.563783086523, 14606.196659183846, 14616.976811623084, 14623.341949612293, 14629.92685036568, 7724.420668449889, 8746.12538746133, 9022.413543119676, 9081.909180908238, 9162.358634895627, 9083.45499270046, 9217.861732074025, 9249.676261330822, 9287.164155226063, 9294.581743821544, 4501.437320334958, 4588.0, 4597.586217240464, 4634.72191668501, 4647.512011238839, 1943.6598595246057, 1949.385943427844, 1959.2848610257154, 1961.460598335469, 1977.7725561560317, 928.8513837785922, 1000.6297669862198, 1045.9320144190756, 1093.1528065749108, 1097.4786976186408, 20229.0, 20841.0, 20883.24174454211, 21013.369598912057, 21051.368458946257, 861.3023451004706, 1002.6991902429243, 1018.4602160854758, 1040.7138037039724, 1061.6231237910586, 10774.138068954464, 11266.0, 11272.774544509064, 11275.718107047225, 11297.71755706114, 660542.0, 668207.0, 670021.0, 672161.6391918107, 681887.0, 76214.23785762182, 116598.41700791611, 117247.8275217237, 119829.40085299518, 128596.0, 992.5434300221979, 995.6017592962872, 1009.7273736091214, 1012.9493525323704, 1031.7162780235644, 18154.819936704072, 18263.269469221083, 18318.17568209407, 18426.907865460587, 18457.35399261073, 46341.53658463372, 48006.039879202915, 50370.49629503804, 54302.45697542974, 54902.45097549133, 72592.27407725855, 79350.0, 80219.0, 81200.0, 81360.59319703364, 7508.887366689613, 8331.250187483156, 8406.453580517247, 8411.663533458594, 8688.956555217184, 11720.0, 13472.0, 13606.795898061735, 13774.380152893344, 13841.37713802861, 11489.023433007953, 11642.126840487166, 11709.803960464822, 11749.0, 12067.637970860887, 9998.804923714344, 11173.497192626513, 11472.713182170513, 11762.647120586396, 11903.40482975865, 10072.395656260647, 11611.013063889326, 11691.473883675086, 11823.586174483851, 12067.517299307929, 8182.713605023796, 8273.54495502729, 8461.788455288666, 8468.153184681483, 8495.872561911452, 10024.548895299584, 10915.0, 11252.774944501229, 11873.109516786448, 12175.817362739388], "unit": "score", "name": "jquery.html", "value": 9720.714299789544}, {"lowerIsBetter": false, "replicates": [1565.436442880563, 1679.2695177597745, 1990.7013947907813, 2055.6710926251812, 2077.698733683615, 8381.119982401851, 9068.41055331403, 9207.539623018847, 9436.811263774729, 9438.85841712373, 9202.861957070649, 9208.263338932886, 9293.488858112802, 9297.302702297338, 9311.95344023279, 2576.6779152605923, 2577.90977315794, 2579.896804127837, 2595.039835260956, 2598.5322641924445, 2544.8345857519203, 2604.192700262915, 2604.8437093774432, 2613.098481024053, 2624.606309053638, 2583.754543318382, 2583.9741602584018, 2604.960925586118, 2615.3853844346563, 2616.4113074558263, 2581.2127301173136, 2583.6124581312765, 2583.6875995983582, 2603.0238660502314, 2611.569091099966, 2561.8334808237405, 2580.2259322203263, 2596.974030259692, 2603.5183491054217, 2608.1523504860997, 9160.496172710498, 9188.0, 9193.862092068624, 9254.398464099879, 9280.35037547372, 5701.515371193454, 5791.768329266824, 5802.361740208574, 5857.7949771757785, 5859.941400585983, 3691.8892433227047, 3750.549934007909, 3806.7525610835205, 3817.4464702617965, 3821.885343439701, 1009.3489699144085, 1068.3803394031443, 1069.9679009629647, 1110.0120892405766, 1111.0278506306981, 11998.160128790989, 12140.0, 12229.205101668274, 12370.938145309306, 12380.752384952251, 5057.468965758616, 5090.08378491875, 5112.974435127875, 5148.768305426265, 5216.008958297912, 10591.735206619896, 10599.682009539727, 10625.893741062646, 10636.202284828514, 10652.201084918663, 4908.846421091041, 5715.514181294637, 5819.6508209507565, 5832.0, 5870.501007414332, 4704.317873908264, 5169.172932330809, 5220.321358223483, 5252.684838909678, 5283.128283833202, 4026.416169655384, 4206.390073439334, 4216.789160541961, 4245.320748680197, 4266.360045993126, 1250.7748605251143, 1402.8947828912872, 1405.8313002439568, 1414.5119933622884, 1419.4038503828417, 1416.1361569442631, 1437.3029080895758, 1442.939439511958, 1462.5539210540887, 1463.0270869871417, 8672.479651220947, 8689.13108689126, 8717.564121793885, 8718.215360617574, 8727.258183054511, 464.42179486539476, 464.87448388935474, 474.8243150034509, 519.4908989190615, 533.9626226164131, 6399.680015999182, 6424.743010279536, 6500.707468163944, 6501.252355979028, 6540.967295163494, 10974.122070234362, 11170.888291116984, 11326.830097548544, 11341.773164536664, 11412.029977451844, 10866.239363244496, 11165.162612804072, 11168.66494005181, 11231.045361144394, 11287.943560282147, 8723.956380218186, 8726.520041397784, 8761.780955476037, 8768.912310876809, 8799.69201077972, 6333.904991425225, 8215.0, 8252.546109964009, 8331.375146864131, 8394.370422218235, 8848.823023539364, 9288.58201380953, 9726.15816752393, 9959.651412200537, 10041.949790251001, 9442.575084121094, 10367.170626349724, 10487.213458990454, 10546.683599492027, 10582.841257380991, 7849.0, 7858.5677787722225, 7923.247291507298, 7946.64240109208, 7978.4415090945395, 8642.913570864463, 8661.783455413664, 8672.566371681516, 8694.0, 8735.519546424754, 7631.580263085583, 7680.193579674054, 7756.92243077562, 7776.144624091458, 7842.137364889743, 6523.151990241238, 7511.849763004819, 7542.208068152984, 7598.924010759822, 7658.463907526642, 8043.758687239392, 8151.673933042849, 8230.794230144294, 8230.876536851832, 8261.669533218605, 7247.891281630675, 7344.449166312441, 7346.853062938818, 7355.7057717690695, 7388.076490438695, 7401.555906645618, 7405.7778266652085, 7434.070741157356, 7458.5151965122095, 7461.701531938662], "unit": "score", "name": "mootools.html", "value": 5085.1972477784875}, {"lowerIsBetter": false, "replicates": [324.4144319503297, 329.57155697593123, 338.2507745344062, 343.5842630417195, 349.6730556929271, 6984.755533556327, 6986.650667466625, 7023.754168604093, 7037.472189585782, 7071.752488662898, 6962.373386395224, 6982.301769823015, 7007.824804379893, 7019.157701075866, 7019.719211231544, 4940.184869496528, 5030.597552195815, 5106.285120083173, 5142.588592912558, 5237.528622423981, 5107.233914912774, 5128.53843154116, 5146.922796158042, 5162.483751624845, 5165.018646457161, 5083.567896728782, 5089.949100508985, 5091.7708703108265, 5092.694438333712, 5146.176611742122, 4381.298992161255, 5089.083964886319, 5094.668846525001, 5111.309973153614, 5117.8464646060675, 4448.266036104072, 4449.354843547668, 4450.243458612012, 4462.642988560908, 4485.573870482299, 6543.672816359211, 6687.431568316699, 6722.29415911332, 6761.830954226134, 6813.863722725568, 5968.492678122365, 5994.310654274771, 6003.609765365237, 6034.09488576717, 6049.213602231725, 5944.7324870380935, 7432.256774322578, 7439.3676537494375, 7464.664090115958, 7489.138749043876, 4955.479674634147, 4958.107540642683, 4958.305837182797, 4961.553460188564, 4999.075171093359, 6070.9982852829235, 7660.693572257103, 7728.420368472331, 7934.642941067666, 7971.441999060068, 5067.391912970467, 5087.796488140507, 5108.514691104339, 5110.514501122388, 5115.258287548285, 5132.640715149903, 5174.379074511083, 5201.2198170274005, 5204.713740744295, 5205.29728486657, 5176.0, 5180.352455943007, 6024.608400453956, 6049.425304596057, 6052.182955301066, 7486.401087912954, 7495.287947644965, 7507.0240868687815, 7533.54798712079, 7546.0, 1747.2050217151166, 1787.3922866225546, 1815.4735126813341, 1819.7998220196032, 1821.0166510084407, 1142.4230763464564, 1150.4477850631577, 1164.959226427071, 1167.9357635329968, 1168.4917061078288, 6952.895706564405, 6984.825379365557, 6993.335633114846, 7013.789586312419, 7021.964890175516, 6899.551529150589, 7136.571805691675, 7507.962460187664, 7765.378769698411, 7797.181295963956, 5635.267415236075, 6908.205556360982, 6994.4404447644065, 7002.614856182857, 7026.9648651756415, 4084.795760212037, 4091.8338273591885, 4101.52832424275, 4106.3429851224255, 4115.71190016696, 8106.0, 8108.391870609727, 8126.146754590801, 8126.471779334324, 8156.143604921516, 7700.306972372513, 7964.402669799788, 8007.639656215484, 8122.025356957203, 8123.837523249502, 8184.386171037196, 8216.055153657286, 8222.547759873265, 8229.547374894439, 8244.711435099744, 7845.333146682367, 7854.882176767239, 7865.095514015733, 7879.763607091796, 7886.0536735592095, 7690.230976902265, 7712.416340525987, 7718.764997600357, 7731.497452665559, 7751.379889608705, 7873.37013038944, 8219.9589002057, 8237.382196335178, 8242.093369729206, 8254.050784159659, 5075.746212689277, 5112.71880046601, 5116.539511443988, 5122.436531981404, 5123.282740416419, 7856.528608283521, 7861.646225919733, 7863.21367863232, 7867.252611001945, 7875.881861772193, 7165.605891676008, 7504.061992250969, 7521.736739214101, 7522.097348318237, 7533.39732821362, 6722.663866806738, 7339.192688804121, 7477.88783168242, 7489.700411983677, 7490.250974902466, 7330.780076597711, 7338.853222935405, 7357.301056399633, 7364.116306043309, 7380.630968451448, 7540.622968851426, 7565.508241964255, 7574.394048476219, 7576.204498527575, 7607.163212046781, 7161.176464706417, 7322.450816188913, 7357.484976051625, 7372.262773722585, 7379.077615298088], "unit": "score", "name": "prototype.html", "value": 5488.26895265254}, {"lowerIsBetter": false, "replicates": [667.9866402671944, 675.8209074595236, 775.0815283888593, 785.1873311122989, 789.0846617923206, 15426.84573154268, 15551.688966220669, 15655.843441565581, 15689.137097459636, 15695.84304156958, 11852.466639001244, 14509.347079381427, 14589.854101458983, 14633.634159146, 14871.958962872603, 774.8062984253936, 947.8767760191165, 952.6475204174466, 963.036963036963, 964.2527041542791, 801.4670244287541, 927.6335847340297, 963.6338191487225, 965.826151292767, 967.3567077893192, 904.9638014479445, 1009.3590569988037, 1021.0, 1022.2997246885869, 1024.8872624011353, 861.9008813986409, 973.5181085362719, 987.6296388854215, 1010.7220514358573, 1014.2393205096178, 746.9215732348134, 761.2425636491727, 761.6724808332415, 763.412172627074, 764.9120351159632, 15444.150571718552, 15455.149966751824, 15515.224238788016, 15516.767248491282, 15532.378704851792, 13091.41088651013, 13231.603051908362, 13382.598522044354, 13385.933070334586, 13547.661308467268, 10040.096391324743, 10267.537960791782, 10354.430506322149, 10374.325668831501, 10390.27268091234, 3043.4978228592254, 3415.64135765746, 3510.596281427643, 3550.680438760524, 3580.0333909844458, 80571.0, 81474.59262703708, 85795.0, 86243.70634440488, 88052.55973720155, 9502.429854208769, 9843.0, 9849.409035457895, 9919.950400247953, 9963.501824908726, 23992.28023159308, 24052.759472405403, 24065.63901541478, 24081.879590601933, 24099.397515062265, 6570.8028759137305, 7827.217278272127, 7839.568823714751, 7872.370210383156, 8048.59757012147, 3897.902552436155, 4066.2883995300704, 4122.464079669624, 4123.278426275389, 4155.729877558009, 3856.325143099946, 3896.6687831534637, 3901.804909754501, 3905.3556163233316, 3909.6285852843935, 675.9763408280785, 679.0255982664892, 688.2085601558248, 702.7364738223166, 708.1148564294632, 540.5675459632279, 557.6681874284794, 558.4052983572483, 595.675356930474, 615.3692465223182, 8364.707235246737, 8474.110218426977, 8477.915220847835, 8602.483850968962, 8639.784005399915, 507.9282713474566, 563.3633993587221, 596.9492593129632, 604.3835288006297, 617.949485874016, 3868.9806550967064, 3924.8822535323984, 3980.442738016622, 4116.670666346685, 4127.133302006552, 103002.45496317561, 103846.96153038523, 104282.47858760657, 104780.42829357566, 105648.47175764071, 82828.0, 83021.58489207637, 83471.0, 84935.0, 88127.0, 63577.36422635807, 77994.2200577987, 79395.0, 79902.80631758917, 79929.60035199903, 7944.6822127114265, 8059.113497515152, 8079.555624440713, 8137.593120344078, 8211.71259005932, 51248.23127653014, 52029.7398513005, 52173.478265216865, 52781.7360913193, 55943.0, 75508.0, 76053.0, 76363.47273054397, 77012.61493692496, 77030.61484692765, 9431.717048488556, 10984.491899123088, 11091.5563377464, 11319.09447244235, 11565.0, 11948.283103013848, 11962.162648614514, 12286.078544109048, 12314.876851231373, 12654.936725316682, 9696.563654635418, 11607.303561785982, 12050.156489046034, 12099.57651482194, 12271.509139634314, 11553.711157221136, 11567.826482602935, 11851.407429628656, 11902.821457677968, 11954.222975506564, 8751.977403949257, 11236.325820450798, 11849.933505984503, 11948.223365481215, 11955.462004209658, 8436.620352084294, 9264.768380790534, 9564.330496865152, 9766.169875560658, 9772.169365603719, 6666.533342665967, 8279.254867061993, 8911.2425443838, 9202.815943681222, 9624.422534647943], "unit": "score", "name": "yui.html", "value": 7122.283888952359}], "name": "dromaeo_css", "value": 7776.62022265588}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 114.0, 114.0, 115.0, 136.0, 168.0, 164.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 126.4}, {"lowerIsBetter": true, "replicates": [152.0, 121.0, 163.0, 185.0, 152.0, 140.0, 117.0, 154.0, 183.0, 154.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [195.0, 191.0, 198.0, 202.0, 196.0, 197.0, 193.0, 195.0, 196.0, 200.0], "unit": "score", "name": "audio-dft", "value": 196.3}, {"lowerIsBetter": true, "replicates": [65.0, 76.0, 70.0, 112.0, 55.0, 56.0, 61.0, 64.0, 128.0, 58.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 119.0, 80.0, 83.0, 85.0, 120.0, 80.0, 81.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [134.0, 123.0, 90.0, 88.0, 89.0, 87.0, 90.0, 88.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 93.0, 95.0, 103.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [90.0, 92.0, 90.0, 92.0, 91.0, 91.0, 97.0, 144.0, 137.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 101.3}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 62.0, 55.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [64.0, 69.0, 66.0, 72.0, 76.0, 95.0, 61.0, 84.0, 97.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.3}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 82.0, 84.0, 82.0, 83.0, 84.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [103.0, 132.0, 114.0, 133.0, 130.0, 120.0, 131.0, 131.0, 162.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [124.0, 136.0, 140.0, 133.0, 135.0, 136.0, 137.0, 140.0, 134.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 67.0, 65.0, 68.0, 64.0, 65.0, 71.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1486.0999999999997}]} 07:11:13 INFO - Return code: 0 07:11:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:13 ERROR - # TBPL SUCCESS # 07:11:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:13 INFO - 2016-04-23 07:11:13.271 screenresolution[2326:21405] starting screenresolution argv=screenresolution get 07:11:13 INFO - 2016-04-23 07:11:13.273 screenresolution[2326:21405] Display 0: 1600x1200x32@60 07:11:13 INFO - 2016-04-23 07:11:13.279 screenresolution[2327:21408] starting screenresolution argv=screenresolution list 07:11:13 INFO - Available Modes on Display 0 07:11:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:13 INFO - Intel Iris: 07:11:13 INFO - Chipset Model: Intel Iris 07:11:13 INFO - Type: GPU 07:11:13 INFO - Bus: Built-In 07:11:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:13 INFO - Vendor: Intel (0x8086) 07:11:13 INFO - Device ID: 0x0a2e 07:11:13 INFO - Revision ID: 0x0009 07:11:13 INFO - Displays: 07:11:13 INFO - Display: 07:11:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:13 INFO - Display Serial Number: 1600x1200 60 07:11:13 INFO - Main Display: Yes 07:11:13 INFO - Mirror: Off 07:11:13 INFO - Online: Yes 07:11:13 INFO - Rotation: Supported 07:11:13 INFO - Return code: 0 07:11:13 INFO - Running post-action listener: _resource_record_post_action 07:11:13 INFO - Running post-run listener: _resource_record_post_run 07:11:14 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 94208; Write bytes: 664136192; Read time: 1; Write time: 1969 07:11:14 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356944384; Write bytes: 354872320; Read time: 27948; Write time: 664 07:11:14 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 94208; Write bytes: 298085888; Read time: 1; Write time: 1270 07:11:14 INFO - Running post-run listener: _upload_blobber_files 07:11:14 INFO - Blob upload gear active. 07:11:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:11:14 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'] 07:11:14 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 07:11:14 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:15 INFO - (blobuploader) - INFO - Done attempting. 07:11:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:11:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:16 INFO - (blobuploader) - INFO - Done attempting. 07:11:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:16 INFO - Return code: 0 07:11:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b90f1d2eb277527c165a058ee8bec0396682d8ef0355ae92b5548de661b515bd7cb9c399eb45a57753dd8cea65ce3fab499a2ee89048780fc24888a0d61b40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/506fe32df96f7e2e1559cc756fe85858ee17ce3439c15574b7a7e2510d85b89a4ed8252136869de2c53967582a7c9cb9a97352ae5b7a3b1a76ee385b866c7a2b"} 07:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:16 INFO - Contents: 07:11:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b90f1d2eb277527c165a058ee8bec0396682d8ef0355ae92b5548de661b515bd7cb9c399eb45a57753dd8cea65ce3fab499a2ee89048780fc24888a0d61b40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/506fe32df96f7e2e1559cc756fe85858ee17ce3439c15574b7a7e2510d85b89a4ed8252136869de2c53967582a7c9cb9a97352ae5b7a3b1a76ee385b866c7a2b"} 07:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:16 INFO - Copying logs to upload dir... 07:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.003488 ========= master_lag: 37.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-04-23 07:11:54.624008) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-23 07:11:54.628662) ========= 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.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b90f1d2eb277527c165a058ee8bec0396682d8ef0355ae92b5548de661b515bd7cb9c399eb45a57753dd8cea65ce3fab499a2ee89048780fc24888a0d61b40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/506fe32df96f7e2e1559cc756fe85858ee17ce3439c15574b7a7e2510d85b89a4ed8252136869de2c53967582a7c9cb9a97352ae5b7a3b1a76ee385b866c7a2b"} build_url:https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010957 build_url: 'https://queue.taskcluster.net/v1/task/cmDX6eWIT2ikma9FAfdOPw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4b90f1d2eb277527c165a058ee8bec0396682d8ef0355ae92b5548de661b515bd7cb9c399eb45a57753dd8cea65ce3fab499a2ee89048780fc24888a0d61b40", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/506fe32df96f7e2e1559cc756fe85858ee17ce3439c15574b7a7e2510d85b89a4ed8252136869de2c53967582a7c9cb9a97352ae5b7a3b1a76ee385b866c7a2b"}' ========= master_lag: 11.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-23 07:12:06.267087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-23 07:12:06.270114) ========= 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.AAersr0PUW/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.VRwfkHxS2s/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.005252 ========= master_lag: 6.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-04-23 07:12:12.884133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:12:12.884477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 07:12:13.379127) ========= ========= Total master_lag: 56.21 =========