builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0069 starttime: 1460373208.41 results: success (0) buildid: 20160411022415 builduid: dd22064a08e542d3bf35dbd241cd27d7 revision: f76dce9226157f99a2bf015167a58cc609e9b6a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.408668) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.409069) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.409350) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005882 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.435377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.435647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.453399) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.453657) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.005044 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.501259) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.501522) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.501849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.502116) ========= 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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-11 04:13:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-04-11 04:13:28 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.687448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.687750) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.026066 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:28.736304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 04:13:28.736651) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f76dce9226157f99a2bf015167a58cc609e9b6a9 --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 f76dce9226157f99a2bf015167a58cc609e9b6a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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-11 04:13:28,817 truncating revision to first 12 chars 2016-04-11 04:13:28,817 Setting DEBUG logging. 2016-04-11 04:13:28,817 attempt 1/10 2016-04-11 04:13:28,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f76dce922615?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 04:13:29,830 unpacking tar archive at: mozilla-aurora-f76dce922615/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264462 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 04:13:30.017278) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:30.017626) ========= echo f76dce9226157f99a2bf015167a58cc609e9b6a9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f76dce9226157f99a2bf015167a58cc609e9b6a9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 f76dce9226157f99a2bf015167a58cc609e9b6a9 program finished with exit code 0 elapsedTime=0.005286 script_repo_revision: 'f76dce9226157f99a2bf015167a58cc609e9b6a9' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:30.066375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:30.066680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 04:13:30.082434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-11 04:13:30.082743) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:13:30 INFO - MultiFileLogger online at 20160411 04:13:30 in /builds/slave/test 04:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:30 INFO - {'append_to_log': False, 04:13:30 INFO - 'base_work_dir': '/builds/slave/test', 04:13:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:30 INFO - 'branch': 'Mozilla-Aurora', 04:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:30 INFO - 'config_files': ('talos/mac_config.py',), 04:13:30 INFO - 'default_actions': ('clobber', 04:13:30 INFO - 'read-buildbot-config', 04:13:30 INFO - 'download-and-extract', 04:13:30 INFO - 'populate-webroot', 04:13:30 INFO - 'create-virtualenv', 04:13:30 INFO - 'install', 04:13:30 INFO - 'run-tests'), 04:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:30 INFO - 'download_minidump_stackwalk': True, 04:13:30 INFO - 'download_symbols': 'ondemand', 04:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:30 INFO - 'installer_path': 'installer.exe', 04:13:30 INFO - 'log_level': 'info', 04:13:30 INFO - 'log_name': 'talos', 04:13:30 INFO - 'log_to_console': True, 04:13:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:13:30 INFO - 'opt_config_files': (), 04:13:30 INFO - 'pip_index': False, 04:13:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:30 INFO - 'cmd': ('bash', 04:13:30 INFO - '-c', 04:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:30 INFO - 'enabled': True, 04:13:30 INFO - 'halt_on_failure': False, 04:13:30 INFO - 'name': 'check_screen_resolution'},), 04:13:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:30 INFO - 'cmd': ('bash', 04:13:30 INFO - '-c', 04:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:30 INFO - 'enabled': True, 04:13:30 INFO - 'halt_on_failure': False, 04:13:30 INFO - 'name': 'check_screen_resolution'},), 04:13:30 INFO - 'run_cmd_checks_enabled': True, 04:13:30 INFO - 'sps_profile': False, 04:13:30 INFO - 'sps_profile_interval': 0, 04:13:30 INFO - 'suite': 'dromaeojs', 04:13:30 INFO - 'system_bits': '32', 04:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:30 INFO - 'title': 't-yosemite-r7-0069', 04:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:30 INFO - 'use_talos_json': True, 04:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:30 INFO - 'work_dir': 'build'} 04:13:30 INFO - ##### 04:13:30 INFO - ##### Running clobber step. 04:13:30 INFO - ##### 04:13:30 INFO - Running pre-action listener: _resource_record_pre_action 04:13:30 INFO - Running main action method: clobber 04:13:30 INFO - rmtree: /builds/slave/test/build 04:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - ##### 04:13:31 INFO - ##### Running read-buildbot-config step. 04:13:31 INFO - ##### 04:13:31 INFO - Running pre-action listener: _resource_record_pre_action 04:13:31 INFO - Running main action method: read_buildbot_config 04:13:31 INFO - Using buildbot properties: 04:13:31 INFO - { 04:13:31 INFO - "project": "", 04:13:31 INFO - "product": "firefox", 04:13:31 INFO - "script_repo_revision": "production", 04:13:31 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:13:31 INFO - "repository": "", 04:13:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:13:31 INFO - "buildid": "20160411022415", 04:13:31 INFO - "pgo_build": "False", 04:13:31 INFO - "basedir": "/builds/slave/test", 04:13:31 INFO - "buildnumber": 270, 04:13:31 INFO - "slavename": "t-yosemite-r7-0069", 04:13:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:13:31 INFO - "platform": "yosemite_r7", 04:13:31 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:13:31 INFO - "branch": "mozilla-aurora", 04:13:31 INFO - "repo_path": "releases/mozilla-aurora", 04:13:31 INFO - "revision": "f76dce9226157f99a2bf015167a58cc609e9b6a9", 04:13:31 INFO - "stage_platform": "macosx64", 04:13:31 INFO - "builduid": "dd22064a08e542d3bf35dbd241cd27d7", 04:13:31 INFO - "slavebuilddir": "test" 04:13:31 INFO - } 04:13:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - ##### 04:13:31 INFO - ##### Running download-and-extract step. 04:13:31 INFO - ##### 04:13:31 INFO - Running pre-action listener: _resource_record_pre_action 04:13:31 INFO - Running main action method: download_and_extract 04:13:31 INFO - mkdir: /builds/slave/test/build/tests 04:13:31 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')]} 04:13:31 INFO - https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:32 INFO - Downloaded 1277 bytes. 04:13:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 04:13:32 INFO - Using the following test package requirements: 04:13:32 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:13:32 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 04:13:32 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 04:13:32 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'jsshell-mac.zip'], 04:13:32 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 04:13:32 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:13:32 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 04:13:32 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 04:13:32 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 04:13:32 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:13:32 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:13:32 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 04:13:32 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:32 INFO - https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:34 INFO - Downloaded 17908650 bytes. 04:13:34 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'] 04:13:34 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 04:13:37 INFO - Return code: 0 04:13:37 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 04:13:37 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')]} 04:13:37 INFO - https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:38 INFO - Downloaded 17908650 bytes. 04:13:38 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'] 04:13:38 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 04:13:41 INFO - Return code: 0 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:42 INFO - Downloaded 10845168 bytes. 04:13:42 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'] 04:13:42 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 04:13:43 INFO - Return code: 0 04:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:43 INFO - https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 04:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CxKRMMauRICGxlACJLOLpw/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 04:13:48 INFO - Downloaded 115195465 bytes. 04:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:13:48 INFO - mkdir: /builds/slave/test/properties 04:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:48 INFO - Contents: 04:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:13:50 INFO - Running post-action listener: _resource_record_post_action 04:13:50 INFO - Running post-action listener: set_extra_try_arguments 04:13:50 INFO - ##### 04:13:50 INFO - ##### Running populate-webroot step. 04:13:50 INFO - ##### 04:13:50 INFO - Running pre-action listener: _resource_record_pre_action 04:13:50 INFO - Running main action method: populate_webroot 04:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:50 INFO - '--tppagecycles', 04:13:50 INFO - '7'], 04:13:50 INFO - 'tests': ['tsvgm']}}, 04:13:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:13:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'tests': ['damp', 'tps']}, 04:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['damp', 'tps']}, 04:13:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:50 INFO - 'other': {'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'other_l64': {'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:50 INFO - 'ts_paint', 04:13:50 INFO - 'tpaint', 04:13:50 INFO - 'sessionrestore', 04:13:50 INFO - 'sessionrestore_no_auto_restore', 04:13:50 INFO - 'tabpaint']}, 04:13:50 INFO - 'svgr': {'tests': ['tsvgx', 04:13:50 INFO - 'tsvgr_opacity', 04:13:50 INFO - 'tart', 04:13:50 INFO - 'tscrollx', 04:13:50 INFO - 'cart']}, 04:13:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['tsvgx', 04:13:50 INFO - 'tsvgr_opacity', 04:13:50 INFO - 'tart', 04:13:50 INFO - 'tscrollx', 04:13:50 INFO - 'cart']}, 04:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'tests': ['tp5o']}, 04:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'talos_options': ['--e10s'], 04:13:50 INFO - 'tests': ['tp5o']}, 04:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'talos_options': ['--xperf_path', 04:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:50 INFO - 'tests': ['tp5n']}, 04:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:50 INFO - 'talos_options': ['--e10s', 04:13:50 INFO - '--xperf_path', 04:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:50 INFO - 'tests': ['tp5n']}}, 04:13:50 INFO - 'talos.zip': {'path': '', 04:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:50 INFO - Running post-action listener: _resource_record_post_action 04:13:50 INFO - ##### 04:13:50 INFO - ##### Running create-virtualenv step. 04:13:50 INFO - ##### 04:13:50 INFO - Running pre-action listener: _resource_record_pre_action 04:13:50 INFO - Running main action method: create_virtualenv 04:13:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:50 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 04:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:50 INFO - Using real prefix '/tools/python27' 04:13:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:54 INFO - Installing pip.................done. 04:13:54 INFO - Return code: 0 04:13:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:54 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')]} 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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')]} 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:13:54 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 04:13:54 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 04:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:54 INFO - 'HOME': '/Users/cltbld', 04:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:54 INFO - 'LOGNAME': 'cltbld', 04:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:54 INFO - 'MOZ_NO_REMOTE': '1', 04:13:54 INFO - 'NO_EM_RESTART': '1', 04:13:54 INFO - 'PAGER': '/bin/cat', 04:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:54 INFO - 'PWD': '/builds/slave/test', 04:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:54 INFO - 'SHELL': '/bin/bash', 04:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:13:54 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:54 INFO - 'USER': 'cltbld', 04:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:54 INFO - 'XPC_FLAGS': '0x0', 04:13:54 INFO - 'XPC_SERVICE_NAME': '0', 04:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 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 04:13:54 INFO - Cleaning up... 04:13:54 INFO - Return code: 0 04:13:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:54 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')]} 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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')]} 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:54 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:13:54 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 04:13:54 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 04:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:54 INFO - 'HOME': '/Users/cltbld', 04:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:54 INFO - 'LOGNAME': 'cltbld', 04:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:54 INFO - 'MOZ_NO_REMOTE': '1', 04:13:54 INFO - 'NO_EM_RESTART': '1', 04:13:54 INFO - 'PAGER': '/bin/cat', 04:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:54 INFO - 'PWD': '/builds/slave/test', 04:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:54 INFO - 'SHELL': '/bin/bash', 04:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:13:54 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:54 INFO - 'USER': 'cltbld', 04:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:54 INFO - 'XPC_FLAGS': '0x0', 04:13:54 INFO - 'XPC_SERVICE_NAME': '0', 04:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:54 INFO - Downloading/unpacking psutil>=0.7.1 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:57 INFO - Installing collected packages: psutil 04:13:57 INFO - Running setup.py install for psutil 04:13:57 INFO - building 'psutil._psutil_osx' extension 04:13:57 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 04:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:13:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:13:58 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 04:13:58 INFO - building 'psutil._psutil_posix' extension 04:13:58 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 04:13:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:13:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:13:58 INFO - ^ 04:13:58 INFO - 1 warning generated. 04:13:58 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 04:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:58 INFO - Successfully installed psutil 04:13:58 INFO - Cleaning up... 04:13:58 INFO - Return code: 0 04:13:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:58 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')]} 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:58 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')]} 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:58 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:13:58 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 04:13:58 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 04:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:58 INFO - 'HOME': '/Users/cltbld', 04:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:58 INFO - 'LOGNAME': 'cltbld', 04:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:58 INFO - 'MOZ_NO_REMOTE': '1', 04:13:58 INFO - 'NO_EM_RESTART': '1', 04:13:58 INFO - 'PAGER': '/bin/cat', 04:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:58 INFO - 'PWD': '/builds/slave/test', 04:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:58 INFO - 'SHELL': '/bin/bash', 04:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:13:58 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:58 INFO - 'USER': 'cltbld', 04:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:58 INFO - 'XPC_FLAGS': '0x0', 04:13:58 INFO - 'XPC_SERVICE_NAME': '0', 04:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:01 INFO - Installing collected packages: mozsystemmonitor 04:14:01 INFO - Running setup.py install for mozsystemmonitor 04:14:01 INFO - Successfully installed mozsystemmonitor 04:14:01 INFO - Cleaning up... 04:14:01 INFO - Return code: 0 04:14:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:01 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 04:14:01 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 04:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:01 INFO - 'HOME': '/Users/cltbld', 04:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:01 INFO - 'LOGNAME': 'cltbld', 04:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:01 INFO - 'MOZ_NO_REMOTE': '1', 04:14:01 INFO - 'NO_EM_RESTART': '1', 04:14:01 INFO - 'PAGER': '/bin/cat', 04:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:01 INFO - 'PWD': '/builds/slave/test', 04:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:01 INFO - 'SHELL': '/bin/bash', 04:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:01 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:01 INFO - 'USER': 'cltbld', 04:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:01 INFO - 'XPC_FLAGS': '0x0', 04:14:01 INFO - 'XPC_SERVICE_NAME': '0', 04:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - Downloading docopt-0.6.1.tar.gz 04:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:05 INFO - Running setup.py install for blobuploader 04:14:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:05 INFO - Running setup.py install for requests 04:14:06 INFO - Running setup.py install for docopt 04:14:06 INFO - Successfully installed blobuploader requests docopt 04:14:06 INFO - Cleaning up... 04:14:06 INFO - Return code: 0 04:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:06 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:06 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 04:14:06 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 04:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:06 INFO - 'HOME': '/Users/cltbld', 04:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:06 INFO - 'LOGNAME': 'cltbld', 04:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:06 INFO - 'MOZ_NO_REMOTE': '1', 04:14:06 INFO - 'NO_EM_RESTART': '1', 04:14:06 INFO - 'PAGER': '/bin/cat', 04:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:06 INFO - 'PWD': '/builds/slave/test', 04:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:06 INFO - 'SHELL': '/bin/bash', 04:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:06 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:06 INFO - 'USER': 'cltbld', 04:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:06 INFO - 'XPC_FLAGS': '0x0', 04:14:06 INFO - 'XPC_SERVICE_NAME': '0', 04:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-LCXasS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:06 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-qkM2uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-eu_UiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-wBh6y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-qM52vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-i6Tu8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Q4Kd8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-TONCEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-EGM6Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-cm_da9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-B3Qp3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:07 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-Tf1ij3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:08 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-xe8k8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:08 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-puLen9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:08 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-itgBKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:08 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-E38mZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:08 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-NTBo4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:08 INFO - Running setup.py install for manifestparser 04:14:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for mozcrash 04:14:08 INFO - Running setup.py install for mozdebug 04:14:09 INFO - Running setup.py install for mozdevice 04:14:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozfile 04:14:09 INFO - Running setup.py install for mozhttpd 04:14:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozinfo 04:14:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozInstall 04:14:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:09 INFO - Running setup.py install for mozleak 04:14:09 INFO - Running setup.py install for mozlog 04:14:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for moznetwork 04:14:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozprocess 04:14:10 INFO - Running setup.py install for mozprofile 04:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozrunner 04:14:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:10 INFO - Running setup.py install for mozscreenshot 04:14:10 INFO - Running setup.py install for moztest 04:14:11 INFO - Running setup.py install for mozversion 04:14:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:11 INFO - Cleaning up... 04:14:11 INFO - Return code: 0 04:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:11 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')]} 04:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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')]} 04:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:11 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 04:14:11 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 04:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:11 INFO - 'HOME': '/Users/cltbld', 04:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:11 INFO - 'LOGNAME': 'cltbld', 04:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:11 INFO - 'MOZ_NO_REMOTE': '1', 04:14:11 INFO - 'NO_EM_RESTART': '1', 04:14:11 INFO - 'PAGER': '/bin/cat', 04:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:11 INFO - 'PWD': '/builds/slave/test', 04:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:11 INFO - 'SHELL': '/bin/bash', 04:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:11 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:11 INFO - 'USER': 'cltbld', 04:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:11 INFO - 'XPC_FLAGS': '0x0', 04:14:11 INFO - 'XPC_SERVICE_NAME': '0', 04:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-vKydMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-PH_eTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-r0tkQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-91MBof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:11 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)) 04:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:11 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-TBirgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-7tVTNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-27AY3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-geqFLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-LgJ1CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-ADRrBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-iFfdUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-MWqUcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-bzlfAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-FyH762-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:12 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)) 04:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:12 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-BxbF5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:13 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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:13 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-FeAbeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:13 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)) 04:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:13 INFO - Running setup.py (path:/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/pip-v5fFIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:13 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)) 04:14:13 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)) 04:14:13 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)) 04:14:13 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)) 04:14:13 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)) 04:14:13 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)) 04:14:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:13 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 04:14:13 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 04:14:13 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 04:14:13 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 04:14:13 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 04:14:13 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 04:14:15 INFO - Downloading blessings-1.6.tar.gz 04:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:15 INFO - Installing collected packages: blessings 04:14:15 INFO - Running setup.py install for blessings 04:14:15 INFO - Successfully installed blessings 04:14:15 INFO - Cleaning up... 04:14:16 INFO - Return code: 0 04:14:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:16 INFO - Reading from file tmpfile_stdout 04:14:16 INFO - Current package versions: 04:14:16 INFO - blessings == 1.6 04:14:16 INFO - blobuploader == 1.2.4 04:14:16 INFO - docopt == 0.6.1 04:14:16 INFO - manifestparser == 1.1 04:14:16 INFO - mozInstall == 1.12 04:14:16 INFO - mozcrash == 0.17 04:14:16 INFO - mozdebug == 0.1 04:14:16 INFO - mozdevice == 0.48 04:14:16 INFO - mozfile == 1.2 04:14:16 INFO - mozhttpd == 0.7 04:14:16 INFO - mozinfo == 0.9 04:14:16 INFO - mozleak == 0.1 04:14:16 INFO - mozlog == 3.1 04:14:16 INFO - moznetwork == 0.27 04:14:16 INFO - mozprocess == 0.22 04:14:16 INFO - mozprofile == 0.28 04:14:16 INFO - mozrunner == 6.11 04:14:16 INFO - mozscreenshot == 0.1 04:14:16 INFO - mozsystemmonitor == 0.0 04:14:16 INFO - moztest == 0.7 04:14:16 INFO - mozversion == 1.4 04:14:16 INFO - psutil == 3.1.1 04:14:16 INFO - requests == 1.2.3 04:14:16 INFO - wsgiref == 0.1.2 04:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:16 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:16 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 04:14:16 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 04:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:16 INFO - 'HOME': '/Users/cltbld', 04:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:16 INFO - 'LOGNAME': 'cltbld', 04:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:16 INFO - 'MOZ_NO_REMOTE': '1', 04:14:16 INFO - 'NO_EM_RESTART': '1', 04:14:16 INFO - 'PAGER': '/bin/cat', 04:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:16 INFO - 'PWD': '/builds/slave/test', 04:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:16 INFO - 'SHELL': '/bin/bash', 04:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:16 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:16 INFO - 'USER': 'cltbld', 04:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:16 INFO - 'XPC_FLAGS': '0x0', 04:14:16 INFO - 'XPC_SERVICE_NAME': '0', 04:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 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)) 04:14:16 INFO - Cleaning up... 04:14:16 INFO - Return code: 0 04:14:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:16 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:16 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 04:14:16 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 04:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:16 INFO - 'HOME': '/Users/cltbld', 04:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:16 INFO - 'LOGNAME': 'cltbld', 04:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:16 INFO - 'MOZ_NO_REMOTE': '1', 04:14:16 INFO - 'NO_EM_RESTART': '1', 04:14:16 INFO - 'PAGER': '/bin/cat', 04:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:16 INFO - 'PWD': '/builds/slave/test', 04:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:16 INFO - 'SHELL': '/bin/bash', 04:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:16 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:16 INFO - 'USER': 'cltbld', 04:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:16 INFO - 'XPC_FLAGS': '0x0', 04:14:16 INFO - 'XPC_SERVICE_NAME': '0', 04:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:16 INFO - Downloading/unpacking jsonschema 04:14:16 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 04:14:16 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 04:14:16 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 04:14:16 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 04:14:16 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 04:14:16 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 04:14:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:19 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 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 04:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:19 INFO - warning: no files found matching '*.txt' 04:14:19 INFO - no previously-included directories found matching 'build' 04:14:19 INFO - no previously-included directories found matching 'dist' 04:14:19 INFO - no previously-included directories found matching '.git*' 04:14:19 INFO - Installing collected packages: jsonschema, functools32 04:14:20 INFO - Running setup.py install for functools32 04:14:20 INFO - warning: no files found matching '*.txt' 04:14:20 INFO - no previously-included directories found matching 'build' 04:14:20 INFO - no previously-included directories found matching 'dist' 04:14:20 INFO - no previously-included directories found matching '.git*' 04:14:20 INFO - Successfully installed jsonschema functools32 04:14:20 INFO - Cleaning up... 04:14:20 INFO - Return code: 0 04:14:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:20 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')]} 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:21 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')]} 04:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:21 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 0x109acda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109ad44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8749d85410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, '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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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 04:14:21 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 04:14:21 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 04:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:21 INFO - 'HOME': '/Users/cltbld', 04:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:21 INFO - 'LOGNAME': 'cltbld', 04:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:21 INFO - 'MOZ_NO_REMOTE': '1', 04:14:21 INFO - 'NO_EM_RESTART': '1', 04:14:21 INFO - 'PAGER': '/bin/cat', 04:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:21 INFO - 'PWD': '/builds/slave/test', 04:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:21 INFO - 'SHELL': '/bin/bash', 04:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:21 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:21 INFO - 'USER': 'cltbld', 04:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:21 INFO - 'XPC_FLAGS': '0x0', 04:14:21 INFO - 'XPC_SERVICE_NAME': '0', 04:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:21 INFO - Downloading/unpacking flake8 04:14:21 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 04:14:21 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 04:14:21 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 04:14:21 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 04:14:21 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 04:14:21 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 04:14:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:24 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 04:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:25 INFO - no previously-included directories found matching 'docs/_build' 04:14:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:25 INFO - Running setup.py install for pep8 04:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:25 INFO - no previously-included directories found matching 'docs/_build' 04:14:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:25 INFO - Cleaning up... 04:14:25 INFO - Return code: 0 04:14:25 INFO - Running post-action listener: _resource_record_post_action 04:14:25 INFO - Running post-action listener: _start_resource_monitoring 04:14:25 INFO - Starting resource monitoring. 04:14:25 INFO - ##### 04:14:25 INFO - ##### Running install step. 04:14:25 INFO - ##### 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: install 04:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:26 INFO - Reading from file tmpfile_stdout 04:14:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:26 INFO - Reading from file tmpfile_stdout 04:14:26 INFO - Output received: 04:14:26 INFO - Usage: mozinstall [options] installer 04:14:26 INFO - Options: 04:14:26 INFO - -h, --help show this help message and exit 04:14:26 INFO - -d DEST, --destination=DEST 04:14:26 INFO - Directory to install application into. [default: 04:14:26 INFO - "/builds/slave/test"] 04:14:26 INFO - --app=APP Application being installed. [default: firefox] 04:14:26 INFO - mkdir: /builds/slave/test/build/application 04:14:26 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'] 04:14:26 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 04:14:58 INFO - Reading from file tmpfile_stdout 04:14:58 INFO - Output received: 04:14:58 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:14:58 INFO - Running post-action listener: _resource_record_post_action 04:14:58 INFO - ##### 04:14:58 INFO - ##### Running run-tests step. 04:14:58 INFO - ##### 04:14:58 INFO - Running pre-action listener: _resource_record_pre_action 04:14:58 INFO - Running main action method: run_tests 04:14:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:14:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:14:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:14:58 INFO - 2016-04-11 04:14:58.368 screenresolution[1641:7428] starting screenresolution argv=screenresolution get 04:14:58 INFO - 2016-04-11 04:14:58.371 screenresolution[1641:7428] Display 0: 1600x1200x32@60 04:14:58 INFO - 2016-04-11 04:14:58.377 screenresolution[1642:7430] starting screenresolution argv=screenresolution list 04:14:58 INFO - Available Modes on Display 0 04:14:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:14:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:14:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:14:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:14:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:14:58 INFO - Intel Iris: 04:14:58 INFO - Chipset Model: Intel Iris 04:14:58 INFO - Type: GPU 04:14:58 INFO - Bus: Built-In 04:14:58 INFO - VRAM (Dynamic, Max): 1536 MB 04:14:58 INFO - Vendor: Intel (0x8086) 04:14:58 INFO - Device ID: 0x0a2e 04:14:58 INFO - Revision ID: 0x0009 04:14:58 INFO - Displays: 04:14:58 INFO - Display: 04:14:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:14:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:14:58 INFO - Display Serial Number: 1600x1200 60 04:14:58 INFO - Main Display: Yes 04:14:58 INFO - Mirror: Off 04:14:58 INFO - Online: Yes 04:14:58 INFO - Rotation: Supported 04:14:58 INFO - Return code: 0 04:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:58 INFO - Python 2.7.3 04:14:58 INFO - Return code: 0 04:14:58 INFO - grabbing minidump binary from tooltool 04:14:58 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')]} 04:14:58 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 0x109971d30>, '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 0x1097d5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109968b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:58 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 04:14:58 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 04:14:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:58 INFO - Return code: 0 04:14:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:14:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:14:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:59 INFO - Return code: 0 04:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yaKGdJgfZJ/Render', 04:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:59 INFO - 'HOME': '/Users/cltbld', 04:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:59 INFO - 'LOGNAME': 'cltbld', 04:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:59 INFO - 'MOZ_NO_REMOTE': '1', 04:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:59 INFO - 'NO_EM_RESTART': '1', 04:14:59 INFO - 'PAGER': '/bin/cat', 04:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:59 INFO - 'PWD': '/builds/slave/test', 04:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:59 INFO - 'SHELL': '/bin/bash', 04:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8Wb8Dar86n/Listeners', 04:14:59 INFO - 'TMPDIR': '/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/', 04:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:59 INFO - 'USER': 'cltbld', 04:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:59 INFO - 'XPC_FLAGS': '0x0', 04:14:59 INFO - 'XPC_SERVICE_NAME': '0', 04:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:15:00 INFO - mozversion application_buildid: 20160411022415 04:15:00 INFO - mozversion application_changeset: f76dce9226157f99a2bf015167a58cc609e9b6a9 04:15:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:15:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:00 INFO - mozversion application_name: Firefox 04:15:00 INFO - mozversion application_remotingname: firefox-dev 04:15:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:15:00 INFO - mozversion application_vendor: Mozilla 04:15:00 INFO - mozversion application_version: 47.0a2 04:15:00 INFO - mozversion platform_buildid: 20160411022415 04:15:00 INFO - mozversion platform_changeset: f76dce9226157f99a2bf015167a58cc609e9b6a9 04:15:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:15:00 INFO - mozversion platform_version: 47.0a2 04:15:00 INFO - using testdate: 1460373300 04:15:00 INFO - actual date: 1460373300 04:15:00 INFO - starting webserver on 'localhost:49275' 04:15:00 INFO - SUITE-START | Running 2 tests 04:15:00 INFO - TEST-START | dromaeo_css 04:15:00 INFO - operating with platform_type : mac_ 04:15:00 INFO - Initialising browser for dromaeo_css test... 04:15:00 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpuW4Q9D/profile http://localhost:49275/getInfo.html) 04:15:02 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 04:15:02 INFO - PROCESS | 1660 | colorDepth:24 04:15:02 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 04:15:02 INFO - PROCESS | 1660 | __metrics 04:15:02 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:15:02 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:03 INFO - TEST-INFO | 1660: exit 0 04:15:03 INFO - Browser initialized. 04:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:03 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmpuW4Q9D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:14 INFO - PROCESS | 1662 | RSS: Main: 207503360 04:15:14 INFO - PROCESS | 1662 | 04:16:06 INFO - PROCESS | 1662 | 1460373366304 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] 04:18:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:18:17 INFO - PROCESS | 1662 | RSS: Main: 317759488 04:18:17 INFO - PROCESS | 1662 | 04:21:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:21:20 INFO - PROCESS | 1662 | RSS: Main: 335204352 04:21:20 INFO - PROCESS | 1662 | 04:24:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:24:23 INFO - PROCESS | 1662 | RSS: Main: 345980928 04:24:23 INFO - PROCESS | 1662 | 04:27:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:27:25 INFO - PROCESS | 1662 | RSS: Main: 302968832 04:27:25 INFO - PROCESS | 1662 | 04:30:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:30:29 INFO - PROCESS | 1662 | RSS: Main: 303939584 04:30:29 INFO - PROCESS | 1662 | 04:33:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:33:32 INFO - PROCESS | 1662 | RSS: Main: 349265920 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | __start_tp_report 04:33:32 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:33:32 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:33:32 INFO - PROCESS | 1662 | |i|pagename|runs| 04:33:32 INFO - PROCESS | 1662 | |0;dojo.html;3468.716574867299;3533.328667553165;3544.273423948091;3570.785752854829;3621.4567814827788;5832.883342333151;5841.153032810245;5843.5617328700355;5855.151003104547;5858.062709966406;5799.623024503415;5815.244018277628;5818.534517238621;5836.795712150076;5849.239598852154;5177.378714554259;5215.348081489804;5240.318758561381;5242.370915490146;5287.709175995319;5355.758990845402;5367.087595108841;5367.329083864517;5381.461853814626;5385.838424847261;5219.895602087956;5241.528262456378;5282.709450980195;5285.6300058995885;5302;5152.793888244466;5277.1556550951855;5296.947030529723;5307.310049693534;5347.25138480613;4561.7262964222255;5165;5198.6880787152895;5244.816431424882;5281.155015197588;5694.032014557493;5696.601237913348;5731.541476681856;5740.397258287903;5773.826785196451;6152.446279834791;6265.5614107012525;6316.115743795872;6329.3354197809485;6335.8732825343695;5279.894402111975;6256.562040657156;6284.685765711742;6360.840978975516;6367.458766004896;5824.912626310609;5877.265341832271;5896.793612223594;5900.203472531153;5904.616199947032;6263.467605253604;6304.338044505261;6377.3303803100935;6386.521010924106;6414.486841052798;6260.217472815898;6282.277538083087;6299.464545513591;6312.905306420407;6325.335839736854;6316;6340.714667839959;6365.2998170201245;6375.840603984938;6381.266154392211;6073.665948372882;6222.968885155636;6247.687615619292;6317.652529110851;6329.905051424233;6318.6524741138755;6345.746170153235;6348.555601107971;6348.587341822767;6355.269144048493;4913.385826771653;4933.629977751683;4962.8511144665;4965.726885021359;4975.601951843843;4395.208862404734;4407.779611019436;4482.641388688897;4485.596296333346;4498.820047198141;5866.70666466675;5875.177475153482;5889.528837692974;5893.410658934073;5926.407359264125;6297.4962003039645;6302.558820882494;6332.240131184288;6358;6363.61818290904;5739.397363276879;5834.912476312858;5839.416058394211;5853.765849366063;5885.382034886361;4727.787249573708;5395.433479484597;5417.26866872975;5435.510804027577;5450.618456708072;5377.4891385319115;6467.223933128054;6506.219253689493;6511.967440162769;6515.120458738104;6257.374262573706;6283.3088360281245;6320.4311611955145;6328;6334.841628959313;6349.238091429058;6422.454091402096;6449.96775016122;6450.774222902176;6455.709493072917;6228.750849966132;6286.308506064421;6298.1812364392335;6309.589876658002;6431.324710905475;6223.128761973418;6251.937480625135;6313.40022697843;6321;6364.268109167319;6224.844378890382;6233.127362169209;6241.188645476059;6248.593841400295;6280.685965701788;6037.215162028908;6221.035739460391;6230.43926046658;6235.438810507076;6239.688015599293;5874.765009399576;6016.368281330572;6085;6086.1175129606845;6099.207103076749;6202.5658203925295;6233.096201050732;6238.594491358229;6254.718537665725;6274.058891166179;6096.1465394845645;6099.11562823397;6103.3591472894705;6112.510999120149;6122.846928826815 04:33:32 INFO - PROCESS | 1662 | |1;ext.html;475.0854604885594;587.7178954102031;592.5703864698091;654.9279579246283;663.820768392534;29744;32610.67389326106;40980.59019409805;41037.71698264139;41110.79444602773;44355.11289774202;44808.775956120255;44999;45189.32216016763;45324.320135197995;9595.472249026301;9832.557534910946;9834.803303933917;9835.90164098357;9853.310268281222;9544.42733435996;9665.951670241639;9673.22614190863;9680.709578712615;9842.458664773434;9797.608095676165;9874.01259874014;9875.1112399884;9877.35797173185;9887.505624718771;9769.560369783341;9827.754306142333;9836.262280328932;9838.36050656705;9850.50747462624;9771.706848794547;9885.555150018194;9903.306768526207;9910.851337229948;9917.454540000297;42743.93140171489;43036.56963430357;43112.3533147003;43131.56868431307;43348.783256083836;3136.764742644311;3291.7860339077884;3382.4588065909584;3697.186618943855;3938.133610605662;23622.76377236223;29793;30286.697133028607;30291.69708302933;30378.696213038027;2777.527820270559;2785.5264605017196;2803.215099772067;2814.5637426198973;2852.4865524205634;484071;487029;487413;488817.5559122217;488911;72245.63877180581;72767.63616181992;72867;72911;73075.63462182655;76657.233427665;80642.79035814467;81750;81824;81862;18480.537986550175;18541.536461588297;18696.626067478846;18717.625647486973;18734.718979215322;13891;14001.159930404208;14020.509282175075;14026.158430493999;14037.298135093204;22410.551788964454;22666.320010399715;22828.31515054551;22966;22999.425014374774;7423.740169094056;7771.33943614799;8243.093259741423;8561.914380856237;8917.73246802597;985.5614251658087;994.9303548751518;1017.2980643356061;1090.7818436312768;1138.4250953268547;25169.874150629497;25856.741432585433;30049;30180;30859.38281234363;970.6457143142702;1140.4753813246;1151.6602602232363;1177.935213563245;1189.655000049993;12019.939900300618;15268.541943741706;15510;15582.298796554182;15807.525774226791;534053;537391;537501;538552;539311;55571.44428555744;61333.69333153305;61421.38578614246;61857.69071154615;61949.690251548454;1386.6186798630458;1400.2018849255826;1503.624093976506;1518.096732444194;1548.4580396861234;29092.690828912328;29262.414751705273;29371.559426609045;30023.699763002965;30743.2314192147;47378;48709.269360958904;48955.510444895095;49051.01897962092;49057.26414103863;365288.1735591305;368098;369107;369267;369340;29513.114606561838;33784.66215337913;34267.65732342644;34837.303253935286;34884.476732849536;41805.1638967225;42205;42299.7885010573;43951.78024109859;44087.55912440835;34391.82804085963;35629;35696;35922.92231233067;36610.45084323684;35473.935781926586;35607.10982225362;35758;36152;36180.27639447144;29374.412511750073;29552.704472955855;29609;29712.702872970993;29808.403831923675;29936.25159371033;32987.721964485565;32999.845005425654;33021.33957320888;33026.69733026678;24857.627135593342;24945.75054249434;24976.500469990136;25490.74509254958;25517.362065947756 04:33:32 INFO - PROCESS | 1662 | |2;jquery.html;375.94736736856834;385.5219527785547;385.97298189126764;386.36057325126905;389.65320864430646;19517.12172952217;20991.790082099174;21505.46236344092;21527.892360538193;21532.461688457795;20273.89863050683;20632.69050964233;20983;21316.36050918475;21441;5397.190421436787;5440.945590544084;5553.500184983351;5565;5570.303712035975;6037.2755269367735;6072.483838873701;6101.328853826076;6104.786332478364;6112.572119951606;5643.351014633328;6022.608530445529;6081.969590152065;6084.300305464862;6095.29904061032;5321.893562128756;5489.478499542537;5511.834644960618;5540.695261760601;5548.889022219573;5297.099493086146;5344.251804747339;5355.3305836770405;5357.785688572452;5357.812476563302;25405.74594254052;25545.872270638527;25843.61234581483;26144.607830882553;26231.475370492484;2159.622066138435;2203.22886989554;2219.1012639880873;2799.006352744787;2807.4244779820087;9293.256539476826;9354.625814967394;9399.671011514563;9861.063198996084;10415.68752937413;1750.0374793863452;1751.220706785481;1784.1703607822426;1804.3143605429852;1823.4073925974112;82340;112057;114072;114354.42822785916;117687.41156294163;11580.757387931393;11623.709407264716;11631.360275184777;11767.529298828122;11983.340916249515;14584.48954286616;14588.41646334156;14593.905457090761;14626.195559244345;14640;8645.092265312178;8890.244329231959;8899.866502002475;8924.55377231136;9009.729708108636;9112.997570267265;9120.087991200828;9143.588538515784;9205;9238.538073096319;4530.88672783183;4599.33309670096;4601.470830854495;4603.033362993742;4618.1918164321105;1635.7464592988106;1903.4004288649032;1952.1410579345327;1954.921803127859;1995.5609765851489;932.5150921520907;934.6962237272913;990.7855941969692;1015.3451024089421;1058.0213302694976;17283.74074388885;20362.287319944026;20540.794592053888;21210.469738256357;21265.36203913885;998.8513209808779;1001.234055947201;1027.209049032241;1046.5970601318547;1060.4379678770265;11113.944175303333;11373.431328433546;11400.771984560428;11446.828297575543;11475.770484590428;626599;641767;643137;645080;650556.7472162609;100027;100141.49929250307;109037.45481272542;128851;132388;1005.7586179316911;1016.5730393234859;1026.08165691707;1028.7736697926443;1035.9015893490107;18466.907665461586;18800.52998675044;19119.426417207505;19194.848309101497;19374.321898733477;40282;50056.749716251186;50668.23997640112;50813.74593127011;52302;73474.26525734675;77635.30706450167;78149;78865.2113478858;78924.60537697504;8094.676212951416;8158.796030099057;8184.058833234254;8209.220124088202;8332;9664.951675241578;13025.218486890817;13208.405621747237;13397.12918660284;13568.86431135676;10906.127509799038;11289.887101128883;11302.265352752045;11542.480588373712;11696.47365868555;11240.662780116609;11240.887591123985;11396.430178490877;11616.303021818718;11700.648980530597;11456.312621242752;11536.711582210177;11584;11822.704432388915;11903.821442678194;8062.314703250055;8178.591070446335;8243.340532757245;8295.211954864279;8540.359473039423;10073.244506662177;11353.829692554784;11637.5344986203;11691.415429228335;11760.82358764602 04:33:32 INFO - PROCESS | 1662 | |3;mootools.html;1452.520668179501;1588.7934568506096;1620.4571468558033;1956.4913122588132;2086.232957691674;8194.303484203843;8898.911010889897;9089.045650206715;9109.59006844692;9127;8806.647734090644;9037;9040.773980650487;9049.683261085847;9055.04921983192;2003.827760759957;2225.5103877147003;2480.838745481547;2510.5104504621604;2537.8096642751775;2557.6419301297833;2561.5517284475236;2563.0772921748157;2568.2552059902605;2571.3700143464876;2349.8472599281076;2526.077981536735;2528.026709716754;2530.72162062173;2532.101104108043;2455.484348286862;2491.8006559475198;2497.9750202498108;2499.3379402697183;2546.808989325799;2503.374156460885;2518.848869067862;2530.253575195322;2560.411105445758;2560.5775047117204;9196.632134714604;9257.074292570756;9262.305327100494;9275.67535136267;9276.860847087299;5620;5752.453516915886;5799.246098007275;5811.883762324772;5815.21494598228;3529.1000794797164;3609.4224924012033;3737.7757334560015;3749.7750134991716;3753.924921501582;1040.8438734189856;1059.8092343378266;1064.3188359449957;1069.8181309177457;1101.944902754859;9549.952250238774;12442;12471.251724896445;12474.688132796753;12479.688007799787;4271.1671224111;4714.175019371665;4987.775550100254;5075.2387141929;5107.61692873036;10602.098821600097;10620.415877126832;10632.255742098134;10639;10649.094826939641;5728.942710572925;5743.396943320975;5747.568932330092;5748.367679555246;5772.797952071657;4544.590986811137;4716.3868697069165;4951.752412379366;5064.215046667772;5090.567301779316;3528.3119791640897;4045.3122085774894;4094.7952602369764;4129.29801933672;4162.021924847659;1339.5847287340955;1352.553657293091;1356.287948826854;1361.4282001559368;1363.6045546791518;1160.9013233875046;1167.9824802627968;1372.9977116704663;1400.7058517711191;1402.5161319344809;8551.615177317035;8569.871451928226;8666.176713212235;8667.653293868301;8765.693200737944;1247.357610830423;1259.2570383473612;1263.728298415845;1268.7018550640591;1274.5857596281246;6535.803925882231;6576.309487503839;6644.534882558271;6653.334666533308;6684.398404143651;10789.082927951054;11274.92888175622;11294.491747871365;11307.773844523228;11318.094552435785;10896.945515272373;11046.944765276123;11087.05760010408;11100.888991109985;11201.495932683049;8589.312854971588;8662.913370866338;8705.825883482295;8719.825603487894;8739.12608739121;8260.752177434446;8269.627866746132;8342.082370939313;8433.873491897504;8437.915620843958;9945.204383649147;10102.949485252526;10182.898171018194;10255.94872025635;10261;10175.236857235885;10468.790624187626;10492.895071049192;10650.254482186172;10650.89349106499;7025.297470252934;7469.066366704162;7478.102627684712;7749.496282741604;7826;8551;8551.05938346769;8611.224989750952;8611.913880861111;8616.483011019109;7528;7554.773356799305;7584.08990921093;7681.462297639112;7772.68909243624;7053.800853854755;7397.630118494161;7458.47790654649;7570.621468926422;7600.239976002355;7297.635118244173;8077.15189905075;8126.024877014796;8139.7965050871835;8158.551279679437;7090.787276381717;7310.195878453473;7312.8537429250055;7340.009098771598;7372.373348265458;7455.589942553212;7463.253674632493;7508.0990281166605;7517.210692877388;7518.28576285252 04:33:32 INFO - PROCESS | 1662 | |4;prototype.html;329.1770573566085;331.08124953254713;333.36161251203913;337.2630801698291;337.68303615898;5776.682282474462;6679.899801502976;6691.0632511448375;6770.593764374129;6804.6257455839905;6316.810495685137;6659.101021362115;6678.833029174273;6691.1636045494315;6701.095352127473;4718.764061796896;4802.23164293713;4831.855044348676;4921.311016457699;4939.061578300129;4945.802167913279;4953.777080031407;4959.727215003191;4960.404751429834;4973.925391119136;4900.289458028584;4911.238757992499;4915.311856340115;4921.384826896638;4923.70457772533;4699.295105734133;4777.426708794949;4894.608431325485;4896.192128298826;4910.926336104962;4203.852865149705;4214.641755450791;4218.2196293685765;4227.682923780729;4230.323148296288;5207.895842083175;5474.890502189974;6339.703354255807;6402.711877965457;6483.4164925156965;5899.852503687399;5900.1149827526215;5904.822855314347;5908.261467316585;5921.378255283219;6854.280300568468;7136;7136.286371362874;7137.500374973754;7139.250378710264;4779.880502987418;4799.568038876483;4800.271902115236;4801.855944321641;4815.181419158752;7373.926260737378;7543.321101100927;7560.130584982742;7563.848723025509;7566.129895062083;4886.315915771795;4887.486813884562;4889.315495830587;4894.535019173173;4913.606911447076;4932.53140951609;4943.307936888838;4954.702717836942;4967.403911530567;4969.82605608802;4486.68593198473;5906.114082887515;5911.615744976562;5915.08316210988;5915.526757859361;7154.642267886585;7169.89245161323;7175.31834475724;7186.209516953131;7188.921661750779;1683.9158042097847;1720.1399300349824;1720.2946791815546;1724.3188940368484;1725.4909801608555;1035.5184839049878;1071.4910417551757;1099.9330649270196;1105.6461932181624;1133.1784456269138;6467;6484.708188131451;6568.573042752301;6581.638009909501;6607.273199948002;7479.775606731807;7494.21310762373;7494.601727447273;7502.212267711811;7503.5497870127965;6124.418180272867;6164.013757798731;6744.5616034957575;6769.120014398097;6772.2211945625895;3425.1950791563963;3652.8128358283666;3798.5061941947924;3936.822842972073;3950.762954222756;7732.226777322223;7774.067111946602;7778.533288002738;7780.416468764752;7823.139454659983;6838.623875686885;7106.822329441702;7612.619369031526;7680.846383072419;7682.654280557388;7742.187070357644;7755.2244775521995;7761.068671759425;7766.417518686234;7772.961135194175;6078.3921607838865;7121.67952442131;7452.254774522505;7455.0681164854395;7463.6641351140415;7238.0952380952385;7265.491415600857;7289.088863892013;7325.340719335285;7340.706371745284;7730.11103723079;7732.497387669783;7757.030371203599;7760.650770715219;7778.961105194438;4903.166461701448;4910.533499317559;4915.557599816034;4917.385326834145;4922.310876477224;7049.823754406181;7358.0434543509;7384.741534046498;7394.223606521453;7405;7114.288571142844;7156.749513767201;7159.248278930846;7163.176234733072;7164.140303163654;7116.25279345682;7119.501634885508;7128.572285662877;7129.643517823984;7145.499815013107;6959.930400695928;6961.373476386947;6969.616671083139;6972.930270697431;6979.651017449209;6915.654217289216;7094.751683691046;7111.928880711127;7137.750178743719;7169.390601798906;6665.566738162004;6817.693203805939;6818.590884546943;6823.897641535282;6947.444204463732 04:33:32 INFO - PROCESS | 1662 | |5;yui.html;681.8159097043801;696.1750325863852;731.8353370491636;778.2451022508169;778.8870613761003;15150.393984240618;15536.533903982885;15540.689186216283;17491;17715.82284177158;16539.751903721455;16636.83363166368;16734.58163545909;16782.83217167828;16815.41146059888;786.657803855322;797.4696826610298;798.6046906781152;964.9517524123801;987.7530617345664;796.8804679298094;961.4808003678005;989.366805244644;989.5744829723216;991.2912267728573;1030.6701855406236;1037.4034929915292;1037.7716902281486;1038.8961103889587;1040.126293913113;814.6334149632689;1030.3508789462664;1031.3811712972195;1032.4063663393579;1032.6179313653959;615.4645458451176;616.0020766358527;761.003085957392;773.6595897804948;774.1484367196095;15558.37766489339;15620.531384058382;15628.218589070615;15660.608484787857;15663.13852738099;12655.683607909783;12750.234985900875;12843.743125137538;12966.935165324207;13065.934670326682;10774.784504309948;10968.012878840942;11104.44477776116;11161.72095697614;11733.882661173364;4179.728317659343;4181.038361176916;4183.6653067754505;4273.743575385456;4276.2516559601945;75202.99999999945;76238;76303.61848190779;76443;83751.5812420934;10097.596096156072;10249.94875025635;10262.897371026194;10343.431111288952;10507.47462626881;23182.76817231806;23183.53632927366;23184.4203894904;23235.7676423237;23345.88327058388;7047.89428158578;7240.710371585183;7713.7685869424;7788.766337009899;8138.348932085419;4044.8584299549375;4076.5515793262716;4149.211649786531;4229.0273237155625;4383.780810959439;3793.639604237593;3829.965909204499;3840.6543411092575;3846.0577158595765;3847.826847791856;663.2869665110026;679.6058286193995;679.9014142949245;686.543448606681;703.2440126863642;597.0328068528925;605.5791225098515;605.6910975402576;608.428077607048;611.4069352727847;7789.844203115906;8339.666413343519;8368.539730314891;8385.832283354299;8388.79028024292;417.59701887678534;496.89068404950854;519.9974000129976;594.7234535940722;618.4125081172904;3679.68722658577;3768.6419790120444;3775.716821238418;3792.184680293695;3947.605239476087;89015;91067.54466227627;91305.54347228355;91523.54238228766;91624;80912.59543702244;84362.5781871099;84807;86520;86587.5670621643;66135.33864661292;67401.32598674048;73074.63462682652;74493.13767155756;75622.9999999989;7473.813154671177;7526.322630963021;7633.084029916446;7722.420818438752;8023;38978.6102138975;50376;50495;50497;51716.224256635425;69724.6513767428;73691.63154184195;73700.63149684218;73896;74598;10149.847752283575;10291.53688084053;10354.792904142025;10565.098282309258;10802.08182304513;10627.628033018807;10705.464726763787;10870.456477176267;10956.835647465454;11192.160587955774;9270.675526356545;9831.557579909064;10214.489275536342;10410.895891040993;10453;10931.398773067558;11028;11071.944640276746;11448.313101213955;11619.535218591162;10794.73013174677;10805.135589153006;10930.344179349264;11216.551337946717;11601.12991525622;9315.953420232856;9398.248140148908;9460.574274157818;9757.902420975699;9843.950780246052;9649.951750241204;9652.324337296603;9662.516874156123;9685.6610018649;9703.805923881624 04:33:32 INFO - PROCESS | 1662 | __end_tp_report 04:33:32 INFO - PROCESS | 1662 | __start_cc_report 04:33:32 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1025 04:33:32 INFO - PROCESS | 1662 | __end_cc_report 04:33:32 INFO - PROCESS | 1662 | __startTimestamp1460374412244__endTimestamp 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:33:32 INFO - PROCESS | 1662 | Number of tests: 6 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5824.43 Median:6086.12 stddev:654.55 (10.8%) stddev-sans-first:629.93 04:33:32 INFO - PROCESS | 1662 | Values: 3468.7 3533.3 3544.3 3570.8 3621.5 5832.9 5841.2 5843.6 5855.2 5858.1 5799.6 5815.2 5818.5 5836.8 5849.2 5177.4 5215.3 5240.3 5242.4 5287.7 5355.8 5367.1 5367.3 5381.5 5385.8 5219.9 5241.5 5282.7 5285.6 5302.0 5152.8 5277.2 5296.9 5307.3 5347.3 4561.7 5165.0 5198.7 5244.8 5281.2 5694.0 5696.6 5731.5 5740.4 5773.8 6152.4 6265.6 6316.1 6329.3 6335.9 5279.9 6256.6 6284.7 6360.8 6367.5 5824.9 5877.3 5896.8 5900.2 5904.6 6263.5 6304.3 6377.3 6386.5 6414.5 6260.2 6282.3 6299.5 6312.9 6325.3 6316.0 6340.7 6365.3 6375.8 6381.3 6073.7 6223.0 6247.7 6317.7 6329.9 6318.7 6345.7 6348.6 6348.6 6355.3 4913.4 4933.6 4962.9 4965.7 4975.6 4395.2 4407.8 4482.6 4485.6 4498.8 5866.7 5875.2 5889.5 5893.4 5926.4 6297.5 6302.6 6332.2 6358.0 6363.6 5739.4 5834.9 5839.4 5853.8 5885.4 4727.8 5395.4 5417.3 5435.5 5450.6 5377.5 6467.2 6506.2 6512.0 6515.1 6257.4 6283.3 6320.4 6328.0 6334.8 6349.2 6422.5 6450.0 6450.8 6455.7 6228.8 6286.3 6298.2 6309.6 6431.3 6223.1 6251.9 6313.4 6321.0 6364.3 6224.8 6233.1 6241.2 6248.6 6280.7 6037.2 6221.0 6230.4 6235.4 6239.7 5874.8 6016.4 6085.0 6086.1 6099.2 6202.6 6233.1 6238.6 6254.7 6274.1 6096.1 6099.1 6103.4 6112.5 6122.8 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:62230.01 Median:369303.50 stddev:124836.04 (33.8%) stddev-sans-first:125100.14 04:33:32 INFO - PROCESS | 1662 | Values: 475.1 587.7 592.6 654.9 663.8 29744.0 32610.7 40980.6 41037.7 41110.8 44355.1 44808.8 44999.0 45189.3 45324.3 9595.5 9832.6 9834.8 9835.9 9853.3 9544.4 9666.0 9673.2 9680.7 9842.5 9797.6 9874.0 9875.1 9877.4 9887.5 9769.6 9827.8 9836.3 9838.4 9850.5 9771.7 9885.6 9903.3 9910.9 9917.5 42743.9 43036.6 43112.4 43131.6 43348.8 3136.8 3291.8 3382.5 3697.2 3938.1 23622.8 29793.0 30286.7 30291.7 30378.7 2777.5 2785.5 2803.2 2814.6 2852.5 484071.0 487029.0 487413.0 488817.6 488911.0 72245.6 72767.6 72867.0 72911.0 73075.6 76657.2 80642.8 81750.0 81824.0 81862.0 18480.5 18541.5 18696.6 18717.6 18734.7 13891.0 14001.2 14020.5 14026.2 14037.3 22410.6 22666.3 22828.3 22966.0 22999.4 7423.7 7771.3 8243.1 8561.9 8917.7 985.6 994.9 1017.3 1090.8 1138.4 25169.9 25856.7 30049.0 30180.0 30859.4 970.6 1140.5 1151.7 1177.9 1189.7 12019.9 15268.5 15510.0 15582.3 15807.5 534053.0 537391.0 537501.0 538552.0 539311.0 55571.4 61333.7 61421.4 61857.7 61949.7 1386.6 1400.2 1503.6 1518.1 1548.5 29092.7 29262.4 29371.6 30023.7 30743.2 47378.0 48709.3 48955.5 49051.0 49057.3 365288.2 368098.0 369107.0 369267.0 369340.0 29513.1 33784.7 34267.7 34837.3 34884.5 41805.2 42205.0 42299.8 43951.8 44087.6 34391.8 35629.0 35696.0 35922.9 36610.5 35473.9 35607.1 35758.0 36152.0 36180.3 29374.4 29552.7 29609.0 29712.7 29808.4 29936.3 32987.7 32999.8 33021.3 33026.7 24857.6 24945.8 24976.5 25490.7 25517.4 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:35540.25 Median:2181.43 stddev:106172.27 (4867.1%) stddev-sans-first:106437.28 04:33:32 INFO - PROCESS | 1662 | Values: 375.9 385.5 386.0 386.4 389.7 19517.1 20991.8 21505.5 21527.9 21532.5 20273.9 20632.7 20983.0 21316.4 21441.0 5397.2 5440.9 5553.5 5565.0 5570.3 6037.3 6072.5 6101.3 6104.8 6112.6 5643.4 6022.6 6082.0 6084.3 6095.3 5321.9 5489.5 5511.8 5540.7 5548.9 5297.1 5344.3 5355.3 5357.8 5357.8 25405.7 25545.9 25843.6 26144.6 26231.5 2159.6 2203.2 2219.1 2799.0 2807.4 9293.3 9354.6 9399.7 9861.1 10415.7 1750.0 1751.2 1784.2 1804.3 1823.4 82340.0 112057.0 114072.0 114354.4 117687.4 11580.8 11623.7 11631.4 11767.5 11983.3 14584.5 14588.4 14593.9 14626.2 14640.0 8645.1 8890.2 8899.9 8924.6 9009.7 9113.0 9120.1 9143.6 9205.0 9238.5 4530.9 4599.3 4601.5 4603.0 4618.2 1635.7 1903.4 1952.1 1954.9 1995.6 932.5 934.7 990.8 1015.3 1058.0 17283.7 20362.3 20540.8 21210.5 21265.4 998.9 1001.2 1027.2 1046.6 1060.4 11113.9 11373.4 11400.8 11446.8 11475.8 626599.0 641767.0 643137.0 645080.0 650556.7 100027.0 100141.5 109037.5 128851.0 132388.0 1005.8 1016.6 1026.1 1028.8 1035.9 18466.9 18800.5 19119.4 19194.8 19374.3 40282.0 50056.7 50668.2 50813.7 52302.0 73474.3 77635.3 78149.0 78865.2 78924.6 8094.7 8158.8 8184.1 8209.2 8332.0 9665.0 13025.2 13208.4 13397.1 13568.9 10906.1 11289.9 11302.3 11542.5 11696.5 11240.7 11240.9 11396.4 11616.3 11700.6 11456.3 11536.7 11584.0 11822.7 11903.8 8062.3 8178.6 8243.3 8295.2 8540.4 10073.2 11353.8 11637.5 11691.4 11760.8 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6299.14 Median:4715.28 stddev:3329.28 (70.6%) stddev-sans-first:3318.68 04:33:32 INFO - PROCESS | 1662 | Values: 1452.5 1588.8 1620.5 1956.5 2086.2 8194.3 8898.9 9089.0 9109.6 9127.0 8806.6 9037.0 9040.8 9049.7 9055.0 2003.8 2225.5 2480.8 2510.5 2537.8 2557.6 2561.6 2563.1 2568.3 2571.4 2349.8 2526.1 2528.0 2530.7 2532.1 2455.5 2491.8 2498.0 2499.3 2546.8 2503.4 2518.8 2530.3 2560.4 2560.6 9196.6 9257.1 9262.3 9275.7 9276.9 5620.0 5752.5 5799.2 5811.9 5815.2 3529.1 3609.4 3737.8 3749.8 3753.9 1040.8 1059.8 1064.3 1069.8 1101.9 9550.0 12442.0 12471.3 12474.7 12479.7 4271.2 4714.2 4987.8 5075.2 5107.6 10602.1 10620.4 10632.3 10639.0 10649.1 5728.9 5743.4 5747.6 5748.4 5772.8 4544.6 4716.4 4951.8 5064.2 5090.6 3528.3 4045.3 4094.8 4129.3 4162.0 1339.6 1352.6 1356.3 1361.4 1363.6 1160.9 1168.0 1373.0 1400.7 1402.5 8551.6 8569.9 8666.2 8667.7 8765.7 1247.4 1259.3 1263.7 1268.7 1274.6 6535.8 6576.3 6644.5 6653.3 6684.4 10789.1 11274.9 11294.5 11307.8 11318.1 10896.9 11046.9 11087.1 11100.9 11201.5 8589.3 8662.9 8705.8 8719.8 8739.1 8260.8 8269.6 8342.1 8433.9 8437.9 9945.2 10102.9 10182.9 10255.9 10261.0 10175.2 10468.8 10492.9 10650.3 10650.9 7025.3 7469.1 7478.1 7749.5 7826.0 8551.0 8551.1 8611.2 8611.9 8616.5 7528.0 7554.8 7584.1 7681.5 7772.7 7053.8 7397.6 7458.5 7570.6 7600.2 7297.6 8077.2 8126.0 8139.8 8158.6 7090.8 7310.2 7312.9 7340.0 7372.4 7455.6 7463.3 7508.1 7517.2 7518.3 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5854.63 Median:6662.33 stddev:1854.15 (27.8%) stddev-sans-first:1812.37 04:33:32 INFO - PROCESS | 1662 | Values: 329.2 331.1 333.4 337.3 337.7 5776.7 6679.9 6691.1 6770.6 6804.6 6316.8 6659.1 6678.8 6691.2 6701.1 4718.8 4802.2 4831.9 4921.3 4939.1 4945.8 4953.8 4959.7 4960.4 4973.9 4900.3 4911.2 4915.3 4921.4 4923.7 4699.3 4777.4 4894.6 4896.2 4910.9 4203.9 4214.6 4218.2 4227.7 4230.3 5207.9 5474.9 6339.7 6402.7 6483.4 5899.9 5900.1 5904.8 5908.3 5921.4 6854.3 7136.0 7136.3 7137.5 7139.3 4779.9 4799.6 4800.3 4801.9 4815.2 7373.9 7543.3 7560.1 7563.8 7566.1 4886.3 4887.5 4889.3 4894.5 4913.6 4932.5 4943.3 4954.7 4967.4 4969.8 4486.7 5906.1 5911.6 5915.1 5915.5 7154.6 7169.9 7175.3 7186.2 7188.9 1683.9 1720.1 1720.3 1724.3 1725.5 1035.5 1071.5 1099.9 1105.6 1133.2 6467.0 6484.7 6568.6 6581.6 6607.3 7479.8 7494.2 7494.6 7502.2 7503.5 6124.4 6164.0 6744.6 6769.1 6772.2 3425.2 3652.8 3798.5 3936.8 3950.8 7732.2 7774.1 7778.5 7780.4 7823.1 6838.6 7106.8 7612.6 7680.8 7682.7 7742.2 7755.2 7761.1 7766.4 7773.0 6078.4 7121.7 7452.3 7455.1 7463.7 7238.1 7265.5 7289.1 7325.3 7340.7 7730.1 7732.5 7757.0 7760.7 7779.0 4903.2 4910.5 4915.6 4917.4 4922.3 7049.8 7358.0 7384.7 7394.2 7405.0 7114.3 7156.7 7159.2 7163.2 7164.1 7116.3 7119.5 7128.6 7129.6 7145.5 6959.9 6961.4 6969.6 6972.9 6979.7 6915.7 7094.8 7111.9 7137.8 7169.4 6665.6 6817.7 6818.6 6823.9 6947.4 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18656.67 Median:50435.50 stddev:26157.14 (51.9%) stddev-sans-first:26195.69 04:33:32 INFO - PROCESS | 1662 | Values: 681.8 696.2 731.8 778.2 778.9 15150.4 15536.5 15540.7 17491.0 17715.8 16539.8 16636.8 16734.6 16782.8 16815.4 786.7 797.5 798.6 965.0 987.8 796.9 961.5 989.4 989.6 991.3 1030.7 1037.4 1037.8 1038.9 1040.1 814.6 1030.4 1031.4 1032.4 1032.6 615.5 616.0 761.0 773.7 774.1 15558.4 15620.5 15628.2 15660.6 15663.1 12655.7 12750.2 12843.7 12966.9 13065.9 10774.8 10968.0 11104.4 11161.7 11733.9 4179.7 4181.0 4183.7 4273.7 4276.3 75203.0 76238.0 76303.6 76443.0 83751.6 10097.6 10249.9 10262.9 10343.4 10507.5 23182.8 23183.5 23184.4 23235.8 23345.9 7047.9 7240.7 7713.8 7788.8 8138.3 4044.9 4076.6 4149.2 4229.0 4383.8 3793.6 3830.0 3840.7 3846.1 3847.8 663.3 679.6 679.9 686.5 703.2 597.0 605.6 605.7 608.4 611.4 7789.8 8339.7 8368.5 8385.8 8388.8 417.6 496.9 520.0 594.7 618.4 3679.7 3768.6 3775.7 3792.2 3947.6 89015.0 91067.5 91305.5 91523.5 91624.0 80912.6 84362.6 84807.0 86520.0 86587.6 66135.3 67401.3 73074.6 74493.1 75623.0 7473.8 7526.3 7633.1 7722.4 8023.0 38978.6 50376.0 50495.0 50497.0 51716.2 69724.7 73691.6 73700.6 73896.0 74598.0 10149.8 10291.5 10354.8 10565.1 10802.1 10627.6 10705.5 10870.5 10956.8 11192.2 9270.7 9831.6 10214.5 10410.9 10453.0 10931.4 11028.0 11071.9 11448.3 11619.5 10794.7 10805.1 10930.3 11216.6 11601.1 9316.0 9398.2 9460.6 9757.9 9844.0 9650.0 9652.3 9662.5 9685.7 9703.8 04:33:32 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:33:32 INFO - PROCESS | 1662 | 04:33:32 INFO - TEST-INFO | 1662: exit 0 04:33:32 INFO - TEST-OK | dromaeo_css | took 1112648ms 04:33:32 INFO - TEST-START | kraken 04:33:32 INFO - operating with platform_type : mac_ 04:33:32 INFO - Initialising browser for kraken test... 04:33:32 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp_Hmiz2/profile http://localhost:49275/getInfo.html) 04:33:35 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 04:33:35 INFO - PROCESS | 1674 | colorDepth:24 04:33:35 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 04:33:35 INFO - PROCESS | 1674 | __metrics 04:33:35 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:35 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:35 INFO - TEST-INFO | 1674: exit 0 04:33:35 INFO - Browser initialized. 04:33:35 INFO - Running cycle 1/1 for kraken test... 04:33:35 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/tmp_Hmiz2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:47 INFO - PROCESS | 1676 | RSS: Main: 207638528 04:33:47 INFO - PROCESS | 1676 | 04:33:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:50 INFO - PROCESS | 1676 | RSS: Main: 262795264 04:33:50 INFO - PROCESS | 1676 | 04:33:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:33:54 INFO - PROCESS | 1676 | RSS: Main: 273223680 04:33:54 INFO - PROCESS | 1676 | 04:33:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:33:57 INFO - PROCESS | 1676 | RSS: Main: 262701056 04:33:57 INFO - PROCESS | 1676 | 04:33:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:34:00 INFO - PROCESS | 1676 | RSS: Main: 265138176 04:34:00 INFO - PROCESS | 1676 | 04:34:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:03 INFO - PROCESS | 1676 | RSS: Main: 265003008 04:34:03 INFO - PROCESS | 1676 | 04:34:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:06 INFO - PROCESS | 1676 | RSS: Main: 264916992 04:34:06 INFO - PROCESS | 1676 | 04:34:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:09 INFO - PROCESS | 1676 | RSS: Main: 265007104 04:34:09 INFO - PROCESS | 1676 | 04:34:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:34:13 INFO - PROCESS | 1676 | RSS: Main: 265338880 04:34:13 INFO - PROCESS | 1676 | 04:34:14 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:15 INFO - PROCESS | 1676 | RSS: Main: 298827776 04:34:15 INFO - PROCESS | 1676 | 04:34:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:17 INFO - PROCESS | 1676 | RSS: Main: 299806720 04:34:17 INFO - PROCESS | 1676 | 04:34:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:20 INFO - PROCESS | 1676 | RSS: Main: 305233920 04:34:20 INFO - PROCESS | 1676 | 04:34:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:23 INFO - PROCESS | 1676 | RSS: Main: 306626560 04:34:23 INFO - PROCESS | 1676 | 04:34:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:26 INFO - PROCESS | 1676 | RSS: Main: 306749440 04:34:26 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:34:28 INFO - PROCESS | 1676 | RSS: Main: 370327552 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | __start_tp_report 04:34:28 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 04:34:28 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 04:34:28 INFO - PROCESS | 1676 | |i|pagename|runs| 04:34:28 INFO - PROCESS | 1676 | |0;ai-astar;112;109;112;112;112;111;119;113;110;113 04:34:28 INFO - PROCESS | 1676 | |1;audio-beat-detection;153;119;154;164;152;172;148;145;149;117 04:34:28 INFO - PROCESS | 1676 | |2;audio-dft;184;185;184;182;186;185;183;183;185;185 04:34:28 INFO - PROCESS | 1676 | |3;audio-fft;73;81;72;111;56;58;61;60;145;83 04:34:28 INFO - PROCESS | 1676 | |4;audio-oscillator;91;95;128;82;78;92;117;77;79;116 04:34:28 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;85;89;86;88;85;89;87;89;84 04:34:28 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;93;96;94;94;93;97;93;94;93 04:34:28 INFO - PROCESS | 1676 | |7;imaging-desaturate;85;85;87;87;86;86;87;87;84;86 04:34:28 INFO - PROCESS | 1676 | |8;json-parse-financial;56;58;59;60;57;57;58;66;51;51 04:34:28 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;61;61;70;73;69;68;65;69;94;104 04:34:28 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;81;98;106;108;105;80;79;81;82;82 04:34:28 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;120;131;131;121;129;119;109;122;130;132 04:34:28 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;134;125;130;138;135;123;135;132;133;132 04:34:28 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;65;67;64;70;68 04:34:28 INFO - PROCESS | 1676 | __end_tp_report 04:34:28 INFO - PROCESS | 1676 | __start_cc_report 04:34:28 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1193 04:34:28 INFO - PROCESS | 1676 | __end_cc_report 04:34:28 INFO - PROCESS | 1676 | __startTimestamp1460374468630__endTimestamp 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | ------- Summary: start ------- 04:34:28 INFO - PROCESS | 1676 | Number of tests: 14 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:2.83 04:34:28 INFO - PROCESS | 1676 | Values: 112.0 109.0 112.0 112.0 112.0 111.0 119.0 113.0 110.0 113.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:152.50 stddev:17.37 (11.4%) stddev-sans-first:18.30 04:34:28 INFO - PROCESS | 1676 | Values: 153.0 119.0 154.0 164.0 152.0 172.0 148.0 145.0 149.0 117.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 04:34:28 INFO - PROCESS | 1676 | Values: 184.0 185.0 184.0 182.0 186.0 185.0 183.0 183.0 185.0 185.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:80.00 Median:66.50 stddev:28.15 (42.3%) stddev-sans-first:29.74 04:34:28 INFO - PROCESS | 1676 | Values: 73.0 81.0 72.0 111.0 56.0 58.0 61.0 60.0 145.0 83.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:80.50 stddev:18.48 (23.0%) stddev-sans-first:19.53 04:34:28 INFO - PROCESS | 1676 | Values: 91.0 95.0 128.0 82.0 78.0 92.0 117.0 77.0 79.0 116.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.50 stddev:1.97 (2.2%) stddev-sans-first:1.96 04:34:28 INFO - PROCESS | 1676 | Values: 89.0 85.0 89.0 86.0 88.0 85.0 89.0 87.0 89.0 84.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:1.37 (1.5%) stddev-sans-first:1.45 04:34:28 INFO - PROCESS | 1676 | Values: 94.0 93.0 96.0 94.0 94.0 93.0 97.0 93.0 94.0 93.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 04:34:28 INFO - PROCESS | 1676 | Values: 85.0 85.0 87.0 87.0 86.0 86.0 87.0 87.0 84.0 86.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:4.32 (7.5%) stddev-sans-first:4.56 04:34:28 INFO - PROCESS | 1676 | Values: 56.0 58.0 59.0 60.0 57.0 57.0 58.0 66.0 51.0 51.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:69.00 stddev:14.21 (20.6%) stddev-sans-first:14.35 04:34:28 INFO - PROCESS | 1676 | Values: 61.0 61.0 70.0 73.0 69.0 68.0 65.0 69.0 94.0 104.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:81.00 stddev:12.38 (15.3%) stddev-sans-first:12.68 04:34:28 INFO - PROCESS | 1676 | Values: 81.0 98.0 106.0 108.0 105.0 80.0 79.0 81.0 82.0 82.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:129.50 stddev:7.46 (5.8%) stddev-sans-first:7.74 04:34:28 INFO - PROCESS | 1676 | Values: 120.0 131.0 131.0 121.0 129.0 119.0 109.0 122.0 130.0 132.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.70 Median:133.50 stddev:4.62 (3.5%) stddev-sans-first:4.82 04:34:28 INFO - PROCESS | 1676 | Values: 134.0 125.0 130.0 138.0 135.0 123.0 135.0 132.0 133.0 132.0 04:34:28 INFO - PROCESS | 1676 | 04:34:28 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.71 (2.6%) stddev-sans-first:1.81 04:34:28 INFO - PROCESS | 1676 | Values: 66.0 67.0 65.0 66.0 66.0 65.0 67.0 64.0 70.0 68.0 04:34:28 INFO - PROCESS | 1676 | -------- Summary: end -------- 04:34:28 INFO - PROCESS | 1676 | 04:34:29 INFO - TEST-INFO | 1676: exit 0 04:34:29 INFO - TEST-OK | kraken | took 56681ms 04:34:29 INFO - SUITE-END | took 1169s 04:34:29 INFO - Completed test suite (00:19:29) 04:34:29 INFO - javascript benchmark 04:34:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3468.716574867299, 3533.328667553165, 3544.273423948091, 3570.785752854829, 3621.4567814827788, 5832.883342333151, 5841.153032810245, 5843.5617328700355, 5855.151003104547, 5858.062709966406, 5799.623024503415, 5815.244018277628, 5818.534517238621, 5836.795712150076, 5849.239598852154, 5177.378714554259, 5215.348081489804, 5240.318758561381, 5242.370915490146, 5287.709175995319, 5355.758990845402, 5367.087595108841, 5367.329083864517, 5381.461853814626, 5385.838424847261, 5219.895602087956, 5241.528262456378, 5282.709450980195, 5285.6300058995885, 5302.0, 5152.793888244466, 5277.1556550951855, 5296.947030529723, 5307.310049693534, 5347.25138480613, 4561.7262964222255, 5165.0, 5198.6880787152895, 5244.816431424882, 5281.155015197588, 5694.032014557493, 5696.601237913348, 5731.541476681856, 5740.397258287903, 5773.826785196451, 6152.446279834791, 6265.5614107012525, 6316.115743795872, 6329.3354197809485, 6335.8732825343695, 5279.894402111975, 6256.562040657156, 6284.685765711742, 6360.840978975516, 6367.458766004896, 5824.912626310609, 5877.265341832271, 5896.793612223594, 5900.203472531153, 5904.616199947032, 6263.467605253604, 6304.338044505261, 6377.3303803100935, 6386.521010924106, 6414.486841052798, 6260.217472815898, 6282.277538083087, 6299.464545513591, 6312.905306420407, 6325.335839736854, 6316.0, 6340.714667839959, 6365.2998170201245, 6375.840603984938, 6381.266154392211, 6073.665948372882, 6222.968885155636, 6247.687615619292, 6317.652529110851, 6329.905051424233, 6318.6524741138755, 6345.746170153235, 6348.555601107971, 6348.587341822767, 6355.269144048493, 4913.385826771653, 4933.629977751683, 4962.8511144665, 4965.726885021359, 4975.601951843843, 4395.208862404734, 4407.779611019436, 4482.641388688897, 4485.596296333346, 4498.820047198141, 5866.70666466675, 5875.177475153482, 5889.528837692974, 5893.410658934073, 5926.407359264125, 6297.4962003039645, 6302.558820882494, 6332.240131184288, 6358.0, 6363.61818290904, 5739.397363276879, 5834.912476312858, 5839.416058394211, 5853.765849366063, 5885.382034886361, 4727.787249573708, 5395.433479484597, 5417.26866872975, 5435.510804027577, 5450.618456708072, 5377.4891385319115, 6467.223933128054, 6506.219253689493, 6511.967440162769, 6515.120458738104, 6257.374262573706, 6283.3088360281245, 6320.4311611955145, 6328.0, 6334.841628959313, 6349.238091429058, 6422.454091402096, 6449.96775016122, 6450.774222902176, 6455.709493072917, 6228.750849966132, 6286.308506064421, 6298.1812364392335, 6309.589876658002, 6431.324710905475, 6223.128761973418, 6251.937480625135, 6313.40022697843, 6321.0, 6364.268109167319, 6224.844378890382, 6233.127362169209, 6241.188645476059, 6248.593841400295, 6280.685965701788, 6037.215162028908, 6221.035739460391, 6230.43926046658, 6235.438810507076, 6239.688015599293, 5874.765009399576, 6016.368281330572, 6085.0, 6086.1175129606845, 6099.207103076749, 6202.5658203925295, 6233.096201050732, 6238.594491358229, 6254.718537665725, 6274.058891166179, 6096.1465394845645, 6099.11562823397, 6103.3591472894705, 6112.510999120149, 6122.846928826815], "unit": "score", "name": "dojo.html", "value": 5783.465964432518}, {"lowerIsBetter": false, "replicates": [475.0854604885594, 587.7178954102031, 592.5703864698091, 654.9279579246283, 663.820768392534, 29744.0, 32610.67389326106, 40980.59019409805, 41037.71698264139, 41110.79444602773, 44355.11289774202, 44808.775956120255, 44999.0, 45189.32216016763, 45324.320135197995, 9595.472249026301, 9832.557534910946, 9834.803303933917, 9835.90164098357, 9853.310268281222, 9544.42733435996, 9665.951670241639, 9673.22614190863, 9680.709578712615, 9842.458664773434, 9797.608095676165, 9874.01259874014, 9875.1112399884, 9877.35797173185, 9887.505624718771, 9769.560369783341, 9827.754306142333, 9836.262280328932, 9838.36050656705, 9850.50747462624, 9771.706848794547, 9885.555150018194, 9903.306768526207, 9910.851337229948, 9917.454540000297, 42743.93140171489, 43036.56963430357, 43112.3533147003, 43131.56868431307, 43348.783256083836, 3136.764742644311, 3291.7860339077884, 3382.4588065909584, 3697.186618943855, 3938.133610605662, 23622.76377236223, 29793.0, 30286.697133028607, 30291.69708302933, 30378.696213038027, 2777.527820270559, 2785.5264605017196, 2803.215099772067, 2814.5637426198973, 2852.4865524205634, 484071.0, 487029.0, 487413.0, 488817.5559122217, 488911.0, 72245.63877180581, 72767.63616181992, 72867.0, 72911.0, 73075.63462182655, 76657.233427665, 80642.79035814467, 81750.0, 81824.0, 81862.0, 18480.537986550175, 18541.536461588297, 18696.626067478846, 18717.625647486973, 18734.718979215322, 13891.0, 14001.159930404208, 14020.509282175075, 14026.158430493999, 14037.298135093204, 22410.551788964454, 22666.320010399715, 22828.31515054551, 22966.0, 22999.425014374774, 7423.740169094056, 7771.33943614799, 8243.093259741423, 8561.914380856237, 8917.73246802597, 985.5614251658087, 994.9303548751518, 1017.2980643356061, 1090.7818436312768, 1138.4250953268547, 25169.874150629497, 25856.741432585433, 30049.0, 30180.0, 30859.38281234363, 970.6457143142702, 1140.4753813246, 1151.6602602232363, 1177.935213563245, 1189.655000049993, 12019.939900300618, 15268.541943741706, 15510.0, 15582.298796554182, 15807.525774226791, 534053.0, 537391.0, 537501.0, 538552.0, 539311.0, 55571.44428555744, 61333.69333153305, 61421.38578614246, 61857.69071154615, 61949.690251548454, 1386.6186798630458, 1400.2018849255826, 1503.624093976506, 1518.096732444194, 1548.4580396861234, 29092.690828912328, 29262.414751705273, 29371.559426609045, 30023.699763002965, 30743.2314192147, 47378.0, 48709.269360958904, 48955.510444895095, 49051.01897962092, 49057.26414103863, 365288.1735591305, 368098.0, 369107.0, 369267.0, 369340.0, 29513.114606561838, 33784.66215337913, 34267.65732342644, 34837.303253935286, 34884.476732849536, 41805.1638967225, 42205.0, 42299.7885010573, 43951.78024109859, 44087.55912440835, 34391.82804085963, 35629.0, 35696.0, 35922.92231233067, 36610.45084323684, 35473.935781926586, 35607.10982225362, 35758.0, 36152.0, 36180.27639447144, 29374.412511750073, 29552.704472955855, 29609.0, 29712.702872970993, 29808.403831923675, 29936.25159371033, 32987.721964485565, 32999.845005425654, 33021.33957320888, 33026.69733026678, 24857.627135593342, 24945.75054249434, 24976.500469990136, 25490.74509254958, 25517.362065947756], "unit": "score", "name": "ext.html", "value": 20119.831311107548}, {"lowerIsBetter": false, "replicates": [375.94736736856834, 385.5219527785547, 385.97298189126764, 386.36057325126905, 389.65320864430646, 19517.12172952217, 20991.790082099174, 21505.46236344092, 21527.892360538193, 21532.461688457795, 20273.89863050683, 20632.69050964233, 20983.0, 21316.36050918475, 21441.0, 5397.190421436787, 5440.945590544084, 5553.500184983351, 5565.0, 5570.303712035975, 6037.2755269367735, 6072.483838873701, 6101.328853826076, 6104.786332478364, 6112.572119951606, 5643.351014633328, 6022.608530445529, 6081.969590152065, 6084.300305464862, 6095.29904061032, 5321.893562128756, 5489.478499542537, 5511.834644960618, 5540.695261760601, 5548.889022219573, 5297.099493086146, 5344.251804747339, 5355.3305836770405, 5357.785688572452, 5357.812476563302, 25405.74594254052, 25545.872270638527, 25843.61234581483, 26144.607830882553, 26231.475370492484, 2159.622066138435, 2203.22886989554, 2219.1012639880873, 2799.006352744787, 2807.4244779820087, 9293.256539476826, 9354.625814967394, 9399.671011514563, 9861.063198996084, 10415.68752937413, 1750.0374793863452, 1751.220706785481, 1784.1703607822426, 1804.3143605429852, 1823.4073925974112, 82340.0, 112057.0, 114072.0, 114354.42822785916, 117687.41156294163, 11580.757387931393, 11623.709407264716, 11631.360275184777, 11767.529298828122, 11983.340916249515, 14584.48954286616, 14588.41646334156, 14593.905457090761, 14626.195559244345, 14640.0, 8645.092265312178, 8890.244329231959, 8899.866502002475, 8924.55377231136, 9009.729708108636, 9112.997570267265, 9120.087991200828, 9143.588538515784, 9205.0, 9238.538073096319, 4530.88672783183, 4599.33309670096, 4601.470830854495, 4603.033362993742, 4618.1918164321105, 1635.7464592988106, 1903.4004288649032, 1952.1410579345327, 1954.921803127859, 1995.5609765851489, 932.5150921520907, 934.6962237272913, 990.7855941969692, 1015.3451024089421, 1058.0213302694976, 17283.74074388885, 20362.287319944026, 20540.794592053888, 21210.469738256357, 21265.36203913885, 998.8513209808779, 1001.234055947201, 1027.209049032241, 1046.5970601318547, 1060.4379678770265, 11113.944175303333, 11373.431328433546, 11400.771984560428, 11446.828297575543, 11475.770484590428, 626599.0, 641767.0, 643137.0, 645080.0, 650556.7472162609, 100027.0, 100141.49929250307, 109037.45481272542, 128851.0, 132388.0, 1005.7586179316911, 1016.5730393234859, 1026.08165691707, 1028.7736697926443, 1035.9015893490107, 18466.907665461586, 18800.52998675044, 19119.426417207505, 19194.848309101497, 19374.321898733477, 40282.0, 50056.749716251186, 50668.23997640112, 50813.74593127011, 52302.0, 73474.26525734675, 77635.30706450167, 78149.0, 78865.2113478858, 78924.60537697504, 8094.676212951416, 8158.796030099057, 8184.058833234254, 8209.220124088202, 8332.0, 9664.951675241578, 13025.218486890817, 13208.405621747237, 13397.12918660284, 13568.86431135676, 10906.127509799038, 11289.887101128883, 11302.265352752045, 11542.480588373712, 11696.47365868555, 11240.662780116609, 11240.887591123985, 11396.430178490877, 11616.303021818718, 11700.648980530597, 11456.312621242752, 11536.711582210177, 11584.0, 11822.704432388915, 11903.821442678194, 8062.314703250055, 8178.591070446335, 8243.340532757245, 8295.211954864279, 8540.359473039423, 10073.244506662177, 11353.829692554784, 11637.5344986203, 11691.415429228335, 11760.82358764602], "unit": "score", "name": "jquery.html", "value": 9629.103701843895}, {"lowerIsBetter": false, "replicates": [1452.520668179501, 1588.7934568506096, 1620.4571468558033, 1956.4913122588132, 2086.232957691674, 8194.303484203843, 8898.911010889897, 9089.045650206715, 9109.59006844692, 9127.0, 8806.647734090644, 9037.0, 9040.773980650487, 9049.683261085847, 9055.04921983192, 2003.827760759957, 2225.5103877147003, 2480.838745481547, 2510.5104504621604, 2537.8096642751775, 2557.6419301297833, 2561.5517284475236, 2563.0772921748157, 2568.2552059902605, 2571.3700143464876, 2349.8472599281076, 2526.077981536735, 2528.026709716754, 2530.72162062173, 2532.101104108043, 2455.484348286862, 2491.8006559475198, 2497.9750202498108, 2499.3379402697183, 2546.808989325799, 2503.374156460885, 2518.848869067862, 2530.253575195322, 2560.411105445758, 2560.5775047117204, 9196.632134714604, 9257.074292570756, 9262.305327100494, 9275.67535136267, 9276.860847087299, 5620.0, 5752.453516915886, 5799.246098007275, 5811.883762324772, 5815.21494598228, 3529.1000794797164, 3609.4224924012033, 3737.7757334560015, 3749.7750134991716, 3753.924921501582, 1040.8438734189856, 1059.8092343378266, 1064.3188359449957, 1069.8181309177457, 1101.944902754859, 9549.952250238774, 12442.0, 12471.251724896445, 12474.688132796753, 12479.688007799787, 4271.1671224111, 4714.175019371665, 4987.775550100254, 5075.2387141929, 5107.61692873036, 10602.098821600097, 10620.415877126832, 10632.255742098134, 10639.0, 10649.094826939641, 5728.942710572925, 5743.396943320975, 5747.568932330092, 5748.367679555246, 5772.797952071657, 4544.590986811137, 4716.3868697069165, 4951.752412379366, 5064.215046667772, 5090.567301779316, 3528.3119791640897, 4045.3122085774894, 4094.7952602369764, 4129.29801933672, 4162.021924847659, 1339.5847287340955, 1352.553657293091, 1356.287948826854, 1361.4282001559368, 1363.6045546791518, 1160.9013233875046, 1167.9824802627968, 1372.9977116704663, 1400.7058517711191, 1402.5161319344809, 8551.615177317035, 8569.871451928226, 8666.176713212235, 8667.653293868301, 8765.693200737944, 1247.357610830423, 1259.2570383473612, 1263.728298415845, 1268.7018550640591, 1274.5857596281246, 6535.803925882231, 6576.309487503839, 6644.534882558271, 6653.334666533308, 6684.398404143651, 10789.082927951054, 11274.92888175622, 11294.491747871365, 11307.773844523228, 11318.094552435785, 10896.945515272373, 11046.944765276123, 11087.05760010408, 11100.888991109985, 11201.495932683049, 8589.312854971588, 8662.913370866338, 8705.825883482295, 8719.825603487894, 8739.12608739121, 8260.752177434446, 8269.627866746132, 8342.082370939313, 8433.873491897504, 8437.915620843958, 9945.204383649147, 10102.949485252526, 10182.898171018194, 10255.94872025635, 10261.0, 10175.236857235885, 10468.790624187626, 10492.895071049192, 10650.254482186172, 10650.89349106499, 7025.297470252934, 7469.066366704162, 7478.102627684712, 7749.496282741604, 7826.0, 8551.0, 8551.05938346769, 8611.224989750952, 8611.913880861111, 8616.483011019109, 7528.0, 7554.773356799305, 7584.08990921093, 7681.462297639112, 7772.68909243624, 7053.800853854755, 7397.630118494161, 7458.47790654649, 7570.621468926422, 7600.239976002355, 7297.635118244173, 8077.15189905075, 8126.024877014796, 8139.7965050871835, 8158.551279679437, 7090.787276381717, 7310.195878453473, 7312.8537429250055, 7340.009098771598, 7372.373348265458, 7455.589942553212, 7463.253674632493, 7508.0990281166605, 7517.210692877388, 7518.28576285252], "unit": "score", "name": "mootools.html", "value": 5129.619026174926}, {"lowerIsBetter": false, "replicates": [329.1770573566085, 331.08124953254713, 333.36161251203913, 337.2630801698291, 337.68303615898, 5776.682282474462, 6679.899801502976, 6691.0632511448375, 6770.593764374129, 6804.6257455839905, 6316.810495685137, 6659.101021362115, 6678.833029174273, 6691.1636045494315, 6701.095352127473, 4718.764061796896, 4802.23164293713, 4831.855044348676, 4921.311016457699, 4939.061578300129, 4945.802167913279, 4953.777080031407, 4959.727215003191, 4960.404751429834, 4973.925391119136, 4900.289458028584, 4911.238757992499, 4915.311856340115, 4921.384826896638, 4923.70457772533, 4699.295105734133, 4777.426708794949, 4894.608431325485, 4896.192128298826, 4910.926336104962, 4203.852865149705, 4214.641755450791, 4218.2196293685765, 4227.682923780729, 4230.323148296288, 5207.895842083175, 5474.890502189974, 6339.703354255807, 6402.711877965457, 6483.4164925156965, 5899.852503687399, 5900.1149827526215, 5904.822855314347, 5908.261467316585, 5921.378255283219, 6854.280300568468, 7136.0, 7136.286371362874, 7137.500374973754, 7139.250378710264, 4779.880502987418, 4799.568038876483, 4800.271902115236, 4801.855944321641, 4815.181419158752, 7373.926260737378, 7543.321101100927, 7560.130584982742, 7563.848723025509, 7566.129895062083, 4886.315915771795, 4887.486813884562, 4889.315495830587, 4894.535019173173, 4913.606911447076, 4932.53140951609, 4943.307936888838, 4954.702717836942, 4967.403911530567, 4969.82605608802, 4486.68593198473, 5906.114082887515, 5911.615744976562, 5915.08316210988, 5915.526757859361, 7154.642267886585, 7169.89245161323, 7175.31834475724, 7186.209516953131, 7188.921661750779, 1683.9158042097847, 1720.1399300349824, 1720.2946791815546, 1724.3188940368484, 1725.4909801608555, 1035.5184839049878, 1071.4910417551757, 1099.9330649270196, 1105.6461932181624, 1133.1784456269138, 6467.0, 6484.708188131451, 6568.573042752301, 6581.638009909501, 6607.273199948002, 7479.775606731807, 7494.21310762373, 7494.601727447273, 7502.212267711811, 7503.5497870127965, 6124.418180272867, 6164.013757798731, 6744.5616034957575, 6769.120014398097, 6772.2211945625895, 3425.1950791563963, 3652.8128358283666, 3798.5061941947924, 3936.822842972073, 3950.762954222756, 7732.226777322223, 7774.067111946602, 7778.533288002738, 7780.416468764752, 7823.139454659983, 6838.623875686885, 7106.822329441702, 7612.619369031526, 7680.846383072419, 7682.654280557388, 7742.187070357644, 7755.2244775521995, 7761.068671759425, 7766.417518686234, 7772.961135194175, 6078.3921607838865, 7121.67952442131, 7452.254774522505, 7455.0681164854395, 7463.6641351140415, 7238.0952380952385, 7265.491415600857, 7289.088863892013, 7325.340719335285, 7340.706371745284, 7730.11103723079, 7732.497387669783, 7757.030371203599, 7760.650770715219, 7778.961105194438, 4903.166461701448, 4910.533499317559, 4915.557599816034, 4917.385326834145, 4922.310876477224, 7049.823754406181, 7358.0434543509, 7384.741534046498, 7394.223606521453, 7405.0, 7114.288571142844, 7156.749513767201, 7159.248278930846, 7163.176234733072, 7164.140303163654, 7116.25279345682, 7119.501634885508, 7128.572285662877, 7129.643517823984, 7145.499815013107, 6959.930400695928, 6961.373476386947, 6969.616671083139, 6972.930270697431, 6979.651017449209, 6915.654217289216, 7094.751683691046, 7111.928880711127, 7137.750178743719, 7169.390601798906, 6665.566738162004, 6817.693203805939, 6818.590884546943, 6823.897641535282, 6947.444204463732], "unit": "score", "name": "prototype.html", "value": 5235.4560271206665}, {"lowerIsBetter": false, "replicates": [681.8159097043801, 696.1750325863852, 731.8353370491636, 778.2451022508169, 778.8870613761003, 15150.393984240618, 15536.533903982885, 15540.689186216283, 17491.0, 17715.82284177158, 16539.751903721455, 16636.83363166368, 16734.58163545909, 16782.83217167828, 16815.41146059888, 786.657803855322, 797.4696826610298, 798.6046906781152, 964.9517524123801, 987.7530617345664, 796.8804679298094, 961.4808003678005, 989.366805244644, 989.5744829723216, 991.2912267728573, 1030.6701855406236, 1037.4034929915292, 1037.7716902281486, 1038.8961103889587, 1040.126293913113, 814.6334149632689, 1030.3508789462664, 1031.3811712972195, 1032.4063663393579, 1032.6179313653959, 615.4645458451176, 616.0020766358527, 761.003085957392, 773.6595897804948, 774.1484367196095, 15558.37766489339, 15620.531384058382, 15628.218589070615, 15660.608484787857, 15663.13852738099, 12655.683607909783, 12750.234985900875, 12843.743125137538, 12966.935165324207, 13065.934670326682, 10774.784504309948, 10968.012878840942, 11104.44477776116, 11161.72095697614, 11733.882661173364, 4179.728317659343, 4181.038361176916, 4183.6653067754505, 4273.743575385456, 4276.2516559601945, 75202.99999999945, 76238.0, 76303.61848190779, 76443.0, 83751.5812420934, 10097.596096156072, 10249.94875025635, 10262.897371026194, 10343.431111288952, 10507.47462626881, 23182.76817231806, 23183.53632927366, 23184.4203894904, 23235.7676423237, 23345.88327058388, 7047.89428158578, 7240.710371585183, 7713.7685869424, 7788.766337009899, 8138.348932085419, 4044.8584299549375, 4076.5515793262716, 4149.211649786531, 4229.0273237155625, 4383.780810959439, 3793.639604237593, 3829.965909204499, 3840.6543411092575, 3846.0577158595765, 3847.826847791856, 663.2869665110026, 679.6058286193995, 679.9014142949245, 686.543448606681, 703.2440126863642, 597.0328068528925, 605.5791225098515, 605.6910975402576, 608.428077607048, 611.4069352727847, 7789.844203115906, 8339.666413343519, 8368.539730314891, 8385.832283354299, 8388.79028024292, 417.59701887678534, 496.89068404950854, 519.9974000129976, 594.7234535940722, 618.4125081172904, 3679.68722658577, 3768.6419790120444, 3775.716821238418, 3792.184680293695, 3947.605239476087, 89015.0, 91067.54466227627, 91305.54347228355, 91523.54238228766, 91624.0, 80912.59543702244, 84362.5781871099, 84807.0, 86520.0, 86587.5670621643, 66135.33864661292, 67401.32598674048, 73074.63462682652, 74493.13767155756, 75622.9999999989, 7473.813154671177, 7526.322630963021, 7633.084029916446, 7722.420818438752, 8023.0, 38978.6102138975, 50376.0, 50495.0, 50497.0, 51716.224256635425, 69724.6513767428, 73691.63154184195, 73700.63149684218, 73896.0, 74598.0, 10149.847752283575, 10291.53688084053, 10354.792904142025, 10565.098282309258, 10802.08182304513, 10627.628033018807, 10705.464726763787, 10870.456477176267, 10956.835647465454, 11192.160587955774, 9270.675526356545, 9831.557579909064, 10214.489275536342, 10410.895891040993, 10453.0, 10931.398773067558, 11028.0, 11071.944640276746, 11448.313101213955, 11619.535218591162, 10794.73013174677, 10805.135589153006, 10930.344179349264, 11216.551337946717, 11601.12991525622, 9315.953420232856, 9398.248140148908, 9460.574274157818, 9757.902420975699, 9843.950780246052, 9649.951750241204, 9652.324337296603, 9662.516874156123, 9685.6610018649, 9703.805923881624], "unit": "score", "name": "yui.html", "value": 7048.756920476533}], "name": "dromaeo_css", "value": 7722.6085408689605}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 112.0, 112.0, 111.0, 119.0, 113.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [153.0, 119.0, 154.0, 164.0, 152.0, 172.0, 148.0, 145.0, 149.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 184.0, 182.0, 186.0, 185.0, 183.0, 183.0, 185.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [73.0, 81.0, 72.0, 111.0, 56.0, 58.0, 61.0, 60.0, 145.0, 83.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 128.0, 82.0, 78.0, 92.0, 117.0, 77.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 87.0, 89.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 96.0, 94.0, 94.0, 93.0, 97.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 87.0, 86.0, 86.0, 87.0, 87.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 59.0, 60.0, 57.0, 57.0, 58.0, 66.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 70.0, 73.0, 69.0, 68.0, 65.0, 69.0, 94.0, 104.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.4}, {"lowerIsBetter": true, "replicates": [81.0, 98.0, 106.0, 108.0, 105.0, 80.0, 79.0, 81.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.2}, {"lowerIsBetter": true, "replicates": [120.0, 131.0, 131.0, 121.0, 129.0, 119.0, 109.0, 122.0, 130.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [134.0, 125.0, 130.0, 138.0, 135.0, 123.0, 135.0, 132.0, 133.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 67.0, 64.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1429.9}]} 04:34:29 INFO - Return code: 0 04:34:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:29 INFO - # TBPL SUCCESS # 04:34:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:29 INFO - 2016-04-11 04:34:29.953 screenresolution[1680:9746] starting screenresolution argv=screenresolution get 04:34:29 INFO - 2016-04-11 04:34:29.955 screenresolution[1680:9746] Display 0: 1600x1200x32@60 04:34:29 INFO - 2016-04-11 04:34:29.962 screenresolution[1681:9749] starting screenresolution argv=screenresolution list 04:34:29 INFO - Available Modes on Display 0 04:34:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:30 INFO - Intel Iris: 04:34:30 INFO - Chipset Model: Intel Iris 04:34:30 INFO - Type: GPU 04:34:30 INFO - Bus: Built-In 04:34:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:30 INFO - Vendor: Intel (0x8086) 04:34:30 INFO - Device ID: 0x0a2e 04:34:30 INFO - Revision ID: 0x0009 04:34:30 INFO - Displays: 04:34:30 INFO - Display: 04:34:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:30 INFO - Display Serial Number: 1600x1200 60 04:34:30 INFO - Main Display: Yes 04:34:30 INFO - Mirror: Off 04:34:30 INFO - Online: Yes 04:34:30 INFO - Rotation: Supported 04:34:30 INFO - Return code: 0 04:34:30 INFO - Running post-action listener: _resource_record_post_action 04:34:30 INFO - Running post-run listener: _resource_record_post_run 04:34:31 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 37762560; Write bytes: 663175168; Read time: 458; Write time: 1860 04:34:31 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356342272; Write bytes: 353830912; Read time: 28147; Write time: 637 04:34:31 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35972608; Write bytes: 298170368; Read time: 377; Write time: 1188 04:34:31 INFO - Running post-run listener: _upload_blobber_files 04:34:31 INFO - Blob upload gear active. 04:34:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:31 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 04:34:31 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'] 04:34:31 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 04:34:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:33 INFO - (blobuploader) - INFO - Done attempting. 04:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:34 INFO - (blobuploader) - INFO - Done attempting. 04:34:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:34 INFO - Return code: 0 04:34:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b892343c4d455fc437aa814432202fbad24120a3b9121ea593d1fc3e140b844f4e9e6e84dc02d149f7dbb17c1ead9c8a54facb7679de915a8de7eaad30d520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ae1a69d01c6667e3267c6ba03c435ed5626301ff401f42fc02c06a91e989e5a0dd67f9b5ef04a47974a5ab9988f40969f6c64ea4b37ebcc3472ad7a9a0f78a"} 04:34:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:34 INFO - Contents: 04:34:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b892343c4d455fc437aa814432202fbad24120a3b9121ea593d1fc3e140b844f4e9e6e84dc02d149f7dbb17c1ead9c8a54facb7679de915a8de7eaad30d520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ae1a69d01c6667e3267c6ba03c435ed5626301ff401f42fc02c06a91e989e5a0dd67f9b5ef04a47974a5ab9988f40969f6c64ea4b37ebcc3472ad7a9a0f78a"} 04:34:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:34 INFO - Copying logs to upload dir... 04:34:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.217196 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-11 04:34:34.377871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 04:34:34.381249) ========= 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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b892343c4d455fc437aa814432202fbad24120a3b9121ea593d1fc3e140b844f4e9e6e84dc02d149f7dbb17c1ead9c8a54facb7679de915a8de7eaad30d520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ae1a69d01c6667e3267c6ba03c435ed5626301ff401f42fc02c06a91e989e5a0dd67f9b5ef04a47974a5ab9988f40969f6c64ea4b37ebcc3472ad7a9a0f78a"} build_url:https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011007 build_url: 'https://queue.taskcluster.net/v1/task/CxKRMMauRICGxlACJLOLpw/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25b892343c4d455fc437aa814432202fbad24120a3b9121ea593d1fc3e140b844f4e9e6e84dc02d149f7dbb17c1ead9c8a54facb7679de915a8de7eaad30d520", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47ae1a69d01c6667e3267c6ba03c435ed5626301ff401f42fc02c06a91e989e5a0dd67f9b5ef04a47974a5ab9988f40969f6c64ea4b37ebcc3472ad7a9a0f78a"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 04:34:34.433152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:34:34.433466) ========= 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.yaKGdJgfZJ/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.8Wb8Dar86n/Listeners TMPDIR=/var/folders/7f/3lpp9ct90ln73152f8wy_3th00000w/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.005130 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 04:34:34.484189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 04:34:34.484509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 04:34:34.484857) ========= ========= Total master_lag: 0.32 =========