builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1458330835.87 results: success (0) buildid: 20160318115308 builduid: fb3ca00ee6244c2bba3cb88ce0246501 revision: c6af39f64775b5a8a71e08e2fb28436fd990b401 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 12:53:55.868130) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 12:53:55.868556) ========= ========= Started set props: basedir (results: 0, elapsed: 54 secs) (at 2016-03-18 12:53:55.868858) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005152 basedir: '/builds/slave/test' ========= master_lag: 54.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 54 secs) (at 2016-03-18 12:54:49.900051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 mins, 14 secs) (at 2016-03-18 12:54:49.900350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 mins, 14 secs) (at 2016-03-18 12:56:04.718412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 17 secs) (at 2016-03-18 12:56:04.718704) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.006441 ========= master_lag: 17.32 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 17 secs) (at 2016-03-18 12:56:22.048269) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 12:56:22.048571) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 12:56:22.051551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-18 12:56:22.051862) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-03-18 12:56:22-- 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% 178M=0s 2016-03-18 12:56:23 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.465425 ========= master_lag: 9.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-18 12:56:31.809423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-18 12:56:31.809698) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.026434 ========= master_lag: 6.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-03-18 12:56:37.939611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-18 12:56:37.942944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c6af39f64775b5a8a71e08e2fb28436fd990b401 --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 c6af39f64775b5a8a71e08e2fb28436fd990b401 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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-03-18 12:56:38,936 truncating revision to first 12 chars 2016-03-18 12:56:38,936 Setting DEBUG logging. 2016-03-18 12:56:38,936 attempt 1/10 2016-03-18 12:56:38,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c6af39f64775?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 12:56:40,011 unpacking tar archive at: mozilla-aurora-c6af39f64775/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327662 ========= master_lag: 9.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-03-18 12:56:48.621452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 3 secs) (at 2016-03-18 12:56:48.621760) ========= echo c6af39f64775b5a8a71e08e2fb28436fd990b401 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c6af39f64775b5a8a71e08e2fb28436fd990b401'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 c6af39f64775b5a8a71e08e2fb28436fd990b401 program finished with exit code 0 elapsedTime=0.005902 script_repo_revision: 'c6af39f64775b5a8a71e08e2fb28436fd990b401' ========= master_lag: 3.54 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 3 secs) (at 2016-03-18 12:56:52.169583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-18 12:56:52.169875) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-03-18 12:56:54.877759) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-18 12:56:54.881119) ========= /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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:56:58 INFO - MultiFileLogger online at 20160318 12:56:58 in /builds/slave/test 12:56:58 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 12:56:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:56:58 INFO - {'append_to_log': False, 12:56:58 INFO - 'base_work_dir': '/builds/slave/test', 12:56:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:56:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:56:58 INFO - 'branch': 'Mozilla-Aurora', 12:56:58 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:58 INFO - 'config_files': ('talos/mac_config.py',), 12:56:58 INFO - 'default_actions': ('clobber', 12:56:58 INFO - 'read-buildbot-config', 12:56:58 INFO - 'download-and-extract', 12:56:58 INFO - 'populate-webroot', 12:56:58 INFO - 'create-virtualenv', 12:56:58 INFO - 'install', 12:56:58 INFO - 'run-tests'), 12:56:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:58 INFO - 'download_minidump_stackwalk': True, 12:56:58 INFO - 'download_symbols': 'ondemand', 12:56:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:58 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:58 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:58 INFO - 'installer_path': 'installer.exe', 12:56:58 INFO - 'log_level': 'info', 12:56:58 INFO - 'log_name': 'talos', 12:56:58 INFO - 'log_to_console': True, 12:56:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:56:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:56:58 INFO - 'opt_config_files': (), 12:56:58 INFO - 'pip_index': False, 12:56:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:56:58 INFO - 'cmd': ('bash', 12:56:58 INFO - '-c', 12:56:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:56:58 INFO - 'enabled': True, 12:56:58 INFO - 'halt_on_failure': False, 12:56:58 INFO - 'name': 'check_screen_resolution'},), 12:56:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:56:58 INFO - 'cmd': ('bash', 12:56:58 INFO - '-c', 12:56:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:56:58 INFO - 'enabled': True, 12:56:58 INFO - 'halt_on_failure': False, 12:56:58 INFO - 'name': 'check_screen_resolution'},), 12:56:58 INFO - 'run_cmd_checks_enabled': True, 12:56:58 INFO - 'sps_profile': False, 12:56:58 INFO - 'sps_profile_interval': 0, 12:56:58 INFO - 'suite': 'dromaeojs', 12:56:58 INFO - 'system_bits': '32', 12:56:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:58 INFO - 'title': 't-yosemite-r7-0051', 12:56:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:58 INFO - 'use_talos_json': True, 12:56:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:56:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:58 INFO - 'work_dir': 'build'} 12:56:58 INFO - ##### 12:56:58 INFO - ##### Running clobber step. 12:56:58 INFO - ##### 12:56:58 INFO - Running pre-action listener: _resource_record_pre_action 12:56:58 INFO - Running main action method: clobber 12:56:58 INFO - rmtree: /builds/slave/test/build 12:56:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:00 INFO - Running post-action listener: _resource_record_post_action 12:57:00 INFO - ##### 12:57:00 INFO - ##### Running read-buildbot-config step. 12:57:00 INFO - ##### 12:57:00 INFO - Running pre-action listener: _resource_record_pre_action 12:57:00 INFO - Running main action method: read_buildbot_config 12:57:00 INFO - Using buildbot properties: 12:57:00 INFO - { 12:57:00 INFO - "project": "", 12:57:00 INFO - "product": "firefox", 12:57:00 INFO - "script_repo_revision": "production", 12:57:00 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:57:00 INFO - "repository": "", 12:57:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:57:00 INFO - "buildid": "20160318115308", 12:57:00 INFO - "pgo_build": "False", 12:57:00 INFO - "basedir": "/builds/slave/test", 12:57:00 INFO - "buildnumber": 240, 12:57:00 INFO - "slavename": "t-yosemite-r7-0051", 12:57:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:57:00 INFO - "platform": "yosemite_r7", 12:57:00 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:57:00 INFO - "branch": "mozilla-aurora", 12:57:00 INFO - "repo_path": "releases/mozilla-aurora", 12:57:00 INFO - "revision": "c6af39f64775b5a8a71e08e2fb28436fd990b401", 12:57:00 INFO - "stage_platform": "macosx64", 12:57:00 INFO - "builduid": "fb3ca00ee6244c2bba3cb88ce0246501", 12:57:00 INFO - "slavebuilddir": "test" 12:57:00 INFO - } 12:57:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 12:57:00 INFO - Running post-action listener: _resource_record_post_action 12:57:00 INFO - ##### 12:57:00 INFO - ##### Running download-and-extract step. 12:57:00 INFO - ##### 12:57:00 INFO - Running pre-action listener: _resource_record_pre_action 12:57:00 INFO - Running main action method: download_and_extract 12:57:00 INFO - mkdir: /builds/slave/test/build/tests 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:00 INFO - https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 12:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 12:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:01 INFO - Downloaded 1277 bytes. 12:57:01 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 12:57:01 INFO - Using the following test package requirements: 12:57:01 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:57:01 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 12:57:01 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 12:57:01 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'jsshell-mac.zip'], 12:57:01 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 12:57:01 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:57:01 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 12:57:01 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 12:57:01 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 12:57:01 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 12:57:01 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 12:57:01 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 12:57:01 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:57: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')]} 12:57:01 INFO - https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:02 INFO - Downloaded 17867804 bytes. 12:57:02 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'] 12:57:02 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 12:57:05 INFO - Return code: 0 12:57:05 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 12:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:05 INFO - https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:57:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:57:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 12:57:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:09 INFO - Downloaded 17867804 bytes. 12:57:09 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'] 12:57:09 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 12:57:12 INFO - Return code: 0 12:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:12 INFO - https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:57:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 12:57:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 12:57:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:13 INFO - Downloaded 10845161 bytes. 12:57:13 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'] 12:57:13 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 12:57:14 INFO - Return code: 0 12:57:14 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')]} 12:57:14 INFO - https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 12:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 12:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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 12:57:17 INFO - Downloaded 114983995 bytes. 12:57:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:57:17 INFO - mkdir: /builds/slave/test/properties 12:57:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:17 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:17 INFO - Contents: 12:57:17 INFO - build_url:https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 12:57:18 INFO - Running post-action listener: _resource_record_post_action 12:57:18 INFO - Running post-action listener: set_extra_try_arguments 12:57:18 INFO - ##### 12:57:18 INFO - ##### Running populate-webroot step. 12:57:18 INFO - ##### 12:57:18 INFO - Running pre-action listener: _resource_record_pre_action 12:57:18 INFO - Running main action method: populate_webroot 12:57:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:18 INFO - '--tppagecycles', 12:57:18 INFO - '7'], 12:57:18 INFO - 'tests': ['tsvgm']}}, 12:57:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:57:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:57:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'tests': ['damp', 'tps']}, 12:57:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['damp', 'tps']}, 12:57:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:57:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:18 INFO - 'other': {'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'other_l64': {'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'other_nol64': {'tests': ['a11yr', 12:57:18 INFO - 'ts_paint', 12:57:18 INFO - 'tpaint', 12:57:18 INFO - 'sessionrestore', 12:57:18 INFO - 'sessionrestore_no_auto_restore', 12:57:18 INFO - 'tabpaint']}, 12:57:18 INFO - 'svgr': {'tests': ['tsvgx', 12:57:18 INFO - 'tsvgr_opacity', 12:57:18 INFO - 'tart', 12:57:18 INFO - 'tscrollx', 12:57:18 INFO - 'cart']}, 12:57:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['tsvgx', 12:57:18 INFO - 'tsvgr_opacity', 12:57:18 INFO - 'tart', 12:57:18 INFO - 'tscrollx', 12:57:18 INFO - 'cart']}, 12:57:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'tests': ['tp5o']}, 12:57:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'talos_options': ['--e10s'], 12:57:18 INFO - 'tests': ['tp5o']}, 12:57:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'talos_options': ['--xperf_path', 12:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:18 INFO - 'tests': ['tp5n']}, 12:57:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:18 INFO - 'talos_options': ['--e10s', 12:57:18 INFO - '--xperf_path', 12:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:18 INFO - 'tests': ['tp5n']}}, 12:57:18 INFO - 'talos.zip': {'path': '', 12:57:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:18 INFO - Running post-action listener: _resource_record_post_action 12:57:18 INFO - ##### 12:57:18 INFO - ##### Running create-virtualenv step. 12:57:18 INFO - ##### 12:57:18 INFO - Running pre-action listener: _resource_record_pre_action 12:57:18 INFO - Running main action method: create_virtualenv 12:57:18 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:18 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 12:57:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:18 INFO - Using real prefix '/tools/python27' 12:57:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:19 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:22 INFO - Installing pip.................done. 12:57:22 INFO - Return code: 0 12:57:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:22 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:22 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 12:57:22 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 12:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:22 INFO - 'HOME': '/Users/cltbld', 12:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:22 INFO - 'LOGNAME': 'cltbld', 12:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:22 INFO - 'MOZ_NO_REMOTE': '1', 12:57:22 INFO - 'NO_EM_RESTART': '1', 12:57:22 INFO - 'PAGER': '/bin/cat', 12:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:22 INFO - 'PWD': '/builds/slave/test', 12:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:22 INFO - 'SHELL': '/bin/bash', 12:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:22 INFO - 'USER': 'cltbld', 12:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:22 INFO - 'XPC_FLAGS': '0x0', 12:57:22 INFO - 'XPC_SERVICE_NAME': '0', 12:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:22 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 12:57:22 INFO - Cleaning up... 12:57:22 INFO - Return code: 0 12:57:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:22 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:22 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 12:57:22 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 12:57:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:22 INFO - 'HOME': '/Users/cltbld', 12:57:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:22 INFO - 'LOGNAME': 'cltbld', 12:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:22 INFO - 'MOZ_NO_REMOTE': '1', 12:57:22 INFO - 'NO_EM_RESTART': '1', 12:57:22 INFO - 'PAGER': '/bin/cat', 12:57:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:22 INFO - 'PWD': '/builds/slave/test', 12:57:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:22 INFO - 'SHELL': '/bin/bash', 12:57:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:22 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:22 INFO - 'USER': 'cltbld', 12:57:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:22 INFO - 'XPC_FLAGS': '0x0', 12:57:22 INFO - 'XPC_SERVICE_NAME': '0', 12:57:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:22 INFO - Downloading/unpacking psutil>=0.7.1 12:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:25 INFO - Installing collected packages: psutil 12:57:25 INFO - Running setup.py install for psutil 12:57:25 INFO - building 'psutil._psutil_osx' extension 12:57:25 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 12:57:26 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 12:57:26 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 12:57:26 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 12:57:26 INFO - building 'psutil._psutil_posix' extension 12:57:26 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 12:57:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:57:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:57:26 INFO - ^ 12:57:26 INFO - 1 warning generated. 12:57:26 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 12:57:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:26 INFO - Successfully installed psutil 12:57:26 INFO - Cleaning up... 12:57:26 INFO - Return code: 0 12:57:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:26 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:26 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 12:57:26 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 12:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:26 INFO - 'HOME': '/Users/cltbld', 12:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:26 INFO - 'LOGNAME': 'cltbld', 12:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:26 INFO - 'MOZ_NO_REMOTE': '1', 12:57:26 INFO - 'NO_EM_RESTART': '1', 12:57:26 INFO - 'PAGER': '/bin/cat', 12:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:26 INFO - 'PWD': '/builds/slave/test', 12:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:26 INFO - 'SHELL': '/bin/bash', 12:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:26 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:26 INFO - 'USER': 'cltbld', 12:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:26 INFO - 'XPC_FLAGS': '0x0', 12:57:26 INFO - 'XPC_SERVICE_NAME': '0', 12:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:57:27 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 12:57:27 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 12:57:27 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 12:57:27 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 12:57:27 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 12:57:27 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 12:57:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:57:29 INFO - Installing collected packages: mozsystemmonitor 12:57:29 INFO - Running setup.py install for mozsystemmonitor 12:57:29 INFO - Successfully installed mozsystemmonitor 12:57:29 INFO - Cleaning up... 12:57:29 INFO - Return code: 0 12:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:29 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:29 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 12:57:29 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 12:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:29 INFO - 'HOME': '/Users/cltbld', 12:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:29 INFO - 'LOGNAME': 'cltbld', 12:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:29 INFO - 'MOZ_NO_REMOTE': '1', 12:57:29 INFO - 'NO_EM_RESTART': '1', 12:57:29 INFO - 'PAGER': '/bin/cat', 12:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:29 INFO - 'PWD': '/builds/slave/test', 12:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:29 INFO - 'SHELL': '/bin/bash', 12:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:29 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:29 INFO - 'USER': 'cltbld', 12:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:29 INFO - 'XPC_FLAGS': '0x0', 12:57:29 INFO - 'XPC_SERVICE_NAME': '0', 12:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:30 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 12:57:30 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 12:57:30 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 12:57:30 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 12:57:30 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 12:57:30 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 12:57:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 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 12:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:33 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 12:57:33 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 12:57:33 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 12:57:33 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 12:57:33 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 12:57:33 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 12:57:33 INFO - Downloading docopt-0.6.1.tar.gz 12:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:33 INFO - Running setup.py install for blobuploader 12:57:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:33 INFO - Running setup.py install for requests 12:57:34 INFO - Running setup.py install for docopt 12:57:34 INFO - Successfully installed blobuploader requests docopt 12:57:34 INFO - Cleaning up... 12:57:34 INFO - Return code: 0 12:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:34 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')]} 12:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:34 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')]} 12:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:34 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:34 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 12:57:34 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 12:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:34 INFO - 'HOME': '/Users/cltbld', 12:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:34 INFO - 'LOGNAME': 'cltbld', 12:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:34 INFO - 'MOZ_NO_REMOTE': '1', 12:57:34 INFO - 'NO_EM_RESTART': '1', 12:57:34 INFO - 'PAGER': '/bin/cat', 12:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:34 INFO - 'PWD': '/builds/slave/test', 12:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:34 INFO - 'SHELL': '/bin/bash', 12:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:34 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:34 INFO - 'USER': 'cltbld', 12:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:34 INFO - 'XPC_FLAGS': '0x0', 12:57:34 INFO - 'XPC_SERVICE_NAME': '0', 12:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-mOjKSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:34 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8ObdP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-M_QkQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-wrjjUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-xNjE_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BtXnpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZQmgjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-qIaQak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BNtHR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-oXDUCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8TMltt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:35 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hyzOf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2wCeH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-YztlS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BjJWbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ejs855-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:36 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-imKiut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:36 INFO - Running setup.py install for manifestparser 12:57:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:36 INFO - Running setup.py install for mozcrash 12:57:36 INFO - Running setup.py install for mozdebug 12:57:36 INFO - Running setup.py install for mozdevice 12:57:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Running setup.py install for mozfile 12:57:37 INFO - Running setup.py install for mozhttpd 12:57:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Running setup.py install for mozinfo 12:57:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Running setup.py install for mozInstall 12:57:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:37 INFO - Running setup.py install for mozleak 12:57:37 INFO - Running setup.py install for mozlog 12:57:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Running setup.py install for moznetwork 12:57:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Running setup.py install for mozprocess 12:57:38 INFO - Running setup.py install for mozprofile 12:57:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Running setup.py install for mozrunner 12:57:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:38 INFO - Running setup.py install for mozscreenshot 12:57:38 INFO - Running setup.py install for moztest 12:57:38 INFO - Running setup.py install for mozversion 12:57:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:39 INFO - Cleaning up... 12:57:39 INFO - Return code: 0 12:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:39 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:39 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 12:57:39 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 12:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:39 INFO - 'HOME': '/Users/cltbld', 12:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:39 INFO - 'LOGNAME': 'cltbld', 12:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:39 INFO - 'MOZ_NO_REMOTE': '1', 12:57:39 INFO - 'NO_EM_RESTART': '1', 12:57:39 INFO - 'PAGER': '/bin/cat', 12:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:39 INFO - 'PWD': '/builds/slave/test', 12:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:39 INFO - 'SHELL': '/bin/bash', 12:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:39 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:39 INFO - 'USER': 'cltbld', 12:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:39 INFO - 'XPC_FLAGS': '0x0', 12:57:39 INFO - 'XPC_SERVICE_NAME': '0', 12:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9a4y1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:39 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)) 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Zrjc0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:39 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)) 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-3zLPmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:39 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)) 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Tk1sWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:39 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)) 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_7uHV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:39 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)) 12:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-OuomUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BW_YtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-dGJmL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-i_oN34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-LWlWMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zzUh80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Av8g2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MHmSYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-rD8KgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FAu80n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:40 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)) 12:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:40 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-OR55MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:41 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)) 12:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:41 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-WiacYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:41 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)) 12:57:41 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)) 12:57:41 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)) 12:57:41 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)) 12:57:41 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)) 12:57:41 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)) 12:57:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:43 INFO - Downloading blessings-1.6.tar.gz 12:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:43 INFO - Installing collected packages: blessings 12:57:43 INFO - Running setup.py install for blessings 12:57:43 INFO - Successfully installed blessings 12:57:43 INFO - Cleaning up... 12:57:43 INFO - Return code: 0 12:57:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:44 INFO - Reading from file tmpfile_stdout 12:57:44 INFO - Current package versions: 12:57:44 INFO - blessings == 1.6 12:57:44 INFO - blobuploader == 1.2.4 12:57:44 INFO - docopt == 0.6.1 12:57:44 INFO - manifestparser == 1.1 12:57:44 INFO - mozInstall == 1.12 12:57:44 INFO - mozcrash == 0.17 12:57:44 INFO - mozdebug == 0.1 12:57:44 INFO - mozdevice == 0.48 12:57:44 INFO - mozfile == 1.2 12:57:44 INFO - mozhttpd == 0.7 12:57:44 INFO - mozinfo == 0.9 12:57:44 INFO - mozleak == 0.1 12:57:44 INFO - mozlog == 3.1 12:57:44 INFO - moznetwork == 0.27 12:57:44 INFO - mozprocess == 0.22 12:57:44 INFO - mozprofile == 0.28 12:57:44 INFO - mozrunner == 6.11 12:57:44 INFO - mozscreenshot == 0.1 12:57:44 INFO - mozsystemmonitor == 0.0 12:57:44 INFO - moztest == 0.7 12:57:44 INFO - mozversion == 1.4 12:57:44 INFO - psutil == 3.1.1 12:57:44 INFO - requests == 1.2.3 12:57:44 INFO - wsgiref == 0.1.2 12:57:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:44 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 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:44 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 12:57:44 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 12:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:44 INFO - 'HOME': '/Users/cltbld', 12:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:44 INFO - 'LOGNAME': 'cltbld', 12:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:44 INFO - 'MOZ_NO_REMOTE': '1', 12:57:44 INFO - 'NO_EM_RESTART': '1', 12:57:44 INFO - 'PAGER': '/bin/cat', 12:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:44 INFO - 'PWD': '/builds/slave/test', 12:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:44 INFO - 'SHELL': '/bin/bash', 12:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:44 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:44 INFO - 'USER': 'cltbld', 12:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:44 INFO - 'XPC_FLAGS': '0x0', 12:57:44 INFO - 'XPC_SERVICE_NAME': '0', 12:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 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)) 12:57:44 INFO - Cleaning up... 12:57:44 INFO - Return code: 0 12:57:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:44 INFO - 'HOME': '/Users/cltbld', 12:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:44 INFO - 'LOGNAME': 'cltbld', 12:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:44 INFO - 'MOZ_NO_REMOTE': '1', 12:57:44 INFO - 'NO_EM_RESTART': '1', 12:57:44 INFO - 'PAGER': '/bin/cat', 12:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:44 INFO - 'PWD': '/builds/slave/test', 12:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:44 INFO - 'SHELL': '/bin/bash', 12:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:44 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:44 INFO - 'USER': 'cltbld', 12:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:44 INFO - 'XPC_FLAGS': '0x0', 12:57:44 INFO - 'XPC_SERVICE_NAME': '0', 12:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:44 INFO - Downloading/unpacking jsonschema 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:47 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:47 INFO - warning: no files found matching '*.txt' 12:57:47 INFO - no previously-included directories found matching 'build' 12:57:47 INFO - no previously-included directories found matching 'dist' 12:57:47 INFO - no previously-included directories found matching '.git*' 12:57:47 INFO - Installing collected packages: jsonschema, functools32 12:57:47 INFO - Running setup.py install for functools32 12:57:47 INFO - warning: no files found matching '*.txt' 12:57:47 INFO - no previously-included directories found matching 'build' 12:57:47 INFO - no previously-included directories found matching 'dist' 12:57:47 INFO - no previously-included directories found matching '.git*' 12:57:47 INFO - Successfully installed jsonschema functools32 12:57:47 INFO - Cleaning up... 12:57:47 INFO - Return code: 0 12:57:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5a74c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd348a530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, '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.GF6hkJkscE/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.jtw04VHDK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 12:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:47 INFO - 'HOME': '/Users/cltbld', 12:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:47 INFO - 'LOGNAME': 'cltbld', 12:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:47 INFO - 'MOZ_NO_REMOTE': '1', 12:57:47 INFO - 'NO_EM_RESTART': '1', 12:57:47 INFO - 'PAGER': '/bin/cat', 12:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:47 INFO - 'PWD': '/builds/slave/test', 12:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:47 INFO - 'SHELL': '/bin/bash', 12:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:57:47 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:47 INFO - 'USER': 'cltbld', 12:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:47 INFO - 'XPC_FLAGS': '0x0', 12:57:47 INFO - 'XPC_SERVICE_NAME': '0', 12:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:48 INFO - Downloading/unpacking flake8 12:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:51 INFO - no previously-included directories found matching 'docs/_build' 12:57:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:51 INFO - Running setup.py install for pep8 12:57:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:51 INFO - no previously-included directories found matching 'docs/_build' 12:57:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:57:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:51 INFO - Cleaning up... 12:57:52 INFO - Return code: 0 12:57:52 INFO - Running post-action listener: _resource_record_post_action 12:57:52 INFO - Running post-action listener: _start_resource_monitoring 12:57:52 INFO - Starting resource monitoring. 12:57:52 INFO - ##### 12:57:52 INFO - ##### Running install step. 12:57:52 INFO - ##### 12:57:52 INFO - Running pre-action listener: _resource_record_pre_action 12:57:52 INFO - Running main action method: install 12:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:52 INFO - Reading from file tmpfile_stdout 12:57:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:52 INFO - Reading from file tmpfile_stdout 12:57:52 INFO - Output received: 12:57:52 INFO - Usage: mozinstall [options] installer 12:57:52 INFO - Options: 12:57:52 INFO - -h, --help show this help message and exit 12:57:52 INFO - -d DEST, --destination=DEST 12:57:52 INFO - Directory to install application into. [default: 12:57:52 INFO - "/builds/slave/test"] 12:57:52 INFO - --app=APP Application being installed. [default: firefox] 12:57:52 INFO - mkdir: /builds/slave/test/build/application 12:57:52 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'] 12:57:52 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 12:58:25 INFO - Reading from file tmpfile_stdout 12:58:25 INFO - Output received: 12:58:25 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:58:25 INFO - Running post-action listener: _resource_record_post_action 12:58:25 INFO - ##### 12:58:25 INFO - ##### Running run-tests step. 12:58:25 INFO - ##### 12:58:25 INFO - Running pre-action listener: _resource_record_pre_action 12:58:25 INFO - Running main action method: run_tests 12:58:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:58:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:58:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:58:25 INFO - 2016-03-18 12:58:25.419 screenresolution[1655:8166] starting screenresolution argv=screenresolution get 12:58:25 INFO - 2016-03-18 12:58:25.421 screenresolution[1655:8166] Display 0: 1600x1200x32@60 12:58:25 INFO - 2016-03-18 12:58:25.427 screenresolution[1656:8169] starting screenresolution argv=screenresolution list 12:58:25 INFO - Available Modes on Display 0 12:58:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:58:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:58:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:58:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:58:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:58:25 INFO - Intel Iris: 12:58:25 INFO - Chipset Model: Intel Iris 12:58:25 INFO - Type: GPU 12:58:25 INFO - Bus: Built-In 12:58:25 INFO - VRAM (Dynamic, Max): 1536 MB 12:58:25 INFO - Vendor: Intel (0x8086) 12:58:25 INFO - Device ID: 0x0a2e 12:58:25 INFO - Revision ID: 0x0009 12:58:25 INFO - Displays: 12:58:25 INFO - Display: 12:58:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:58:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:58:25 INFO - Display Serial Number: 1600x1200 60 12:58:25 INFO - Main Display: Yes 12:58:25 INFO - Mirror: Off 12:58:25 INFO - Online: Yes 12:58:25 INFO - Rotation: Supported 12:58:25 INFO - Return code: 0 12:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:58:25 INFO - Python 2.7.3 12:58:25 INFO - Return code: 0 12:58:25 INFO - grabbing minidump binary from tooltool 12:58:25 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')]} 12:58:25 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 0x10d444d30>, '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 0x10d2a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d43bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:58:25 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 12:58:25 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 12:58:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:25 INFO - Return code: 0 12:58:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:58:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:58:26 INFO - Return code: 0 12:58:26 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/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 12:58:26 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/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 12:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GF6hkJkscE/Render', 12:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:26 INFO - 'HOME': '/Users/cltbld', 12:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:26 INFO - 'LOGNAME': 'cltbld', 12:58:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:26 INFO - 'MOZ_NO_REMOTE': '1', 12:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:58:26 INFO - 'NO_EM_RESTART': '1', 12:58:26 INFO - 'PAGER': '/bin/cat', 12:58:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:26 INFO - 'PWD': '/builds/slave/test', 12:58:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:26 INFO - 'SHELL': '/bin/bash', 12:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jtw04VHDK8/Listeners', 12:58:26 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 12:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:26 INFO - 'USER': 'cltbld', 12:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:26 INFO - 'XPC_FLAGS': '0x0', 12:58:26 INFO - 'XPC_SERVICE_NAME': '0', 12:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:26 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/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 12:58:27 INFO - mozversion application_buildid: 20160318115308 12:58:27 INFO - mozversion application_changeset: c6af39f64775b5a8a71e08e2fb28436fd990b401 12:58:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:58:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:27 INFO - mozversion application_name: Firefox 12:58:27 INFO - mozversion application_remotingname: firefox-dev 12:58:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:58:27 INFO - mozversion application_vendor: Mozilla 12:58:27 INFO - mozversion application_version: 47.0a2 12:58:27 INFO - mozversion platform_buildid: 20160318115308 12:58:27 INFO - mozversion platform_changeset: c6af39f64775b5a8a71e08e2fb28436fd990b401 12:58:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:58:27 INFO - mozversion platform_version: 47.0a2 12:58:27 INFO - using testdate: 1458331107 12:58:27 INFO - actual date: 1458331107 12:58:27 INFO - starting webserver on 'localhost:49272' 12:58:27 INFO - SUITE-START | Running 2 tests 12:58:27 INFO - TEST-START | dromaeo_css 12:58:27 INFO - operating with platform_type : mac_ 12:58:27 INFO - Initialising browser for dromaeo_css test... 12:58:27 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpOsg2UG/profile http://localhost:49272/getInfo.html) 12:58:29 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 12:58:29 INFO - PROCESS | 1674 | colorDepth:24 12:58:29 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 12:58:29 INFO - PROCESS | 1674 | __metrics 12:58:29 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" 12:58:29 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] 12:58:30 INFO - TEST-INFO | 1674: exit 0 12:58:30 INFO - Browser initialized. 12:58:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:30 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpOsg2UG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:41 INFO - PROCESS | 1677 | RSS: Main: 210628608 12:58:41 INFO - PROCESS | 1677 | 12:59:33 INFO - PROCESS | 1677 | 1458331173085 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] 13:01:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 13:01:44 INFO - PROCESS | 1677 | RSS: Main: 351354880 13:01:44 INFO - PROCESS | 1677 | 13:04:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 13:04:47 INFO - PROCESS | 1677 | RSS: Main: 345292800 13:04:47 INFO - PROCESS | 1677 | 13:07:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 13:07:50 INFO - PROCESS | 1677 | RSS: Main: 348889088 13:07:50 INFO - PROCESS | 1677 | 13:10:52 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 13:10:53 INFO - PROCESS | 1677 | RSS: Main: 308383744 13:10:53 INFO - PROCESS | 1677 | 13:13:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 13:13:56 INFO - PROCESS | 1677 | RSS: Main: 311914496 13:13:56 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 13:16:59 INFO - PROCESS | 1677 | RSS: Main: 356929536 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | __start_tp_report 13:16:59 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 13:16:59 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 13:16:59 INFO - PROCESS | 1677 | |i|pagename|runs| 13:16:59 INFO - PROCESS | 1677 | |0;dojo.html;2926.795124341296;3475.635058318875;3499.7550171487997;3500.772449790762;3548.7693299935504;5698.401667824881;5710;5722.484976352122;5742.023855944489;5750.079987202049;5712.800051998181;5734.79928202513;5746.396628354026;5749.367569567345;5752.539796816255;5087.287779710843;5130.538251557359;5151.098557752397;5197.376314842205;5218.634695571312;5203.713795741232;5205.037068142406;5210.973945130288;5217.973910130444;5221.138512145491;5168.767405466763;5174.689518628876;5212.035773381917;5223.764930578133;5253.527182553569;5205.739713014353;5265.76304066318;5270.8155214567305;5279.260903473517;5301.522862942354;5009.524095210949;5168.22476628505;5170.431252562215;5187.896242075175;5192.376914770214;5541.806036788693;5607.859803504945;5614.606977511535;5619.072852979253;5646.745896434629;6138;6241.375862413723;6303.621782693053;6312.053192021188;6314.116023756677;6196.659183744892;6239.563230573862;6251.156093927307;6256.436920677161;6270.905936410957;5741.9951508486265;5764.33710123337;5774.133879918004;5853;5874.530037596982;6299.716512756937;6324.3043265240785;6325.146105275729;6326.557141000086;6499.05763664266;6145.907811382833;6156.168162645234;6192.907106393408;6199;6218;6130.306415576139;6215.844603884939;6304.338044505353;6307.180066591313;6334.904976425358;5233.476652334736;6226.59527130735;6267.843303917439;6273.811785646438;6280.214973128359;6252.624842509464;6257.593256438408;6296.118543403927;6332.936670633327;6334.3032266450655;4651.09303685778;4821.63837712173;4884.633652476078;4906.55840974314;4926.064047830901;4346.826126954887;4387.188370151533;4413.845515406945;4423.137488189772;4424.380586717862;5687.175359572839;5688.829335119953;5700.315962084494;5707.885842283131;5746.9712651436475;6153;6220.782272620437;6284.497240220863;6296.779612713533;6348.555601107878;5703.572232082527;5705.914411283834;5709.571782116358;5710.971445142748;5712.514436272881;5260.026895024433;5352.65207761502;5372.865678358073;5374.3013408256675;5384.488473595002;6236.345183755731;6289.150964619809;6305.936940630535;6322.430981211713;6447.000714889294;6064.939350606437;6075.605085669417;6077.149199112217;6088.6042407243385;6107.6640784757265;5206.765695543634;6112.633242005494;6210.534209934363;6223.37766223374;6274.215723034621;6158.3225845157895;6169.5064394849205;6180.320164781961;6228.28374736893;6255.218097737783;5125.821061155881;5844.386339434468;6324.272708638566;6339.96830015847;6341.746330146927;5897.67562784051;5944.405559444021;6034.2155519782145;6139.201903752483;6144.692765361625;5049.8737531562;5971.462568368694;6119.112728654409;6121.387861213843;6131.049687298476;5966.284045914518;5976.073708575178;5985.371535988658;5990.7004649768205;5991.880162396815;5935.376785437467;5993.280806303272;6013.548983826143;6074.848128796815;6133.938660613337;5889.528837692888;5913.201717768046;5959.940400596112;6010.609310394811;6036.426539478743 13:16:59 INFO - PROCESS | 1677 | |1;ext.html;503.63486472307557;590.763694522191;609.4697613076625;644.432899048837;667.9565828221165;31760.84119579402;32368.838155809248;32371.762823717647;39837.203255934866;40543.39184912229;43556;43882.56117438825;43944.3408348875;44017;44085.7795711021;9568.760780980461;9804.656837010705;9808.362456440344;9812.50937453128;9814.754631134207;9476.620935162586;9628.807423851518;9643.276754243425;9666.854997175047;9678.56446459911;8211;9581.37721048133;9666.27502937279;9744.366616169926;9757.90242097577;9620.230381569458;9629.855552166724;9700.90299097014;9705.708828735114;9714.31999760017;9596;9717.902820971842;9734.805303893952;9741.707748767549;9753.512324383752;42702.78648606768;42769.786151069355;42841;43345;43788.68633940987;3213.1324542373663;3436.518887355772;3685.8894233173046;3706.4440333949856;3860.401637746154;29419.41161176786;29483.70516294831;29530.409391812045;29569.852150739323;29673;2748.2991837081418;2808.522551166286;2809.044924725583;2814.1557532740303;2938.147937098239;695241;698158;698869;699961.0007799866;715959;72919.90620140702;73136.26863731294;73760;73894;73932.26067739361;62293.37706622876;63925.68037159878;77457.61271193608;78005.60997194977;78009;18311.450656480327;18481.90759046196;18513.35203267879;18524.25902963893;18548.258069677333;14094.71810563783;14171.149731016172;14188.645283867985;14207.573772786833;14208;22260.666090008664;22528.774712252995;22570.322890313317;22590.887045564996;22591.20930767415;9715.174210192072;9943.552540135712;9955.701328960144;9957.302988790716;9958;958.8609651600478;984.8079624473158;1043;1102.9448527573588;1134.4101067444883;29920.85039574832;29940.550891736642;30413;30619.234519136753;30726;1141.2467771271088;1164.8369228308043;1251.0367017396554;1271.9046071544672;1279.5201799325253;15033.022853514487;15651.373945042298;16296.592585185464;16772.58068548296;16786;493096.0690393122;504376;505027;505468;505747;62486;64461.35538644647;64461.67769161124;64470;64515.67742161353;1469.1478942213491;1503.7368460519365;1507.6984603079427;1604.8796340274293;1639.2541393665854;30476.542851857685;31963.041108766774;31996.5200521997;32270.515942260416;32694.83652581722;46049;52088.47911520836;53322.2001669983;53676.19485707639;53779.46220537901;388116;400236;400287;400854;401034;30215.395692086477;34599;34614.480782788785;35552.28895422129;35763;42500.57499424966;42759.93100172521;43269.35095973626;44109.33835992527;44187.55812441834;34647;35730;36873.44689829601;39697.603023969394;41131;37987.240255194185;38256;38394.80802595969;38462.038449039;39157.60842391539;38438;38683.80658096691;38872;39095.6090439092;39185.21629567336;32570.67429325771;33630.663693363735;34338.82830585931;34362.65637343695;34483.79306724253;25386;25455.745442545336;25471.872640636677;25580.74419255858;25922.83347249416 13:16:59 INFO - PROCESS | 1677 | |2;jquery.html;320.32091965034124;384.59617401728195;384.9133944862405;394.76708741842305;396.2016536678593;16746.413875514343;20065.699014514776;20828.750274983493;21098.367048988515;21373.67939480909;17752.467425977207;20644.896775516103;21216.04527796249;21260.787392126073;22298.442538936535;5839.299284085905;5951.4048595140575;5968.194293770329;6007.068904319815;6007.068904319837;5701.116326969306;5913.822585322448;5959.493443057346;5974.731137098841;5989.1016347548;5942.6137301075505;5954.732037058321;5956.017257152586;5958.344582095988;5961.731722072495;5800.390958949313;6422.646754428504;6439.130717353191;6445.097686323895;6450.161479007723;5630.690312032878;5661.5187709044785;5664.178694089375;5666.376698563155;5666.801661941853;13614.455421783117;14159.22124283164;14166.433342666282;14168.433262669481;14175.362108705132;2083.3229200509895;2130;2201.570693714726;2316.5945959457026;2332.521833024226;9627.181689556395;10045.447500387476;10217.978202179796;10320.432376219305;10536.947315263451;1733.306677329066;1772.8670349723823;1783.6700210460976;1826.4794533557872;1871.2327945542263;81792.18207817904;102929;106155;109294;109908;11818.409079545989;11829.349385783693;11854.999999999827;11857.288562686266;11903.34531600753;14352.856471435152;14371.281435928371;14402.207878566569;14409.85590144106;14425.711485770436;8972.19250267479;8981.416207946462;8986.977929965837;9085.409448385966;9131.086891310815;9304.8604270936;9309.860352094724;9311.860322095174;9316.953415233016;9429.009953954874;3789.412641040643;4216.536181020086;4625.5836974671765;4646.4888862225125;4706.176419126639;1810.01252179036;1869.2803270740592;1942.4949513126405;1949.9122539485475;1952.8047195280642;898.3980732908836;941.9058094190526;1011.8381059030667;1025.789713108811;1036.875574930998;20218.090185941666;20465.38603841887;20986.685199722015;21551;21757.347279581638;1005.818952588541;1029.1098200057047;1042.702829693549;1047.6280920273346;1071.50175168547;11149.609763658395;11528.884711152949;11570.537178512765;11588.13089018327;11635.952764251258;623870;625083;625577;627978;649334;118596.40701796436;119254.40372798081;119785;122215;126030;1035.880873699519;1039.1894322428518;1057.460695045517;1060.109508013257;1060.6658902445704;18225.635487289914;18645.533861653566;18736.53158671044;19333.51666208356;19403.320883769;47032.7648361756;48081.27878081902;48178;48302;48916;63894;65308.673456632416;65780.6710966442;69340.65329673319;69820.95268571077;7276.7089316428865;7746.57393843344;8088.676452941816;8447.324214062983;8662.566871656518;9719.854202187114;12759.80860287115;13693.863061369259;13803.102798318077;13805.959050121222;11747.353895535827;11751.177417580688;12018.519259229533;12048.457819398323;12104.334261615344;11547.769044619228;11636.36000020007;11717.472713727731;11771;11999.04007679366;11737.119716021161;11855.229410088661;11917.404129793302;12141.575044873387;12215.389230538616;8188;8237.855979862468;8385.245327920517;8562.957185214034;8778.912210878065;8905.421147625384;10259.692209233735;11210.103191744804;11762.70593235176;12035.879641203826 13:16:59 INFO - PROCESS | 1677 | |3;mootools.html;1522.6726253855418;1665.6835201311749;1688.6875927953329;2004.3586052463208;2071.502839318563;8376.371772117092;9118.224950879176;9279.396839205447;9284.071592840712;9285.814283714322;9108.590113444894;9135.908640913589;9258.444493330388;9268.629254829799;9280.628774849014;2266.05958527211;2308.803751681101;2600.5449046416848;2634.99870049381;2635.196265139132;2633.5654616988268;2645.3254420122844;2647.0206023771134;2649.509840679471;2650.939624150336;2542.4406630541253;2580.883860226285;2604.843709377434;2606.322356187386;2606.6741657292837;2560.231930420885;2597.1429428288716;2604.5702459094227;2614.4640348728467;2614.6078088286718;2582.109172335541;2588.352911772057;2606.0487921908557;2615.9738402616113;2626.1071235779737;9259.953700231523;9352.158305752515;9352.67265645699;9366.297527685383;9394;5691.288588926384;5850.912236316459;5857.209276747627;5914.970425147847;5914.97042514789;3493.598236202844;3705.8888233352773;3791.298609757204;3858.3633700439673;3875.961240387588;985.261054209343;1067.8505009298703;1072.447689439939;1078.0567003871613;1108.8724796648407;12715.855572998382;12724.872751272555;12726.854583087566;12747.298898560575;12748.171368861087;5072.163093089599;5116.616253780981;5196.558292545176;5220.112580861262;5228.555572776357;10680.51937662807;10692.893071069346;10703.1437485001;10711.571537138427;10717.249792514449;5794.333651630032;5797.594168408171;5808.6224395414165;5813.476787089182;5820.505257053198;4615.515370886009;4680.906381872343;4713.670043097019;4727.527247275245;5243.318368612056;4135.045490399744;4170.374443833389;4219.008532994744;4244.087521182961;4252.170826688766;1362.7751421015619;1390.7774756038984;1391.6938273579797;1398.727248186594;1402.1797248609473;1166.8891455311732;1180.0913296761446;1183.816508441193;1203.2599951030054;1208.347492354119;8389.203025712548;8397.160283971676;8432.78918027042;8472.57637118154;8512.446690965067;1189.2864281431073;1235.4193529041336;1271.0530654662336;1273.5542560104075;1286.466116561635;6473.546851720334;6499.902501462482;6554.606723596599;6576.572522786004;6582.572132811352;9593.42439453635;11181.161412893904;11266;11275.379854108103;11278.492467838967;10573.418461984511;10959.83560246597;11083.445827708581;11098.2786118902;11132.721681958015;8606.397552171413;8735.301175905912;8764.693235736719;8780.253678437404;8838.690645827364;8404.159584041547;8444.155584441507;8456.985161780625;8542.06037335905;8543.8718419225;9955.402675839183;9983.550740216562;10077.748056298651;10082.890882003121;10264.127549158406;10241.436720980417;10661.573537058432;10677.412742299248;10687.732806679584;10879.347239165676;7186.748463803742;7388.889166662612;7656.961715191388;7687.346575541142;7993.6003199838615;8617.612207450555;8625.525596092024;8669.133086691281;8673.436226645248;8686.478811271343;6300.21247344082;7611.010568626043;7728.7681369559;7820.921790782019;7886;7499.775006749588;7547.73582924595;7559.773206803805;7628.42786791004;7639.88540171909;8090.231428014329;8098.919010810052;8133.593320334078;8144.144864789112;8190.180981902001;7251.419886408969;7291.125064992235;7360.521566098187;7397.926020739724;7398.223186565333;7469.215732348025;7513.812154696177;7546;7599.506032107895;7602.695892164473 13:16:59 INFO - PROCESS | 1677 | |4;prototype.html;295.47700569991116;304.71356924490976;346.88379392903374;349.68528324507923;350.46554005142156;5328.547073498752;6550.639714815683;6651.235107962573;6658.6670666466725;6680.899786503206;6544.4437222835995;6549.3123222061595;6576.835579110512;6582.4075833175;6588.945768677013;4634.86095417138;4725.267583524542;4804.183288840905;4834.395700537433;4894.902101957959;4813.061453016663;4819.5180481951875;4823.517648235166;4845.563899249067;4856.951430485703;4794.089123066607;4846.200376937801;4856.150173719602;4874.366332376804;4874.488178741234;4617.722936623796;4662.440507139131;4767.737774422405;4814.855554333376;4849.951500485021;4134.896627584304;4158.480189976253;4167.604077612622;4176.7076304658685;4179.310413781723;5386.596005299618;5936.495397891184;6220.47125994291;6242.1261023456755;6287.654179020152;5705.201271821907;5720.942790572082;5728.541716662657;5739.139129130622;5741.971290143564;5578.972105139489;6965.5124141310125;6977.406920411771;6979.336962988508;6992.965035174791;3600.567931848195;4550.840720574764;4563.566461186182;4565.452145742499;4568.977155114237;7206.675699593531;7340.4861659684375;7344.889826652605;7348.081489813773;7358.705651773923;4667.393238878924;4682.391289132459;4683.414573178353;4697.224957881979;4701.459332176843;3912.5891781363116;4736.360591320127;4741.909360847025;4749.928751068736;4756.500567440369;5462.863428414242;5587.944120558743;5603.103503439512;5618.0449323615085;5620.892165437961;6226.346233645492;6688.83277918056;6943.618101004493;6949.027136200936;6959.234484206733;1612.6049117966174;1621.6270257840763;1629.959251018734;1633.085472135608;1635.2232689472644;1001.5493028137367;1018.8522664213648;1040.9850395863973;1058.2116323339162;1069.112636511709;6272.372762723691;6362.968185159045;6368.29948705642;6415.422611964946;6541.803745887631;7318.121825380988;7319.817004574928;7327.45044121693;7332.266773322625;7376.963115184497;5361.865953351119;6393.392627700361;6399.720055988821;6540.574862633914;6574.8356291093105;3098.90703278902;3857.2092720992127;3865.8453661853773;3875;3875.1280961783373;7367.336939675348;7631.122420921665;7639;7663.501872378278;7673.501222420637;6179.721912513947;7528.51064680794;7532.698692052257;7575.24247575238;7581.658825352873;7606.733764318223;7606.885896711665;7615.581143037075;7629.504082234637;7632.084149901936;7007.544509606859;7309.342159205697;7353.77938661841;7356;7367.447441441806;5940.881182376242;7169.426445884213;7190.784276471714;7198.20819709842;7213.3868621167785;7618.542887426772;7619.923800762143;7622.466427350032;7623.275788800055;7627.161012288755;4676.929846052244;4682.601978831837;4686.906261874675;4699.295105734167;4710.4818469967595;6291.339409362135;6903.928821353675;7240.8913866290995;7253.492255542062;7262.818429539304;6696.966515167393;6938.548994315353;7015.158181018311;7020.192677842114;7057.117860267466;6982.162140543167;7027.894581581382;7036.683349249399;7046.260142684944;7050.647467626701;6888.448924086161;6890.414314783299;6895.55178913369;6896.586204827727;6918.446524278146;6799.558028728117;7031.648417579203;7043.401310888426;7049.647517623996;7050.929490705027;6606.570572912745;6750.8649827004165;6902.827429314308;6911.827204319731;6917.757878474229 13:16:59 INFO - PROCESS | 1677 | |5;yui.html;698.4530705109734;732.4579810939906;765.6171914042978;781.8319061401797;784.019975031211;12401.937990310058;14948.77576836347;15225;15296.31166597503;15305.846941530595;14047.438102475915;14101.858981410183;14121.929390353034;14143.787843182336;14155.716885662307;791.129757267006;809.2393150438598;950.064186776025;985.7437066362761;987.5062468765617;956.6077908057698;969.3795970578835;973.9074787895139;974.3471873844505;974.5565767575771;1039.1063685230695;1046.1526163807303;1046.3669479964626;1046.7278507588044;1047.9266451348408;833.0461621443444;993.0665174735725;1031.6131450705984;1031.6801791444639;1033.3489901362168;769.2807225244414;769.4114002787871;771.0169533844394;773.3272053313653;774.4307933668749;14952.40190392383;14991.325390357351;15028.323725432381;15031.549053528412;15042.32309546073;13121.803172952414;13220.933895330461;13302.401391937387;13432.932835335858;13452.461901523928;8587;10133.847992280122;10187.439690817002;10531;10679.519421626046;3495.615482296945;3545.9474530617435;3611.7291203159607;3613.4760459733193;3645.4167333226555;80742.59628701878;80749;81118;83856.58071709663;85333.57333213295;8257.587120643944;9773.338532449501;9859.408435493893;9876.061774131445;10082.899171008343;21819.236326728806;21856.89071554632;22020.559588808133;22130.88934555317;22132.88933555354;7645.961770191225;7675.347595454337;7718.228177182349;7889.802754931058;7965.402594805297;4184.727992680466;4238.809253583596;4246.256905041605;4417.690761646654;4480.932786008212;3165.4776961801044;3491.650834916488;3596.8561257549927;3599.9820000899826;3600.6399360063783;605.4036773777825;660.5244224158598;706.1032488739272;710.4848984486309;714.118064190724;568.4400865147826;588.2029849553793;606.3213701082578;608.8660494691161;640.7084776426715;8259.8348033039;8291.95854020726;8389.454685445426;8458.87311690325;8515.233628973423;586.0710773424171;590.3329237961076;591.2638764737843;622.0979579609584;625.871696302257;3795.5065841440437;3975.565494193816;4022.6580740637373;4053.088055187618;4174.770387628649;92649.53675231716;93384.06615933754;94714.5264273688;94934.10131797325;96548;70800;75799.34702285394;80348.59825700834;82221.58889205636;83954.74067888987;74974;75891.62054189804;76653.61673191599;76872.23127768762;77256.61371693105;7259.983602295789;7914.881276780968;8145.79635509117;8189.181081891763;8204.179582041748;48441.75779121082;50537.48387548379;51970.48029519656;52515.68710782108;54071.729641353115;69308.61382772417;69489;70449.64775176092;70494.64752676409;71083.64458177883;10002.799944001225;10168.33905796121;10226.6420675276;10279.331843430453;10907.890921090688;10794.676159715222;11051.944740276569;11056.447177640925;11100.61147859821;11415.942920285346;9059.773505662411;10209.642662506776;10698.679039628823;10729.195310351912;11315.434228288717;10626.256162068581;10684.83972740394;10777.08394786452;10816.621418250323;11008.724781880517;9955.402675839472;10285.84571231447;10306.278560500992;10318.742031449274;10582.417967011888;8902.993905246554;9029.322800790098;9042.457452552868;9311.487868167045;9317.068293170629;9039.096090390909;9091.181793638605;9094.727158185266;9124.635014599342;9138.268938485038 13:16:59 INFO - PROCESS | 1677 | __end_tp_report 13:16:59 INFO - PROCESS | 1677 | __start_cc_report 13:16:59 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1287 13:16:59 INFO - PROCESS | 1677 | __end_cc_report 13:16:59 INFO - PROCESS | 1677 | __startTimestamp1458332219553__endTimestamp 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | ------- Summary: start ------- 13:16:59 INFO - PROCESS | 1677 | Number of tests: 6 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5716.59 Median:5913.20 stddev:648.12 (11.0%) stddev-sans-first:612.05 13:16:59 INFO - PROCESS | 1677 | Values: 2926.8 3475.6 3499.8 3500.8 3548.8 5698.4 5710.0 5722.5 5742.0 5750.1 5712.8 5734.8 5746.4 5749.4 5752.5 5087.3 5130.5 5151.1 5197.4 5218.6 5203.7 5205.0 5211.0 5218.0 5221.1 5168.8 5174.7 5212.0 5223.8 5253.5 5205.7 5265.8 5270.8 5279.3 5301.5 5009.5 5168.2 5170.4 5187.9 5192.4 5541.8 5607.9 5614.6 5619.1 5646.7 6138.0 6241.4 6303.6 6312.1 6314.1 6196.7 6239.6 6251.2 6256.4 6270.9 5742.0 5764.3 5774.1 5853.0 5874.5 6299.7 6324.3 6325.1 6326.6 6499.1 6145.9 6156.2 6192.9 6199.0 6218.0 6130.3 6215.8 6304.3 6307.2 6334.9 5233.5 6226.6 6267.8 6273.8 6280.2 6252.6 6257.6 6296.1 6332.9 6334.3 4651.1 4821.6 4884.6 4906.6 4926.1 4346.8 4387.2 4413.8 4423.1 4424.4 5687.2 5688.8 5700.3 5707.9 5747.0 6153.0 6220.8 6284.5 6296.8 6348.6 5703.6 5705.9 5709.6 5711.0 5712.5 5260.0 5352.7 5372.9 5374.3 5384.5 6236.3 6289.2 6305.9 6322.4 6447.0 6064.9 6075.6 6077.1 6088.6 6107.7 5206.8 6112.6 6210.5 6223.4 6274.2 6158.3 6169.5 6180.3 6228.3 6255.2 5125.8 5844.4 6324.3 6340.0 6341.7 5897.7 5944.4 6034.2 6139.2 6144.7 5049.9 5971.5 6119.1 6121.4 6131.0 5966.3 5976.1 5985.4 5990.7 5991.9 5935.4 5993.3 6013.5 6074.8 6133.9 5889.5 5913.2 5959.9 6010.6 6036.4 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:68609.47 Median:39767.40 stddev:146716.85 (368.9%) stddev-sans-first:147039.32 13:16:59 INFO - PROCESS | 1677 | Values: 503.6 590.8 609.5 644.4 668.0 31760.8 32368.8 32371.8 39837.2 40543.4 43556.0 43882.6 43944.3 44017.0 44085.8 9568.8 9804.7 9808.4 9812.5 9814.8 9476.6 9628.8 9643.3 9666.9 9678.6 8211.0 9581.4 9666.3 9744.4 9757.9 9620.2 9629.9 9700.9 9705.7 9714.3 9596.0 9717.9 9734.8 9741.7 9753.5 42702.8 42769.8 42841.0 43345.0 43788.7 3213.1 3436.5 3685.9 3706.4 3860.4 29419.4 29483.7 29530.4 29569.9 29673.0 2748.3 2808.5 2809.0 2814.2 2938.1 695241.0 698158.0 698869.0 699961.0 715959.0 72919.9 73136.3 73760.0 73894.0 73932.3 62293.4 63925.7 77457.6 78005.6 78009.0 18311.5 18481.9 18513.4 18524.3 18548.3 14094.7 14171.1 14188.6 14207.6 14208.0 22260.7 22528.8 22570.3 22590.9 22591.2 9715.2 9943.6 9955.7 9957.3 9958.0 958.9 984.8 1043.0 1102.9 1134.4 29920.9 29940.6 30413.0 30619.2 30726.0 1141.2 1164.8 1251.0 1271.9 1279.5 15033.0 15651.4 16296.6 16772.6 16786.0 493096.1 504376.0 505027.0 505468.0 505747.0 62486.0 64461.4 64461.7 64470.0 64515.7 1469.1 1503.7 1507.7 1604.9 1639.3 30476.5 31963.0 31996.5 32270.5 32694.8 46049.0 52088.5 53322.2 53676.2 53779.5 388116.0 400236.0 400287.0 400854.0 401034.0 30215.4 34599.0 34614.5 35552.3 35763.0 42500.6 42759.9 43269.4 44109.3 44187.6 34647.0 35730.0 36873.4 39697.6 41131.0 37987.2 38256.0 38394.8 38462.0 39157.6 38438.0 38683.8 38872.0 39095.6 39185.2 32570.7 33630.7 34338.8 34362.7 34483.8 25386.0 25455.7 25471.9 25580.7 25922.8 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:34682.79 Median:11456.04 stddev:104343.99 (910.8%) stddev-sans-first:104604.80 13:16:59 INFO - PROCESS | 1677 | Values: 320.3 384.6 384.9 394.8 396.2 16746.4 20065.7 20828.8 21098.4 21373.7 17752.5 20644.9 21216.0 21260.8 22298.4 5839.3 5951.4 5968.2 6007.1 6007.1 5701.1 5913.8 5959.5 5974.7 5989.1 5942.6 5954.7 5956.0 5958.3 5961.7 5800.4 6422.6 6439.1 6445.1 6450.2 5630.7 5661.5 5664.2 5666.4 5666.8 13614.5 14159.2 14166.4 14168.4 14175.4 2083.3 2130.0 2201.6 2316.6 2332.5 9627.2 10045.4 10218.0 10320.4 10536.9 1733.3 1772.9 1783.7 1826.5 1871.2 81792.2 102929.0 106155.0 109294.0 109908.0 11818.4 11829.3 11855.0 11857.3 11903.3 14352.9 14371.3 14402.2 14409.9 14425.7 8972.2 8981.4 8987.0 9085.4 9131.1 9304.9 9309.9 9311.9 9317.0 9429.0 3789.4 4216.5 4625.6 4646.5 4706.2 1810.0 1869.3 1942.5 1949.9 1952.8 898.4 941.9 1011.8 1025.8 1036.9 20218.1 20465.4 20986.7 21551.0 21757.3 1005.8 1029.1 1042.7 1047.6 1071.5 11149.6 11528.9 11570.5 11588.1 11636.0 623870.0 625083.0 625577.0 627978.0 649334.0 118596.4 119254.4 119785.0 122215.0 126030.0 1035.9 1039.2 1057.5 1060.1 1060.7 18225.6 18645.5 18736.5 19333.5 19403.3 47032.8 48081.3 48178.0 48302.0 48916.0 63894.0 65308.7 65780.7 69340.7 69821.0 7276.7 7746.6 8088.7 8447.3 8662.6 9719.9 12759.8 13693.9 13803.1 13806.0 11747.4 11751.2 12018.5 12048.5 12104.3 11547.8 11636.4 11717.5 11771.0 11999.0 11737.1 11855.2 11917.4 12141.6 12215.4 8188.0 8237.9 8385.2 8563.0 8778.9 8905.4 10259.7 11210.1 11762.7 12035.9 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6370.02 Median:5094.39 stddev:3352.44 (65.8%) stddev-sans-first:3342.04 13:16:59 INFO - PROCESS | 1677 | Values: 1522.7 1665.7 1688.7 2004.4 2071.5 8376.4 9118.2 9279.4 9284.1 9285.8 9108.6 9135.9 9258.4 9268.6 9280.6 2266.1 2308.8 2600.5 2635.0 2635.2 2633.6 2645.3 2647.0 2649.5 2650.9 2542.4 2580.9 2604.8 2606.3 2606.7 2560.2 2597.1 2604.6 2614.5 2614.6 2582.1 2588.4 2606.0 2616.0 2626.1 9260.0 9352.2 9352.7 9366.3 9394.0 5691.3 5850.9 5857.2 5915.0 5915.0 3493.6 3705.9 3791.3 3858.4 3876.0 985.3 1067.9 1072.4 1078.1 1108.9 12715.9 12724.9 12726.9 12747.3 12748.2 5072.2 5116.6 5196.6 5220.1 5228.6 10680.5 10692.9 10703.1 10711.6 10717.2 5794.3 5797.6 5808.6 5813.5 5820.5 4615.5 4680.9 4713.7 4727.5 5243.3 4135.0 4170.4 4219.0 4244.1 4252.2 1362.8 1390.8 1391.7 1398.7 1402.2 1166.9 1180.1 1183.8 1203.3 1208.3 8389.2 8397.2 8432.8 8472.6 8512.4 1189.3 1235.4 1271.1 1273.6 1286.5 6473.5 6499.9 6554.6 6576.6 6582.6 9593.4 11181.2 11266.0 11275.4 11278.5 10573.4 10959.8 11083.4 11098.3 11132.7 8606.4 8735.3 8764.7 8780.3 8838.7 8404.2 8444.2 8457.0 8542.1 8543.9 9955.4 9983.6 10077.7 10082.9 10264.1 10241.4 10661.6 10677.4 10687.7 10879.3 7186.7 7388.9 7657.0 7687.3 7993.6 8617.6 8625.5 8669.1 8673.4 8686.5 6300.2 7611.0 7728.8 7820.9 7886.0 7499.8 7547.7 7559.8 7628.4 7639.9 8090.2 8098.9 8133.6 8144.1 8190.2 7251.4 7291.1 7360.5 7397.9 7398.2 7469.2 7513.8 7546.0 7599.5 7602.7 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5706.35 Median:6396.56 stddev:1833.02 (28.7%) stddev-sans-first:1792.61 13:16:59 INFO - PROCESS | 1677 | Values: 295.5 304.7 346.9 349.7 350.5 5328.5 6550.6 6651.2 6658.7 6680.9 6544.4 6549.3 6576.8 6582.4 6588.9 4634.9 4725.3 4804.2 4834.4 4894.9 4813.1 4819.5 4823.5 4845.6 4857.0 4794.1 4846.2 4856.2 4874.4 4874.5 4617.7 4662.4 4767.7 4814.9 4850.0 4134.9 4158.5 4167.6 4176.7 4179.3 5386.6 5936.5 6220.5 6242.1 6287.7 5705.2 5720.9 5728.5 5739.1 5742.0 5579.0 6965.5 6977.4 6979.3 6993.0 3600.6 4550.8 4563.6 4565.5 4569.0 7206.7 7340.5 7344.9 7348.1 7358.7 4667.4 4682.4 4683.4 4697.2 4701.5 3912.6 4736.4 4741.9 4749.9 4756.5 5462.9 5587.9 5603.1 5618.0 5620.9 6226.3 6688.8 6943.6 6949.0 6959.2 1612.6 1621.6 1630.0 1633.1 1635.2 1001.5 1018.9 1041.0 1058.2 1069.1 6272.4 6363.0 6368.3 6415.4 6541.8 7318.1 7319.8 7327.5 7332.3 7377.0 5361.9 6393.4 6399.7 6540.6 6574.8 3098.9 3857.2 3865.8 3875.0 3875.1 7367.3 7631.1 7639.0 7663.5 7673.5 6179.7 7528.5 7532.7 7575.2 7581.7 7606.7 7606.9 7615.6 7629.5 7632.1 7007.5 7309.3 7353.8 7356.0 7367.4 5940.9 7169.4 7190.8 7198.2 7213.4 7618.5 7619.9 7622.5 7623.3 7627.2 4676.9 4682.6 4686.9 4699.3 4710.5 6291.3 6903.9 7240.9 7253.5 7262.8 6697.0 6938.5 7015.2 7020.2 7057.1 6982.2 7027.9 7036.7 7046.3 7050.6 6888.4 6890.4 6895.6 6896.6 6918.4 6799.6 7031.6 7043.4 7049.6 7050.9 6606.6 6750.9 6902.8 6911.8 6917.8 13:16:59 INFO - PROCESS | 1677 | 13:16:59 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18610.76 Median:598.33 stddev:26600.39 (4445.7%) stddev-sans-first:26641.01 13:16:59 INFO - PROCESS | 1677 | Values: 698.5 732.5 765.6 781.8 784.0 12401.9 14948.8 15225.0 15296.3 15305.8 14047.4 14101.9 14121.9 14143.8 14155.7 791.1 809.2 950.1 985.7 987.5 956.6 969.4 973.9 974.3 974.6 1039.1 1046.2 1046.4 1046.7 1047.9 833.0 993.1 1031.6 1031.7 1033.3 769.3 769.4 771.0 773.3 774.4 14952.4 14991.3 15028.3 15031.5 15042.3 13121.8 13220.9 13302.4 13432.9 13452.5 8587.0 10133.8 10187.4 10531.0 10679.5 3495.6 3545.9 3611.7 3613.5 3645.4 80742.6 80749.0 81118.0 83856.6 85333.6 8257.6 9773.3 9859.4 9876.1 10082.9 21819.2 21856.9 22020.6 22130.9 22132.9 7646.0 7675.3 7718.2 7889.8 7965.4 4184.7 4238.8 4246.3 4417.7 4480.9 3165.5 3491.7 3596.9 3600.0 3600.6 605.4 660.5 706.1 710.5 714.1 568.4 588.2 606.3 608.9 640.7 8259.8 8292.0 8389.5 8458.9 8515.2 586.1 590.3 591.3 622.1 625.9 3795.5 3975.6 4022.7 4053.1 4174.8 92649.5 93384.1 94714.5 94934.1 96548.0 70800.0 75799.3 80348.6 82221.6 83954.7 74974.0 75891.6 76653.6 76872.2 77256.6 7260.0 7914.9 8145.8 8189.2 8204.2 48441.8 50537.5 51970.5 52515.7 54071.7 69308.6 69489.0 70449.6 70494.6 71083.6 10002.8 10168.3 10226.6 10279.3 10907.9 10794.7 11051.9 11056.4 11100.6 11415.9 9059.8 10209.6 10698.7 10729.2 11315.4 10626.3 10684.8 10777.1 10816.6 11008.7 9955.4 10285.8 10306.3 10318.7 10582.4 8903.0 9029.3 9042.5 9311.5 9317.1 9039.1 9091.2 9094.7 9124.6 9138.3 13:16:59 INFO - PROCESS | 1677 | -------- Summary: end -------- 13:16:59 INFO - PROCESS | 1677 | 13:17:00 INFO - TEST-INFO | 1677: exit 0 13:17:00 INFO - TEST-OK | dromaeo_css | took 1112904ms 13:17:00 INFO - TEST-START | kraken 13:17:00 INFO - operating with platform_type : mac_ 13:17:00 INFO - Initialising browser for kraken test... 13:17:00 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpHwFrPq/profile http://localhost:49272/getInfo.html) 13:17:02 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 13:17:02 INFO - PROCESS | 1682 | colorDepth:24 13:17:02 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 13:17:02 INFO - PROCESS | 1682 | __metrics 13:17:02 INFO - PROCESS | 1682 | 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" 13:17:02 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:02 INFO - TEST-INFO | 1682: exit 0 13:17:02 INFO - Browser initialized. 13:17:02 INFO - Running cycle 1/1 for kraken test... 13:17:02 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpHwFrPq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:14 INFO - PROCESS | 1684 | RSS: Main: 210055168 13:17:14 INFO - PROCESS | 1684 | 13:17:17 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:18 INFO - PROCESS | 1684 | RSS: Main: 265379840 13:17:18 INFO - PROCESS | 1684 | 13:17:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 13:17:21 INFO - PROCESS | 1684 | RSS: Main: 274898944 13:17:21 INFO - PROCESS | 1684 | 13:17:24 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 13:17:25 INFO - PROCESS | 1684 | RSS: Main: 264450048 13:17:25 INFO - PROCESS | 1684 | 13:17:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 13:17:27 INFO - PROCESS | 1684 | RSS: Main: 267513856 13:17:27 INFO - PROCESS | 1684 | 13:17:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:30 INFO - PROCESS | 1684 | RSS: Main: 266412032 13:17:30 INFO - PROCESS | 1684 | 13:17:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:33 INFO - PROCESS | 1684 | RSS: Main: 267673600 13:17:33 INFO - PROCESS | 1684 | 13:17:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:37 INFO - PROCESS | 1684 | RSS: Main: 266620928 13:17:37 INFO - PROCESS | 1684 | 13:17:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 13:17:40 INFO - PROCESS | 1684 | RSS: Main: 268185600 13:17:40 INFO - PROCESS | 1684 | 13:17:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:42 INFO - PROCESS | 1684 | RSS: Main: 301187072 13:17:42 INFO - PROCESS | 1684 | 13:17:44 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:45 INFO - PROCESS | 1684 | RSS: Main: 300908544 13:17:45 INFO - PROCESS | 1684 | 13:17:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:47 INFO - PROCESS | 1684 | RSS: Main: 307286016 13:17:47 INFO - PROCESS | 1684 | 13:17:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:17:51 INFO - PROCESS | 1684 | RSS: Main: 308494336 13:17:51 INFO - PROCESS | 1684 | 13:17:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:54 INFO - PROCESS | 1684 | RSS: Main: 308781056 13:17:54 INFO - PROCESS | 1684 | 13:17:55 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 13:17:56 INFO - PROCESS | 1684 | RSS: Main: 369369088 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | __start_tp_report 13:17:56 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 13:17:56 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 13:17:56 INFO - PROCESS | 1684 | |i|pagename|runs| 13:17:56 INFO - PROCESS | 1684 | |0;ai-astar;111;108;109;108;113;110;118;110;111;109 13:17:56 INFO - PROCESS | 1684 | |1;audio-beat-detection;158;120;138;153;117;141;115;149;149;140 13:17:56 INFO - PROCESS | 1684 | |2;audio-dft;185;185;183;190;184;197;264;205;185;196 13:17:56 INFO - PROCESS | 1684 | |3;audio-fft;74;71;76;114;55;56;58;58;115;56 13:17:56 INFO - PROCESS | 1684 | |4;audio-oscillator;90;93;115;80;104;123;153;77;78;115 13:17:56 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;87;89;88;89;86;134;130;92;86 13:17:56 INFO - PROCESS | 1684 | |6;imaging-darkroom;96;94;93;93;92;94;93;94;102;122 13:17:56 INFO - PROCESS | 1684 | |7;imaging-desaturate;113;134;104;85;87;85;85;88;85;85 13:17:56 INFO - PROCESS | 1684 | |8;json-parse-financial;57;59;59;58;58;56;58;66;53;52 13:17:56 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;60;60;71;72;90;95;64;64;64;66 13:17:56 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;81;79;69;76;85;108;103;103;79;84 13:17:56 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;119;118;124;128;123;116;117;116;117;126 13:17:56 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;134;119;135;132;159;165;137;133;126;132 13:17:56 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;65;68;68;65;66;64;63;66;66;67 13:17:56 INFO - PROCESS | 1684 | __end_tp_report 13:17:56 INFO - PROCESS | 1684 | __start_cc_report 13:17:56 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1196 13:17:56 INFO - PROCESS | 1684 | __end_cc_report 13:17:56 INFO - PROCESS | 1684 | __startTimestamp1458332276106__endTimestamp 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | ------- Summary: start ------- 13:17:56 INFO - PROCESS | 1684 | Number of tests: 14 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.50 stddev:2.98 (2.7%) stddev-sans-first:3.16 13:17:56 INFO - PROCESS | 1684 | Values: 111.0 108.0 109.0 108.0 113.0 110.0 118.0 110.0 111.0 109.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:145.00 stddev:15.54 (10.7%) stddev-sans-first:14.70 13:17:56 INFO - PROCESS | 1684 | Values: 158.0 120.0 138.0 153.0 117.0 141.0 115.0 149.0 149.0 140.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:197.40 Median:193.00 stddev:24.49 (12.7%) stddev-sans-first:25.56 13:17:56 INFO - PROCESS | 1684 | Values: 185.0 185.0 183.0 190.0 184.0 197.0 264.0 205.0 185.0 196.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:73.30 Median:58.00 stddev:23.12 (39.9%) stddev-sans-first:24.52 13:17:56 INFO - PROCESS | 1684 | Values: 74.0 71.0 76.0 114.0 55.0 56.0 58.0 58.0 115.0 56.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:77.50 stddev:24.24 (31.3%) stddev-sans-first:25.26 13:17:56 INFO - PROCESS | 1684 | Values: 90.0 93.0 115.0 80.0 104.0 123.0 153.0 77.0 78.0 115.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:88.50 stddev:18.55 (21.0%) stddev-sans-first:19.45 13:17:56 INFO - PROCESS | 1684 | Values: 89.0 87.0 89.0 88.0 89.0 86.0 134.0 130.0 92.0 86.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:93.50 stddev:9.13 (9.8%) stddev-sans-first:9.67 13:17:56 INFO - PROCESS | 1684 | Values: 96.0 94.0 93.0 93.0 92.0 94.0 93.0 94.0 102.0 122.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:85.00 stddev:16.80 (19.8%) stddev-sans-first:16.52 13:17:56 INFO - PROCESS | 1684 | Values: 113.0 134.0 104.0 85.0 87.0 85.0 85.0 88.0 85.0 85.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:3.81 (6.6%) stddev-sans-first:4.03 13:17:56 INFO - PROCESS | 1684 | Values: 57.0 59.0 59.0 58.0 58.0 56.0 58.0 66.0 53.0 52.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:68.50 stddev:12.25 (17.9%) stddev-sans-first:12.38 13:17:56 INFO - PROCESS | 1684 | Values: 60.0 60.0 71.0 72.0 90.0 95.0 64.0 64.0 64.0 66.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:79.00 stddev:13.22 (16.7%) stddev-sans-first:13.87 13:17:56 INFO - PROCESS | 1684 | Values: 81.0 79.0 69.0 76.0 85.0 108.0 103.0 103.0 79.0 84.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:4.45 (3.7%) stddev-sans-first:4.69 13:17:56 INFO - PROCESS | 1684 | Values: 119.0 118.0 124.0 128.0 123.0 116.0 117.0 116.0 117.0 126.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:134.50 stddev:14.11 (10.5%) stddev-sans-first:14.92 13:17:56 INFO - PROCESS | 1684 | Values: 134.0 119.0 135.0 132.0 159.0 165.0 137.0 133.0 126.0 132.0 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.69 13:17:56 INFO - PROCESS | 1684 | Values: 65.0 68.0 68.0 65.0 66.0 64.0 63.0 66.0 66.0 67.0 13:17:56 INFO - PROCESS | 1684 | -------- Summary: end -------- 13:17:56 INFO - PROCESS | 1684 | 13:17:56 INFO - TEST-INFO | 1684: exit 0 13:17:56 INFO - TEST-OK | kraken | took 56901ms 13:17:56 INFO - SUITE-END | took 1169s 13:17:57 INFO - Completed test suite (00:19:30) 13:17:57 INFO - javascript benchmark 13:17:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2926.795124341296, 3475.635058318875, 3499.7550171487997, 3500.772449790762, 3548.7693299935504, 5698.401667824881, 5710.0, 5722.484976352122, 5742.023855944489, 5750.079987202049, 5712.800051998181, 5734.79928202513, 5746.396628354026, 5749.367569567345, 5752.539796816255, 5087.287779710843, 5130.538251557359, 5151.098557752397, 5197.376314842205, 5218.634695571312, 5203.713795741232, 5205.037068142406, 5210.973945130288, 5217.973910130444, 5221.138512145491, 5168.767405466763, 5174.689518628876, 5212.035773381917, 5223.764930578133, 5253.527182553569, 5205.739713014353, 5265.76304066318, 5270.8155214567305, 5279.260903473517, 5301.522862942354, 5009.524095210949, 5168.22476628505, 5170.431252562215, 5187.896242075175, 5192.376914770214, 5541.806036788693, 5607.859803504945, 5614.606977511535, 5619.072852979253, 5646.745896434629, 6138.0, 6241.375862413723, 6303.621782693053, 6312.053192021188, 6314.116023756677, 6196.659183744892, 6239.563230573862, 6251.156093927307, 6256.436920677161, 6270.905936410957, 5741.9951508486265, 5764.33710123337, 5774.133879918004, 5853.0, 5874.530037596982, 6299.716512756937, 6324.3043265240785, 6325.146105275729, 6326.557141000086, 6499.05763664266, 6145.907811382833, 6156.168162645234, 6192.907106393408, 6199.0, 6218.0, 6130.306415576139, 6215.844603884939, 6304.338044505353, 6307.180066591313, 6334.904976425358, 5233.476652334736, 6226.59527130735, 6267.843303917439, 6273.811785646438, 6280.214973128359, 6252.624842509464, 6257.593256438408, 6296.118543403927, 6332.936670633327, 6334.3032266450655, 4651.09303685778, 4821.63837712173, 4884.633652476078, 4906.55840974314, 4926.064047830901, 4346.826126954887, 4387.188370151533, 4413.845515406945, 4423.137488189772, 4424.380586717862, 5687.175359572839, 5688.829335119953, 5700.315962084494, 5707.885842283131, 5746.9712651436475, 6153.0, 6220.782272620437, 6284.497240220863, 6296.779612713533, 6348.555601107878, 5703.572232082527, 5705.914411283834, 5709.571782116358, 5710.971445142748, 5712.514436272881, 5260.026895024433, 5352.65207761502, 5372.865678358073, 5374.3013408256675, 5384.488473595002, 6236.345183755731, 6289.150964619809, 6305.936940630535, 6322.430981211713, 6447.000714889294, 6064.939350606437, 6075.605085669417, 6077.149199112217, 6088.6042407243385, 6107.6640784757265, 5206.765695543634, 6112.633242005494, 6210.534209934363, 6223.37766223374, 6274.215723034621, 6158.3225845157895, 6169.5064394849205, 6180.320164781961, 6228.28374736893, 6255.218097737783, 5125.821061155881, 5844.386339434468, 6324.272708638566, 6339.96830015847, 6341.746330146927, 5897.67562784051, 5944.405559444021, 6034.2155519782145, 6139.201903752483, 6144.692765361625, 5049.8737531562, 5971.462568368694, 6119.112728654409, 6121.387861213843, 6131.049687298476, 5966.284045914518, 5976.073708575178, 5985.371535988658, 5990.7004649768205, 5991.880162396815, 5935.376785437467, 5993.280806303272, 6013.548983826143, 6074.848128796815, 6133.938660613337, 5889.528837692888, 5913.201717768046, 5959.940400596112, 6010.609310394811, 6036.426539478743], "unit": "score", "name": "dojo.html", "value": 5675.993341690498}, {"lowerIsBetter": false, "replicates": [503.63486472307557, 590.763694522191, 609.4697613076625, 644.432899048837, 667.9565828221165, 31760.84119579402, 32368.838155809248, 32371.762823717647, 39837.203255934866, 40543.39184912229, 43556.0, 43882.56117438825, 43944.3408348875, 44017.0, 44085.7795711021, 9568.760780980461, 9804.656837010705, 9808.362456440344, 9812.50937453128, 9814.754631134207, 9476.620935162586, 9628.807423851518, 9643.276754243425, 9666.854997175047, 9678.56446459911, 8211.0, 9581.37721048133, 9666.27502937279, 9744.366616169926, 9757.90242097577, 9620.230381569458, 9629.855552166724, 9700.90299097014, 9705.708828735114, 9714.31999760017, 9596.0, 9717.902820971842, 9734.805303893952, 9741.707748767549, 9753.512324383752, 42702.78648606768, 42769.786151069355, 42841.0, 43345.0, 43788.68633940987, 3213.1324542373663, 3436.518887355772, 3685.8894233173046, 3706.4440333949856, 3860.401637746154, 29419.41161176786, 29483.70516294831, 29530.409391812045, 29569.852150739323, 29673.0, 2748.2991837081418, 2808.522551166286, 2809.044924725583, 2814.1557532740303, 2938.147937098239, 695241.0, 698158.0, 698869.0, 699961.0007799866, 715959.0, 72919.90620140702, 73136.26863731294, 73760.0, 73894.0, 73932.26067739361, 62293.37706622876, 63925.68037159878, 77457.61271193608, 78005.60997194977, 78009.0, 18311.450656480327, 18481.90759046196, 18513.35203267879, 18524.25902963893, 18548.258069677333, 14094.71810563783, 14171.149731016172, 14188.645283867985, 14207.573772786833, 14208.0, 22260.666090008664, 22528.774712252995, 22570.322890313317, 22590.887045564996, 22591.20930767415, 9715.174210192072, 9943.552540135712, 9955.701328960144, 9957.302988790716, 9958.0, 958.8609651600478, 984.8079624473158, 1043.0, 1102.9448527573588, 1134.4101067444883, 29920.85039574832, 29940.550891736642, 30413.0, 30619.234519136753, 30726.0, 1141.2467771271088, 1164.8369228308043, 1251.0367017396554, 1271.9046071544672, 1279.5201799325253, 15033.022853514487, 15651.373945042298, 16296.592585185464, 16772.58068548296, 16786.0, 493096.0690393122, 504376.0, 505027.0, 505468.0, 505747.0, 62486.0, 64461.35538644647, 64461.67769161124, 64470.0, 64515.67742161353, 1469.1478942213491, 1503.7368460519365, 1507.6984603079427, 1604.8796340274293, 1639.2541393665854, 30476.542851857685, 31963.041108766774, 31996.5200521997, 32270.515942260416, 32694.83652581722, 46049.0, 52088.47911520836, 53322.2001669983, 53676.19485707639, 53779.46220537901, 388116.0, 400236.0, 400287.0, 400854.0, 401034.0, 30215.395692086477, 34599.0, 34614.480782788785, 35552.28895422129, 35763.0, 42500.57499424966, 42759.93100172521, 43269.35095973626, 44109.33835992527, 44187.55812441834, 34647.0, 35730.0, 36873.44689829601, 39697.603023969394, 41131.0, 37987.240255194185, 38256.0, 38394.80802595969, 38462.038449039, 39157.60842391539, 38438.0, 38683.80658096691, 38872.0, 39095.6090439092, 39185.21629567336, 32570.67429325771, 33630.663693363735, 34338.82830585931, 34362.65637343695, 34483.79306724253, 25386.0, 25455.745442545336, 25471.872640636677, 25580.74419255858, 25922.83347249416], "unit": "score", "name": "ext.html", "value": 20872.017407597832}, {"lowerIsBetter": false, "replicates": [320.32091965034124, 384.59617401728195, 384.9133944862405, 394.76708741842305, 396.2016536678593, 16746.413875514343, 20065.699014514776, 20828.750274983493, 21098.367048988515, 21373.67939480909, 17752.467425977207, 20644.896775516103, 21216.04527796249, 21260.787392126073, 22298.442538936535, 5839.299284085905, 5951.4048595140575, 5968.194293770329, 6007.068904319815, 6007.068904319837, 5701.116326969306, 5913.822585322448, 5959.493443057346, 5974.731137098841, 5989.1016347548, 5942.6137301075505, 5954.732037058321, 5956.017257152586, 5958.344582095988, 5961.731722072495, 5800.390958949313, 6422.646754428504, 6439.130717353191, 6445.097686323895, 6450.161479007723, 5630.690312032878, 5661.5187709044785, 5664.178694089375, 5666.376698563155, 5666.801661941853, 13614.455421783117, 14159.22124283164, 14166.433342666282, 14168.433262669481, 14175.362108705132, 2083.3229200509895, 2130.0, 2201.570693714726, 2316.5945959457026, 2332.521833024226, 9627.181689556395, 10045.447500387476, 10217.978202179796, 10320.432376219305, 10536.947315263451, 1733.306677329066, 1772.8670349723823, 1783.6700210460976, 1826.4794533557872, 1871.2327945542263, 81792.18207817904, 102929.0, 106155.0, 109294.0, 109908.0, 11818.409079545989, 11829.349385783693, 11854.999999999827, 11857.288562686266, 11903.34531600753, 14352.856471435152, 14371.281435928371, 14402.207878566569, 14409.85590144106, 14425.711485770436, 8972.19250267479, 8981.416207946462, 8986.977929965837, 9085.409448385966, 9131.086891310815, 9304.8604270936, 9309.860352094724, 9311.860322095174, 9316.953415233016, 9429.009953954874, 3789.412641040643, 4216.536181020086, 4625.5836974671765, 4646.4888862225125, 4706.176419126639, 1810.01252179036, 1869.2803270740592, 1942.4949513126405, 1949.9122539485475, 1952.8047195280642, 898.3980732908836, 941.9058094190526, 1011.8381059030667, 1025.789713108811, 1036.875574930998, 20218.090185941666, 20465.38603841887, 20986.685199722015, 21551.0, 21757.347279581638, 1005.818952588541, 1029.1098200057047, 1042.702829693549, 1047.6280920273346, 1071.50175168547, 11149.609763658395, 11528.884711152949, 11570.537178512765, 11588.13089018327, 11635.952764251258, 623870.0, 625083.0, 625577.0, 627978.0, 649334.0, 118596.40701796436, 119254.40372798081, 119785.0, 122215.0, 126030.0, 1035.880873699519, 1039.1894322428518, 1057.460695045517, 1060.109508013257, 1060.6658902445704, 18225.635487289914, 18645.533861653566, 18736.53158671044, 19333.51666208356, 19403.320883769, 47032.7648361756, 48081.27878081902, 48178.0, 48302.0, 48916.0, 63894.0, 65308.673456632416, 65780.6710966442, 69340.65329673319, 69820.95268571077, 7276.7089316428865, 7746.57393843344, 8088.676452941816, 8447.324214062983, 8662.566871656518, 9719.854202187114, 12759.80860287115, 13693.863061369259, 13803.102798318077, 13805.959050121222, 11747.353895535827, 11751.177417580688, 12018.519259229533, 12048.457819398323, 12104.334261615344, 11547.769044619228, 11636.36000020007, 11717.472713727731, 11771.0, 11999.04007679366, 11737.119716021161, 11855.229410088661, 11917.404129793302, 12141.575044873387, 12215.389230538616, 8188.0, 8237.855979862468, 8385.245327920517, 8562.957185214034, 8778.912210878065, 8905.421147625384, 10259.692209233735, 11210.103191744804, 11762.70593235176, 12035.879641203826], "unit": "score", "name": "jquery.html", "value": 9493.313540088084}, {"lowerIsBetter": false, "replicates": [1522.6726253855418, 1665.6835201311749, 1688.6875927953329, 2004.3586052463208, 2071.502839318563, 8376.371772117092, 9118.224950879176, 9279.396839205447, 9284.071592840712, 9285.814283714322, 9108.590113444894, 9135.908640913589, 9258.444493330388, 9268.629254829799, 9280.628774849014, 2266.05958527211, 2308.803751681101, 2600.5449046416848, 2634.99870049381, 2635.196265139132, 2633.5654616988268, 2645.3254420122844, 2647.0206023771134, 2649.509840679471, 2650.939624150336, 2542.4406630541253, 2580.883860226285, 2604.843709377434, 2606.322356187386, 2606.6741657292837, 2560.231930420885, 2597.1429428288716, 2604.5702459094227, 2614.4640348728467, 2614.6078088286718, 2582.109172335541, 2588.352911772057, 2606.0487921908557, 2615.9738402616113, 2626.1071235779737, 9259.953700231523, 9352.158305752515, 9352.67265645699, 9366.297527685383, 9394.0, 5691.288588926384, 5850.912236316459, 5857.209276747627, 5914.970425147847, 5914.97042514789, 3493.598236202844, 3705.8888233352773, 3791.298609757204, 3858.3633700439673, 3875.961240387588, 985.261054209343, 1067.8505009298703, 1072.447689439939, 1078.0567003871613, 1108.8724796648407, 12715.855572998382, 12724.872751272555, 12726.854583087566, 12747.298898560575, 12748.171368861087, 5072.163093089599, 5116.616253780981, 5196.558292545176, 5220.112580861262, 5228.555572776357, 10680.51937662807, 10692.893071069346, 10703.1437485001, 10711.571537138427, 10717.249792514449, 5794.333651630032, 5797.594168408171, 5808.6224395414165, 5813.476787089182, 5820.505257053198, 4615.515370886009, 4680.906381872343, 4713.670043097019, 4727.527247275245, 5243.318368612056, 4135.045490399744, 4170.374443833389, 4219.008532994744, 4244.087521182961, 4252.170826688766, 1362.7751421015619, 1390.7774756038984, 1391.6938273579797, 1398.727248186594, 1402.1797248609473, 1166.8891455311732, 1180.0913296761446, 1183.816508441193, 1203.2599951030054, 1208.347492354119, 8389.203025712548, 8397.160283971676, 8432.78918027042, 8472.57637118154, 8512.446690965067, 1189.2864281431073, 1235.4193529041336, 1271.0530654662336, 1273.5542560104075, 1286.466116561635, 6473.546851720334, 6499.902501462482, 6554.606723596599, 6576.572522786004, 6582.572132811352, 9593.42439453635, 11181.161412893904, 11266.0, 11275.379854108103, 11278.492467838967, 10573.418461984511, 10959.83560246597, 11083.445827708581, 11098.2786118902, 11132.721681958015, 8606.397552171413, 8735.301175905912, 8764.693235736719, 8780.253678437404, 8838.690645827364, 8404.159584041547, 8444.155584441507, 8456.985161780625, 8542.06037335905, 8543.8718419225, 9955.402675839183, 9983.550740216562, 10077.748056298651, 10082.890882003121, 10264.127549158406, 10241.436720980417, 10661.573537058432, 10677.412742299248, 10687.732806679584, 10879.347239165676, 7186.748463803742, 7388.889166662612, 7656.961715191388, 7687.346575541142, 7993.6003199838615, 8617.612207450555, 8625.525596092024, 8669.133086691281, 8673.436226645248, 8686.478811271343, 6300.21247344082, 7611.010568626043, 7728.7681369559, 7820.921790782019, 7886.0, 7499.775006749588, 7547.73582924595, 7559.773206803805, 7628.42786791004, 7639.88540171909, 8090.231428014329, 8098.919010810052, 8133.593320334078, 8144.144864789112, 8190.180981902001, 7251.419886408969, 7291.125064992235, 7360.521566098187, 7397.926020739724, 7398.223186565333, 7469.215732348025, 7513.812154696177, 7546.0, 7599.506032107895, 7602.695892164473], "unit": "score", "name": "mootools.html", "value": 5191.065347359852}, {"lowerIsBetter": false, "replicates": [295.47700569991116, 304.71356924490976, 346.88379392903374, 349.68528324507923, 350.46554005142156, 5328.547073498752, 6550.639714815683, 6651.235107962573, 6658.6670666466725, 6680.899786503206, 6544.4437222835995, 6549.3123222061595, 6576.835579110512, 6582.4075833175, 6588.945768677013, 4634.86095417138, 4725.267583524542, 4804.183288840905, 4834.395700537433, 4894.902101957959, 4813.061453016663, 4819.5180481951875, 4823.517648235166, 4845.563899249067, 4856.951430485703, 4794.089123066607, 4846.200376937801, 4856.150173719602, 4874.366332376804, 4874.488178741234, 4617.722936623796, 4662.440507139131, 4767.737774422405, 4814.855554333376, 4849.951500485021, 4134.896627584304, 4158.480189976253, 4167.604077612622, 4176.7076304658685, 4179.310413781723, 5386.596005299618, 5936.495397891184, 6220.47125994291, 6242.1261023456755, 6287.654179020152, 5705.201271821907, 5720.942790572082, 5728.541716662657, 5739.139129130622, 5741.971290143564, 5578.972105139489, 6965.5124141310125, 6977.406920411771, 6979.336962988508, 6992.965035174791, 3600.567931848195, 4550.840720574764, 4563.566461186182, 4565.452145742499, 4568.977155114237, 7206.675699593531, 7340.4861659684375, 7344.889826652605, 7348.081489813773, 7358.705651773923, 4667.393238878924, 4682.391289132459, 4683.414573178353, 4697.224957881979, 4701.459332176843, 3912.5891781363116, 4736.360591320127, 4741.909360847025, 4749.928751068736, 4756.500567440369, 5462.863428414242, 5587.944120558743, 5603.103503439512, 5618.0449323615085, 5620.892165437961, 6226.346233645492, 6688.83277918056, 6943.618101004493, 6949.027136200936, 6959.234484206733, 1612.6049117966174, 1621.6270257840763, 1629.959251018734, 1633.085472135608, 1635.2232689472644, 1001.5493028137367, 1018.8522664213648, 1040.9850395863973, 1058.2116323339162, 1069.112636511709, 6272.372762723691, 6362.968185159045, 6368.29948705642, 6415.422611964946, 6541.803745887631, 7318.121825380988, 7319.817004574928, 7327.45044121693, 7332.266773322625, 7376.963115184497, 5361.865953351119, 6393.392627700361, 6399.720055988821, 6540.574862633914, 6574.8356291093105, 3098.90703278902, 3857.2092720992127, 3865.8453661853773, 3875.0, 3875.1280961783373, 7367.336939675348, 7631.122420921665, 7639.0, 7663.501872378278, 7673.501222420637, 6179.721912513947, 7528.51064680794, 7532.698692052257, 7575.24247575238, 7581.658825352873, 7606.733764318223, 7606.885896711665, 7615.581143037075, 7629.504082234637, 7632.084149901936, 7007.544509606859, 7309.342159205697, 7353.77938661841, 7356.0, 7367.447441441806, 5940.881182376242, 7169.426445884213, 7190.784276471714, 7198.20819709842, 7213.3868621167785, 7618.542887426772, 7619.923800762143, 7622.466427350032, 7623.275788800055, 7627.161012288755, 4676.929846052244, 4682.601978831837, 4686.906261874675, 4699.295105734167, 4710.4818469967595, 6291.339409362135, 6903.928821353675, 7240.8913866290995, 7253.492255542062, 7262.818429539304, 6696.966515167393, 6938.548994315353, 7015.158181018311, 7020.192677842114, 7057.117860267466, 6982.162140543167, 7027.894581581382, 7036.683349249399, 7046.260142684944, 7050.647467626701, 6888.448924086161, 6890.414314783299, 6895.55178913369, 6896.586204827727, 6918.446524278146, 6799.558028728117, 7031.648417579203, 7043.401310888426, 7049.647517623996, 7050.929490705027, 6606.570572912745, 6750.8649827004165, 6902.827429314308, 6911.827204319731, 6917.757878474229], "unit": "score", "name": "prototype.html", "value": 5095.098902159671}, {"lowerIsBetter": false, "replicates": [698.4530705109734, 732.4579810939906, 765.6171914042978, 781.8319061401797, 784.019975031211, 12401.937990310058, 14948.77576836347, 15225.0, 15296.31166597503, 15305.846941530595, 14047.438102475915, 14101.858981410183, 14121.929390353034, 14143.787843182336, 14155.716885662307, 791.129757267006, 809.2393150438598, 950.064186776025, 985.7437066362761, 987.5062468765617, 956.6077908057698, 969.3795970578835, 973.9074787895139, 974.3471873844505, 974.5565767575771, 1039.1063685230695, 1046.1526163807303, 1046.3669479964626, 1046.7278507588044, 1047.9266451348408, 833.0461621443444, 993.0665174735725, 1031.6131450705984, 1031.6801791444639, 1033.3489901362168, 769.2807225244414, 769.4114002787871, 771.0169533844394, 773.3272053313653, 774.4307933668749, 14952.40190392383, 14991.325390357351, 15028.323725432381, 15031.549053528412, 15042.32309546073, 13121.803172952414, 13220.933895330461, 13302.401391937387, 13432.932835335858, 13452.461901523928, 8587.0, 10133.847992280122, 10187.439690817002, 10531.0, 10679.519421626046, 3495.615482296945, 3545.9474530617435, 3611.7291203159607, 3613.4760459733193, 3645.4167333226555, 80742.59628701878, 80749.0, 81118.0, 83856.58071709663, 85333.57333213295, 8257.587120643944, 9773.338532449501, 9859.408435493893, 9876.061774131445, 10082.899171008343, 21819.236326728806, 21856.89071554632, 22020.559588808133, 22130.88934555317, 22132.88933555354, 7645.961770191225, 7675.347595454337, 7718.228177182349, 7889.802754931058, 7965.402594805297, 4184.727992680466, 4238.809253583596, 4246.256905041605, 4417.690761646654, 4480.932786008212, 3165.4776961801044, 3491.650834916488, 3596.8561257549927, 3599.9820000899826, 3600.6399360063783, 605.4036773777825, 660.5244224158598, 706.1032488739272, 710.4848984486309, 714.118064190724, 568.4400865147826, 588.2029849553793, 606.3213701082578, 608.8660494691161, 640.7084776426715, 8259.8348033039, 8291.95854020726, 8389.454685445426, 8458.87311690325, 8515.233628973423, 586.0710773424171, 590.3329237961076, 591.2638764737843, 622.0979579609584, 625.871696302257, 3795.5065841440437, 3975.565494193816, 4022.6580740637373, 4053.088055187618, 4174.770387628649, 92649.53675231716, 93384.06615933754, 94714.5264273688, 94934.10131797325, 96548.0, 70800.0, 75799.34702285394, 80348.59825700834, 82221.58889205636, 83954.74067888987, 74974.0, 75891.62054189804, 76653.61673191599, 76872.23127768762, 77256.61371693105, 7259.983602295789, 7914.881276780968, 8145.79635509117, 8189.181081891763, 8204.179582041748, 48441.75779121082, 50537.48387548379, 51970.48029519656, 52515.68710782108, 54071.729641353115, 69308.61382772417, 69489.0, 70449.64775176092, 70494.64752676409, 71083.64458177883, 10002.799944001225, 10168.33905796121, 10226.6420675276, 10279.331843430453, 10907.890921090688, 10794.676159715222, 11051.944740276569, 11056.447177640925, 11100.61147859821, 11415.942920285346, 9059.773505662411, 10209.642662506776, 10698.679039628823, 10729.195310351912, 11315.434228288717, 10626.256162068581, 10684.83972740394, 10777.08394786452, 10816.621418250323, 11008.724781880517, 9955.402675839472, 10285.84571231447, 10306.278560500992, 10318.742031449274, 10582.417967011888, 8902.993905246554, 9029.322800790098, 9042.457452552868, 9311.487868167045, 9317.068293170629, 9039.096090390909, 9091.181793638605, 9094.727158185266, 9124.635014599342, 9138.268938485038], "unit": "score", "name": "yui.html", "value": 6976.498848986507}], "name": "dromaeo_css", "value": 7694.57060133233}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 109.0, 108.0, 113.0, 110.0, 118.0, 110.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [158.0, 120.0, 138.0, 153.0, 117.0, 141.0, 115.0, 149.0, 149.0, 140.0], "unit": "score", "name": "audio-beat-detection", "value": 138.0}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 183.0, 190.0, 184.0, 197.0, 264.0, 205.0, 185.0, 196.0], "unit": "score", "name": "audio-dft", "value": 197.4}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 76.0, 114.0, 55.0, 56.0, 58.0, 58.0, 115.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.3}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 115.0, 80.0, 104.0, 123.0, 153.0, 77.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 89.0, 88.0, 89.0, 86.0, 134.0, 130.0, 92.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.0}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 93.0, 93.0, 92.0, 94.0, 93.0, 94.0, 102.0, 122.0], "unit": "score", "name": "imaging-darkroom", "value": 97.3}, {"lowerIsBetter": true, "replicates": [113.0, 134.0, 104.0, 85.0, 87.0, 85.0, 85.0, 88.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 59.0, 58.0, 58.0, 56.0, 58.0, 66.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 71.0, 72.0, 90.0, 95.0, 64.0, 64.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.6}, {"lowerIsBetter": true, "replicates": [81.0, 79.0, 69.0, 76.0, 85.0, 108.0, 103.0, 103.0, 79.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 124.0, 128.0, 123.0, 116.0, 117.0, 116.0, 117.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [134.0, 119.0, 135.0, 132.0, 159.0, 165.0, 137.0, 133.0, 126.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 68.0, 65.0, 66.0, 64.0, 63.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1449.9}]} 13:17:57 INFO - Return code: 0 13:17:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:57 INFO - # TBPL SUCCESS # 13:17:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:17:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:17:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:17:57 INFO - 2016-03-18 13:17:57.430 screenresolution[1688:10379] starting screenresolution argv=screenresolution get 13:17:57 INFO - 2016-03-18 13:17:57.432 screenresolution[1688:10379] Display 0: 1600x1200x32@60 13:17:57 INFO - 2016-03-18 13:17:57.438 screenresolution[1689:10382] starting screenresolution argv=screenresolution list 13:17:57 INFO - Available Modes on Display 0 13:17:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:17:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:17:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:17:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:17:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:17:57 INFO - Intel Iris: 13:17:57 INFO - Chipset Model: Intel Iris 13:17:57 INFO - Type: GPU 13:17:57 INFO - Bus: Built-In 13:17:57 INFO - VRAM (Dynamic, Max): 1536 MB 13:17:57 INFO - Vendor: Intel (0x8086) 13:17:57 INFO - Device ID: 0x0a2e 13:17:57 INFO - Revision ID: 0x0009 13:17:57 INFO - Displays: 13:17:57 INFO - Display: 13:17:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:17:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:17:57 INFO - Display Serial Number: 1600x1200 60 13:17:57 INFO - Main Display: Yes 13:17:57 INFO - Mirror: Off 13:17:57 INFO - Online: Yes 13:17:57 INFO - Rotation: Supported 13:17:57 INFO - Return code: 0 13:17:57 INFO - Running post-action listener: _resource_record_post_action 13:17:57 INFO - Running post-run listener: _resource_record_post_run 13:17:58 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 31768064; Write bytes: 665465344; Read time: 314; Write time: 1868 13:17:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358099456; Write bytes: 354129408; Read time: 28882; Write time: 642 13:17:58 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 29986304; Write bytes: 300162048; Read time: 295; Write time: 1192 13:17:58 INFO - Running post-run listener: _upload_blobber_files 13:17:58 INFO - Blob upload gear active. 13:17:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:58 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 13:17:58 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'] 13:17:58 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 13:17:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:59 INFO - (blobuploader) - INFO - Done attempting. 13:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:00 INFO - (blobuploader) - INFO - Done attempting. 13:18:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:18:00 INFO - Return code: 0 13:18:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:18:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:18:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0490fce4fd3d424f05b0145aadd49c6668704f8aa8d9ecff368e1a3f1b4b7b3ca2b512532419be706d28d36a13aab2852b4037d8382fac0bea3cd05407e12569", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a611225c754b0c45da31e63038571bc65dceb066f37bc01e285beb86535f17e21cebdeaa7bed5daa7524a50d0c7b68737222bc1fab1ec61cf7b1bf9078d4136"} 13:18:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:18:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:18:00 INFO - Contents: 13:18:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0490fce4fd3d424f05b0145aadd49c6668704f8aa8d9ecff368e1a3f1b4b7b3ca2b512532419be706d28d36a13aab2852b4037d8382fac0bea3cd05407e12569", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a611225c754b0c45da31e63038571bc65dceb066f37bc01e285beb86535f17e21cebdeaa7bed5daa7524a50d0c7b68737222bc1fab1ec61cf7b1bf9078d4136"} 13:18:00 INFO - Running post-run listener: copy_logs_to_upload_dir 13:18:00 INFO - Copying logs to upload dir... 13:18:00 INFO - mkdir: /builds/slave/test/build/upload/logs 13:18:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.585992 ========= master_lag: 3.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-18 13:18:01.156310) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 15 secs) (at 2016-03-18 13:18:01.165334) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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/0490fce4fd3d424f05b0145aadd49c6668704f8aa8d9ecff368e1a3f1b4b7b3ca2b512532419be706d28d36a13aab2852b4037d8382fac0bea3cd05407e12569", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a611225c754b0c45da31e63038571bc65dceb066f37bc01e285beb86535f17e21cebdeaa7bed5daa7524a50d0c7b68737222bc1fab1ec61cf7b1bf9078d4136"} build_url:https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/YQQXtPNoQcqRPVzJ0FRbMg/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/0490fce4fd3d424f05b0145aadd49c6668704f8aa8d9ecff368e1a3f1b4b7b3ca2b512532419be706d28d36a13aab2852b4037d8382fac0bea3cd05407e12569", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a611225c754b0c45da31e63038571bc65dceb066f37bc01e285beb86535f17e21cebdeaa7bed5daa7524a50d0c7b68737222bc1fab1ec61cf7b1bf9078d4136"}' ========= master_lag: 15.20 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 15 secs) (at 2016-03-18 13:18:16.372990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-18 13:18:16.374375) ========= 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.GF6hkJkscE/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.jtw04VHDK8/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005187 ========= master_lag: 4.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-03-18 13:18:20.823337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 13:18:20.823672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 13:18:20.848922) ========= ========= Total master_lag: 122.97 =========