builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0182 starttime: 1456282609.84 results: success (0) buildid: 20160223165745 builduid: fe3ba3ee68d343d383aa24b7f264a715 revision: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.843644) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.844146) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.844479) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005726 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.869143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.869463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.886062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.886373) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005742 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.934896) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.935243) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.935637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:49.935952) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-02-23 18:56:49-- 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% 72.8M=0s 2016-02-23 18:56:50 (72.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176192 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:50.128110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:50.128536) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.025729 ========= master_lag: 0.45 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:50.600611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:50.600962) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b2baa5e9356644a7ed0b73e422eaff62e159ffb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5b2baa5e9356644a7ed0b73e422eaff62e159ffb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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-02-23 18:56:50,674 truncating revision to first 12 chars 2016-02-23 18:56:50,675 Setting DEBUG logging. 2016-02-23 18:56:50,675 attempt 1/10 2016-02-23 18:56:50,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b2baa5e9356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 18:56:50,955 unpacking tar archive at: mozilla-central-5b2baa5e9356/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540046 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:51.215974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:51.216337) ========= echo 5b2baa5e9356644a7ed0b73e422eaff62e159ffb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5b2baa5e9356644a7ed0b73e422eaff62e159ffb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 5b2baa5e9356644a7ed0b73e422eaff62e159ffb program finished with exit code 0 elapsedTime=0.005802 script_repo_revision: '5b2baa5e9356644a7ed0b73e422eaff62e159ffb' ========= master_lag: 0.16 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:51.381056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:51.381683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 18:56:51.407878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-23 18:56:51.408171) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:56:51 INFO - MultiFileLogger online at 20160223 18:56:51 in /builds/slave/test 18:56:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:56:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:56:51 INFO - {'append_to_log': False, 18:56:51 INFO - 'base_work_dir': '/builds/slave/test', 18:56:51 INFO - 'blob_upload_branch': 'Firefox', 18:56:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:56:51 INFO - 'branch': 'Firefox', 18:56:51 INFO - 'buildbot_json_path': 'buildprops.json', 18:56:51 INFO - 'config_files': ('talos/mac_config.py',), 18:56:51 INFO - 'default_actions': ('clobber', 18:56:51 INFO - 'read-buildbot-config', 18:56:51 INFO - 'download-and-extract', 18:56:51 INFO - 'populate-webroot', 18:56:51 INFO - 'create-virtualenv', 18:56:51 INFO - 'install', 18:56:51 INFO - 'run-tests'), 18:56:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:56:51 INFO - 'download_minidump_stackwalk': True, 18:56:51 INFO - 'download_symbols': 'ondemand', 18:56:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:56:51 INFO - 'tooltool.py': '/tools/tooltool.py', 18:56:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:56:51 INFO - '/tools/misc-python/virtualenv.py')}, 18:56:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:56:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:56:51 INFO - 'installer_path': 'installer.exe', 18:56:51 INFO - 'log_level': 'info', 18:56:51 INFO - 'log_name': 'talos', 18:56:51 INFO - 'log_to_console': True, 18:56:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:56:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:56:51 INFO - 'opt_config_files': (), 18:56:51 INFO - 'pip_index': False, 18:56:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:56:51 INFO - 'cmd': ('bash', 18:56:51 INFO - '-c', 18:56:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:56:51 INFO - 'enabled': True, 18:56:51 INFO - 'halt_on_failure': False, 18:56:51 INFO - 'name': 'check_screen_resolution'},), 18:56:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:56:51 INFO - 'cmd': ('bash', 18:56:51 INFO - '-c', 18:56:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:56:51 INFO - 'enabled': True, 18:56:51 INFO - 'halt_on_failure': False, 18:56:51 INFO - 'name': 'check_screen_resolution'},), 18:56:51 INFO - 'run_cmd_checks_enabled': True, 18:56:51 INFO - 'sps_profile': False, 18:56:51 INFO - 'sps_profile_interval': 0, 18:56:51 INFO - 'suite': 'dromaeojs', 18:56:51 INFO - 'system_bits': '32', 18:56:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:56:51 INFO - 'title': 't-yosemite-r7-0182', 18:56:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:56:51 INFO - 'use_talos_json': True, 18:56:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:56:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:56:51 INFO - 'work_dir': 'build'} 18:56:51 INFO - ##### 18:56:51 INFO - ##### Running clobber step. 18:56:51 INFO - ##### 18:56:51 INFO - Running pre-action listener: _resource_record_pre_action 18:56:51 INFO - Running main action method: clobber 18:56:51 INFO - rmtree: /builds/slave/test/build 18:56:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:56:53 INFO - Running post-action listener: _resource_record_post_action 18:56:53 INFO - ##### 18:56:53 INFO - ##### Running read-buildbot-config step. 18:56:53 INFO - ##### 18:56:53 INFO - Running pre-action listener: _resource_record_pre_action 18:56:53 INFO - Running main action method: read_buildbot_config 18:56:53 INFO - Using buildbot properties: 18:56:53 INFO - { 18:56:53 INFO - "project": "", 18:56:53 INFO - "product": "firefox", 18:56:53 INFO - "script_repo_revision": "production", 18:56:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:56:53 INFO - "repository": "", 18:56:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:56:53 INFO - "buildid": "20160223165745", 18:56:53 INFO - "pgo_build": "False", 18:56:53 INFO - "basedir": "/builds/slave/test", 18:56:53 INFO - "buildnumber": 155, 18:56:53 INFO - "slavename": "t-yosemite-r7-0182", 18:56:53 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:56:53 INFO - "platform": "yosemite_r7", 18:56:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:56:53 INFO - "branch": "mozilla-central", 18:56:53 INFO - "repo_path": "mozilla-central", 18:56:53 INFO - "revision": "5b2baa5e9356644a7ed0b73e422eaff62e159ffb", 18:56:53 INFO - "stage_platform": "macosx64", 18:56:53 INFO - "builduid": "fe3ba3ee68d343d383aa24b7f264a715", 18:56:53 INFO - "slavebuilddir": "test" 18:56:53 INFO - } 18:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:56:53 INFO - Running post-action listener: _resource_record_post_action 18:56:53 INFO - ##### 18:56:53 INFO - ##### Running download-and-extract step. 18:56:53 INFO - ##### 18:56:53 INFO - Running pre-action listener: _resource_record_pre_action 18:56:53 INFO - Running main action method: download_and_extract 18:56:53 INFO - mkdir: /builds/slave/test/build/tests 18:56:53 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')]} 18:56:53 INFO - https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/test_packages.json 18:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/test_packages.json 18:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:56:54 INFO - Downloaded 1277 bytes. 18:56:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:56:54 INFO - Using the following test package requirements: 18:56:54 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:56:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:56:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:56:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'jsshell-mac.zip'], 18:56:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:56:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:56:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:56:54 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:56:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:56:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:56:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:56:54 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:56:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:54 INFO - https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:56:55 INFO - Downloaded 17825926 bytes. 18:56:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:56:58 INFO - Return code: 0 18:56:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:56:58 INFO - https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:56:59 INFO - Downloaded 17825926 bytes. 18:56:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:56:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:57:03 INFO - Return code: 0 18:57:03 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')]} 18:57:03 INFO - https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:57:04 INFO - Downloaded 10707015 bytes. 18:57:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:57:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:57:04 INFO - Return code: 0 18:57:04 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')]} 18:57:04 INFO - https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:57:07 INFO - Downloaded 111458137 bytes. 18:57:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:07 INFO - mkdir: /builds/slave/test/properties 18:57:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:07 INFO - Contents: 18:57:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:57:08 INFO - Running post-action listener: _resource_record_post_action 18:57:08 INFO - Running post-action listener: set_extra_try_arguments 18:57:08 INFO - ##### 18:57:08 INFO - ##### Running populate-webroot step. 18:57:08 INFO - ##### 18:57:08 INFO - Running pre-action listener: _resource_record_pre_action 18:57:08 INFO - Running main action method: populate_webroot 18:57:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:08 INFO - '--tppagecycles', 18:57:08 INFO - '7'], 18:57:08 INFO - 'tests': ['tsvgm']}}, 18:57:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:57:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:57:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:57:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'tests': ['damp', 'tps']}, 18:57:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['damp', 'tps']}, 18:57:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:57:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:08 INFO - 'other': {'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'other_l64': {'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'other_nol64': {'tests': ['a11yr', 18:57:08 INFO - 'ts_paint', 18:57:08 INFO - 'tpaint', 18:57:08 INFO - 'sessionrestore', 18:57:08 INFO - 'sessionrestore_no_auto_restore']}, 18:57:08 INFO - 'svgr': {'tests': ['tsvgx', 18:57:08 INFO - 'tsvgr_opacity', 18:57:08 INFO - 'tart', 18:57:08 INFO - 'tscrollx', 18:57:08 INFO - 'cart']}, 18:57:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['tsvgx', 18:57:08 INFO - 'tsvgr_opacity', 18:57:08 INFO - 'tart', 18:57:08 INFO - 'tscrollx', 18:57:08 INFO - 'cart']}, 18:57:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'tests': ['tp5o']}, 18:57:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'talos_options': ['--e10s'], 18:57:08 INFO - 'tests': ['tp5o']}, 18:57:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'talos_options': ['--xperf_path', 18:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:08 INFO - 'tests': ['tp5n']}, 18:57:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:08 INFO - 'talos_options': ['--e10s', 18:57:08 INFO - '--xperf_path', 18:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:08 INFO - 'tests': ['tp5n']}}, 18:57:08 INFO - 'talos.zip': {'path': '', 18:57:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:08 INFO - Running post-action listener: _resource_record_post_action 18:57:08 INFO - ##### 18:57:08 INFO - ##### Running create-virtualenv step. 18:57:08 INFO - ##### 18:57:08 INFO - Running pre-action listener: _resource_record_pre_action 18:57:08 INFO - Running main action method: create_virtualenv 18:57:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:08 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 18:57:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:08 INFO - Using real prefix '/tools/python27' 18:57:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:12 INFO - Installing pip.................done. 18:57:12 INFO - Return code: 0 18:57:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18: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')]} 18:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:12 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 18:57:12 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 18:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:12 INFO - 'HOME': '/Users/cltbld', 18:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:12 INFO - 'LOGNAME': 'cltbld', 18:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:12 INFO - 'MOZ_NO_REMOTE': '1', 18:57:12 INFO - 'NO_EM_RESTART': '1', 18:57:12 INFO - 'PAGER': '/bin/cat', 18:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:12 INFO - 'PWD': '/builds/slave/test', 18:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:12 INFO - 'SHELL': '/bin/bash', 18:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:12 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:12 INFO - 'USER': 'cltbld', 18:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:12 INFO - 'XPC_FLAGS': '0x0', 18:57:12 INFO - 'XPC_SERVICE_NAME': '0', 18:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:12 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 18:57:12 INFO - Cleaning up... 18:57:12 INFO - Return code: 0 18:57:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18: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')]} 18:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:12 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:12 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 18:57:12 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 18:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:12 INFO - 'HOME': '/Users/cltbld', 18:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:12 INFO - 'LOGNAME': 'cltbld', 18:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:12 INFO - 'MOZ_NO_REMOTE': '1', 18:57:12 INFO - 'NO_EM_RESTART': '1', 18:57:12 INFO - 'PAGER': '/bin/cat', 18:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:12 INFO - 'PWD': '/builds/slave/test', 18:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:12 INFO - 'SHELL': '/bin/bash', 18:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:12 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:12 INFO - 'USER': 'cltbld', 18:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:12 INFO - 'XPC_FLAGS': '0x0', 18:57:12 INFO - 'XPC_SERVICE_NAME': '0', 18:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:12 INFO - Downloading/unpacking psutil>=0.7.1 18:57:12 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 18:57:12 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 18:57:12 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 18:57:12 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 18:57:12 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 18:57:12 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 18:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:15 INFO - Installing collected packages: psutil 18:57:15 INFO - Running setup.py install for psutil 18:57:15 INFO - building 'psutil._psutil_osx' extension 18:57:15 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 18:57:16 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 18:57:16 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 18:57:16 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 18:57:16 INFO - building 'psutil._psutil_posix' extension 18:57:16 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 18:57:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:57:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:57:16 INFO - ^ 18:57:16 INFO - 1 warning generated. 18:57:16 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 18:57:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:16 INFO - Successfully installed psutil 18:57:16 INFO - Cleaning up... 18:57:17 INFO - Return code: 0 18:57:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:57:17 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')]} 18:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:17 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')]} 18:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:17 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:17 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 18:57:17 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 18:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:17 INFO - 'HOME': '/Users/cltbld', 18:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:17 INFO - 'LOGNAME': 'cltbld', 18:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:17 INFO - 'MOZ_NO_REMOTE': '1', 18:57:17 INFO - 'NO_EM_RESTART': '1', 18:57:17 INFO - 'PAGER': '/bin/cat', 18:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:17 INFO - 'PWD': '/builds/slave/test', 18:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:17 INFO - 'SHELL': '/bin/bash', 18:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:17 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:17 INFO - 'USER': 'cltbld', 18:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:17 INFO - 'XPC_FLAGS': '0x0', 18:57:17 INFO - 'XPC_SERVICE_NAME': '0', 18:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:17 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 18:57:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:57:19 INFO - Installing collected packages: mozsystemmonitor 18:57:19 INFO - Running setup.py install for mozsystemmonitor 18:57:19 INFO - Successfully installed mozsystemmonitor 18:57:19 INFO - Cleaning up... 18:57:19 INFO - Return code: 0 18:57:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:19 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')]} 18:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:19 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')]} 18:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:19 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:19 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 18:57:19 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 18:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:19 INFO - 'HOME': '/Users/cltbld', 18:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:19 INFO - 'LOGNAME': 'cltbld', 18:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:19 INFO - 'MOZ_NO_REMOTE': '1', 18:57:19 INFO - 'NO_EM_RESTART': '1', 18:57:19 INFO - 'PAGER': '/bin/cat', 18:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:19 INFO - 'PWD': '/builds/slave/test', 18:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:19 INFO - 'SHELL': '/bin/bash', 18:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:19 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:19 INFO - 'USER': 'cltbld', 18:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:19 INFO - 'XPC_FLAGS': '0x0', 18:57:19 INFO - 'XPC_SERVICE_NAME': '0', 18:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:20 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 18:57:20 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 18:57:20 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 18:57:20 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 18:57:20 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 18:57:20 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 18:57:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18: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 18: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 18: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 18: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 18: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 18: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 18:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:23 INFO - Downloading docopt-0.6.1.tar.gz 18:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:23 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:23 INFO - Running setup.py install for blobuploader 18:57:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:23 INFO - Running setup.py install for requests 18:57:24 INFO - Running setup.py install for docopt 18:57:24 INFO - Successfully installed blobuploader requests docopt 18:57:24 INFO - Cleaning up... 18:57:24 INFO - Return code: 0 18:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:24 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')]} 18:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:24 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')]} 18:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:24 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:24 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 18:57:24 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 18:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:24 INFO - 'HOME': '/Users/cltbld', 18:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:24 INFO - 'LOGNAME': 'cltbld', 18:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:24 INFO - 'MOZ_NO_REMOTE': '1', 18:57:24 INFO - 'NO_EM_RESTART': '1', 18:57:24 INFO - 'PAGER': '/bin/cat', 18:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:24 INFO - 'PWD': '/builds/slave/test', 18:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:24 INFO - 'SHELL': '/bin/bash', 18:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:24 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:24 INFO - 'USER': 'cltbld', 18:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:24 INFO - 'XPC_FLAGS': '0x0', 18:57:24 INFO - 'XPC_SERVICE_NAME': '0', 18:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:24 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-dXmfsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:24 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-CgI1pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-LHql9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-X4GZSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-xe_AuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-PAefbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-5k1BH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-65kDRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-vTjmcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-6YgRGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:25 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-IdTUtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-eM7qOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-pY3tQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-UYWAka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-PZeoa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-pnRoCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:26 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-ljy95u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:26 INFO - Running setup.py install for manifestparser 18:57:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:26 INFO - Running setup.py install for mozcrash 18:57:26 INFO - Running setup.py install for mozdebug 18:57:27 INFO - Running setup.py install for mozdevice 18:57:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Running setup.py install for mozfile 18:57:27 INFO - Running setup.py install for mozhttpd 18:57:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Running setup.py install for mozinfo 18:57:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Running setup.py install for mozInstall 18:57:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:27 INFO - Running setup.py install for mozleak 18:57:27 INFO - Running setup.py install for mozlog 18:57:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Running setup.py install for moznetwork 18:57:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Running setup.py install for mozprocess 18:57:28 INFO - Running setup.py install for mozprofile 18:57:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Running setup.py install for mozrunner 18:57:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:28 INFO - Running setup.py install for mozscreenshot 18:57:28 INFO - Running setup.py install for moztest 18:57:29 INFO - Running setup.py install for mozversion 18:57:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:29 INFO - Cleaning up... 18:57:29 INFO - Return code: 0 18:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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')]} 18:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:29 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:29 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 18:57:29 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 18:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:29 INFO - 'HOME': '/Users/cltbld', 18:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:29 INFO - 'LOGNAME': 'cltbld', 18:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:29 INFO - 'MOZ_NO_REMOTE': '1', 18:57:29 INFO - 'NO_EM_RESTART': '1', 18:57:29 INFO - 'PAGER': '/bin/cat', 18:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:29 INFO - 'PWD': '/builds/slave/test', 18:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:29 INFO - 'SHELL': '/bin/bash', 18:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:29 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:29 INFO - 'USER': 'cltbld', 18:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:29 INFO - 'XPC_FLAGS': '0x0', 18:57:29 INFO - 'XPC_SERVICE_NAME': '0', 18:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:29 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-H0Nyix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:29 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)) 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:29 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-KfMz5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:29 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-RUkxQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:29 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)) 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:29 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-q5ejJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:29 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)) 18:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:29 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-9wctuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-T7k1oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-KKdFWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-nHOuLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-kCsN9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-Qs3qX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-f5tfjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-5hSkAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-uNELMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-oYtEWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:30 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)) 18:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:30 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-A5ccnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:31 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)) 18:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:31 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-JOTUik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:31 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)) 18:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:31 INFO - Running setup.py (path:/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/pip-3TKLw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:31 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)) 18:57:31 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:31 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:31 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)) 18:57:31 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)) 18:57:31 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)) 18:57:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:31 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 18:57:31 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 18:57:31 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 18:57:31 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 18:57:31 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 18:57:31 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 18:57:33 INFO - Downloading blessings-1.6.tar.gz 18:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:33 INFO - Installing collected packages: blessings 18:57:33 INFO - Running setup.py install for blessings 18:57:33 INFO - Successfully installed blessings 18:57:33 INFO - Cleaning up... 18:57:33 INFO - Return code: 0 18:57:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:34 INFO - Reading from file tmpfile_stdout 18:57:34 INFO - Current package versions: 18:57:34 INFO - blessings == 1.6 18:57:34 INFO - blobuploader == 1.2.4 18:57:34 INFO - docopt == 0.6.1 18:57:34 INFO - manifestparser == 1.1 18:57:34 INFO - mozInstall == 1.12 18:57:34 INFO - mozcrash == 0.16 18:57:34 INFO - mozdebug == 0.1 18:57:34 INFO - mozdevice == 0.48 18:57:34 INFO - mozfile == 1.2 18:57:34 INFO - mozhttpd == 0.7 18:57:34 INFO - mozinfo == 0.9 18:57:34 INFO - mozleak == 0.1 18:57:34 INFO - mozlog == 3.1 18:57:34 INFO - moznetwork == 0.27 18:57:34 INFO - mozprocess == 0.22 18:57:34 INFO - mozprofile == 0.28 18:57:34 INFO - mozrunner == 6.11 18:57:34 INFO - mozscreenshot == 0.1 18:57:34 INFO - mozsystemmonitor == 0.0 18:57:34 INFO - moztest == 0.7 18:57:34 INFO - mozversion == 1.4 18:57:34 INFO - psutil == 3.1.1 18:57:34 INFO - requests == 1.2.3 18:57:34 INFO - wsgiref == 0.1.2 18:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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')]} 18:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:34 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:34 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 18:57:34 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 18:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:34 INFO - 'HOME': '/Users/cltbld', 18:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:34 INFO - 'LOGNAME': 'cltbld', 18:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:34 INFO - 'MOZ_NO_REMOTE': '1', 18:57:34 INFO - 'NO_EM_RESTART': '1', 18:57:34 INFO - 'PAGER': '/bin/cat', 18:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:34 INFO - 'PWD': '/builds/slave/test', 18:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:34 INFO - 'SHELL': '/bin/bash', 18:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:34 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:34 INFO - 'USER': 'cltbld', 18:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:34 INFO - 'XPC_FLAGS': '0x0', 18:57:34 INFO - 'XPC_SERVICE_NAME': '0', 18:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 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)) 18:57:34 INFO - Cleaning up... 18:57:34 INFO - Return code: 0 18:57:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18: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')]} 18:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:34 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:34 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 18:57:34 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 18:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:34 INFO - 'HOME': '/Users/cltbld', 18:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:34 INFO - 'LOGNAME': 'cltbld', 18:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:34 INFO - 'MOZ_NO_REMOTE': '1', 18:57:34 INFO - 'NO_EM_RESTART': '1', 18:57:34 INFO - 'PAGER': '/bin/cat', 18:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:34 INFO - 'PWD': '/builds/slave/test', 18:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:34 INFO - 'SHELL': '/bin/bash', 18:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:34 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:34 INFO - 'USER': 'cltbld', 18:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:34 INFO - 'XPC_FLAGS': '0x0', 18:57:34 INFO - 'XPC_SERVICE_NAME': '0', 18:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:34 INFO - Downloading/unpacking jsonschema 18:57:34 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 18:57:34 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 18:57:34 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 18:57:34 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 18:57:34 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 18:57:34 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 18:57:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:37 INFO - Downloading/unpacking functools32 (from jsonschema) 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 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 18:57:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:37 INFO - warning: no files found matching '*.txt' 18:57:37 INFO - no previously-included directories found matching 'build' 18:57:37 INFO - no previously-included directories found matching 'dist' 18:57:37 INFO - no previously-included directories found matching '.git*' 18:57:37 INFO - Installing collected packages: jsonschema, functools32 18:57:37 INFO - Running setup.py install for functools32 18:57:37 INFO - warning: no files found matching '*.txt' 18:57:37 INFO - no previously-included directories found matching 'build' 18:57:37 INFO - no previously-included directories found matching 'dist' 18:57:37 INFO - no previously-included directories found matching '.git*' 18:57:37 INFO - Successfully installed jsonschema functools32 18:57:37 INFO - Cleaning up... 18:57:37 INFO - Return code: 0 18:57:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:37 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 0x10b573a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b57b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf19da8750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, '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.iyFmrhoGvY/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.nY9v9PacI2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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 18:57:37 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 18:57:37 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 18:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:57:37 INFO - 'HOME': '/Users/cltbld', 18:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:57:37 INFO - 'LOGNAME': 'cltbld', 18:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:37 INFO - 'MOZ_NO_REMOTE': '1', 18:57:37 INFO - 'NO_EM_RESTART': '1', 18:57:37 INFO - 'PAGER': '/bin/cat', 18:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:37 INFO - 'PWD': '/builds/slave/test', 18:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:57:37 INFO - 'SHELL': '/bin/bash', 18:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:57:37 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:57:37 INFO - 'USER': 'cltbld', 18:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:37 INFO - 'XPC_FLAGS': '0x0', 18:57:37 INFO - 'XPC_SERVICE_NAME': '0', 18:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:38 INFO - Downloading/unpacking flake8 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:38 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 18:57:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:57:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:57:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18: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 18: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 18: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 18: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 18: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 18: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 18:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:41 INFO - no previously-included directories found matching 'docs/_build' 18:57:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:57:41 INFO - Running setup.py install for pep8 18:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:57:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:57:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:57:41 INFO - no previously-included directories found matching 'docs/_build' 18:57:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:57:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:57:41 INFO - Cleaning up... 18:57:42 INFO - Return code: 0 18:57:42 INFO - Running post-action listener: _resource_record_post_action 18:57:42 INFO - Running post-action listener: _start_resource_monitoring 18:57:42 INFO - Starting resource monitoring. 18:57:42 INFO - ##### 18:57:42 INFO - ##### Running install step. 18:57:42 INFO - ##### 18:57:42 INFO - Running pre-action listener: _resource_record_pre_action 18:57:42 INFO - Running main action method: install 18:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:42 INFO - Reading from file tmpfile_stdout 18:57:42 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:42 INFO - Reading from file tmpfile_stdout 18:57:42 INFO - Output received: 18:57:42 INFO - Usage: mozinstall [options] installer 18:57:42 INFO - Options: 18:57:42 INFO - -h, --help show this help message and exit 18:57:42 INFO - -d DEST, --destination=DEST 18:57:42 INFO - Directory to install application into. [default: 18:57:42 INFO - "/builds/slave/test"] 18:57:42 INFO - --app=APP Application being installed. [default: firefox] 18:57:42 INFO - mkdir: /builds/slave/test/build/application 18:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:58:16 INFO - Reading from file tmpfile_stdout 18:58:16 INFO - Output received: 18:58:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:58:16 INFO - Running post-action listener: _resource_record_post_action 18:58:16 INFO - ##### 18:58:16 INFO - ##### Running run-tests step. 18:58:16 INFO - ##### 18:58:16 INFO - Running pre-action listener: _resource_record_pre_action 18:58:16 INFO - Running main action method: run_tests 18:58:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:58:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:58:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:58:16 INFO - 2016-02-23 18:58:16.457 screenresolution[1653:7370] starting screenresolution argv=screenresolution get 18:58:16 INFO - 2016-02-23 18:58:16.460 screenresolution[1653:7370] Display 0: 1600x1200x32@60 18:58:16 INFO - 2016-02-23 18:58:16.465 screenresolution[1654:7372] starting screenresolution argv=screenresolution list 18:58:16 INFO - Available Modes on Display 0 18:58:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:58:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:58:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:58:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:58:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:58:16 INFO - Intel Iris: 18:58:16 INFO - Chipset Model: Intel Iris 18:58:16 INFO - Type: GPU 18:58:16 INFO - Bus: Built-In 18:58:16 INFO - VRAM (Dynamic, Max): 1536 MB 18:58:16 INFO - Vendor: Intel (0x8086) 18:58:16 INFO - Device ID: 0x0a2e 18:58:16 INFO - Revision ID: 0x0009 18:58:16 INFO - Displays: 18:58:16 INFO - Display: 18:58:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:58:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:58:16 INFO - Display Serial Number: 1600x1200 60 18:58:16 INFO - Main Display: Yes 18:58:16 INFO - Mirror: Off 18:58:16 INFO - Online: Yes 18:58:16 INFO - Rotation: Supported 18:58:16 INFO - Return code: 0 18:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:16 INFO - Python 2.7.3 18:58:16 INFO - Return code: 0 18:58:16 INFO - grabbing minidump binary from tooltool 18:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:58:16 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 0x10b417d30>, '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 0x10b23bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b40eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:16 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 18:58:16 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 18:58:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:16 INFO - Return code: 0 18:58:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:58:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:58:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:58:18 INFO - Return code: 0 18:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 18:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 18:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iyFmrhoGvY/Render', 18:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:58:18 INFO - 'HOME': '/Users/cltbld', 18:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:58:18 INFO - 'LOGNAME': 'cltbld', 18:58:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:18 INFO - 'MOZ_NO_REMOTE': '1', 18:58:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:18 INFO - 'NO_EM_RESTART': '1', 18:58:18 INFO - 'PAGER': '/bin/cat', 18:58:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:18 INFO - 'PWD': '/builds/slave/test', 18:58:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:58:18 INFO - 'SHELL': '/bin/bash', 18:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nY9v9PacI2/Listeners', 18:58:18 INFO - 'TMPDIR': '/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/', 18:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:58:18 INFO - 'USER': 'cltbld', 18:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:18 INFO - 'XPC_FLAGS': '0x0', 18:58:18 INFO - 'XPC_SERVICE_NAME': '0', 18:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:58:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 18:58:18 INFO - mozversion application_buildid: 20160223165745 18:58:18 INFO - mozversion application_changeset: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb 18:58:18 INFO - mozversion application_display_name: Nightly 18:58:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:18 INFO - mozversion application_name: Firefox 18:58:18 INFO - mozversion application_remotingname: firefox 18:58:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:58:18 INFO - mozversion application_vendor: Mozilla 18:58:18 INFO - mozversion application_version: 47.0a1 18:58:18 INFO - mozversion platform_buildid: 20160223165745 18:58:18 INFO - mozversion platform_changeset: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb 18:58:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:58:18 INFO - mozversion platform_version: 47.0a1 18:58:18 INFO - using testdate: 1456282698 18:58:18 INFO - actual date: 1456282698 18:58:18 INFO - starting webserver on 'localhost:49275' 18:58:18 INFO - SUITE-START | Running 2 tests 18:58:18 INFO - TEST-START | dromaeo_css 18:58:18 INFO - operating with platform_type : mac_ 18:58:18 INFO - Initialising browser for dromaeo_css test... 18:58:18 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpJQGp_L/profile http://localhost:49275/getInfo.html) 18:58:21 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 18:58:21 INFO - PROCESS | 1672 | colorDepth:24 18:58:21 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 18:58:21 INFO - PROCESS | 1672 | __metrics 18:58:21 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:58:21 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:21 INFO - TEST-INFO | 1672: exit 0 18:58:21 INFO - Browser initialized. 18:58:21 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:21 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpJQGp_L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:33 INFO - PROCESS | 1675 | RSS: Main: 244244480 18:58:33 INFO - PROCESS | 1675 | 18:59:24 INFO - PROCESS | 1675 | 1456282764704 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] 19:01:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 19:01:37 INFO - PROCESS | 1675 | RSS: Main: 348454912 19:01:37 INFO - PROCESS | 1675 | 19:04:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 19:04:40 INFO - PROCESS | 1675 | RSS: Main: 380231680 19:04:40 INFO - PROCESS | 1675 | 19:07:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 19:07:43 INFO - PROCESS | 1675 | RSS: Main: 375349248 19:07:43 INFO - PROCESS | 1675 | 19:10:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 19:10:45 INFO - PROCESS | 1675 | RSS: Main: 332951552 19:10:45 INFO - PROCESS | 1675 | 19:13:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 19:13:49 INFO - PROCESS | 1675 | RSS: Main: 335773696 19:13:49 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 19:16:52 INFO - PROCESS | 1675 | RSS: Main: 393302016 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | __start_tp_report 19:16:52 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 19:16:52 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 19:16:52 INFO - PROCESS | 1675 | |i|pagename|runs| 19:16:52 INFO - PROCESS | 1675 | |0;dojo.html;3300.8019518828874;3413.7269018478523;3470.8438120284586;3486.2330287336786;3531.7704349217297;5540.5290550303225;5577.414371490996;5584.413636568158;5596.608237423382;5645.040343141665;5636.971815140919;5655.095184770437;5689.886202275952;5809.302883653967;5818.272715910512;5096.668716533413;5122.8207012754565;5155.458676838915;5172.353455818023;5287.233351164079;5235.476452354753;5260.342457192851;5295.894082118355;5318.6011049171275;5350.063738845686;5077.796888124471;5129.358830146231;5202.2456743771945;5211.947880521222;5248.134057880426;5185.299984502081;5190.766415511273;5198.090334191501;5228.2680424740565;5249;4621.659718681578;5006.649534532584;5122.692638441706;5204.973975130138;5207.765650545734;5473.01485732568;5564.693941833198;5578.191162281487;5599.776008959637;5613.298337707786;6175.84560385994;6199.132121502948;6205.875882482325;6217.5336849735995;6218.968905155445;5208.921866172011;6104.786332478387;6242.09489624002;6255.186825712673;6258.311585725612;5715.0855863062125;5740.885182296414;5751.25233719618;5752.741126649311;5792.275965504312;5291.285676433709;6241.594296370812;6271.592346497463;6299.433051025429;6310.7791227306825;5900.20347253124;5987.520998320124;6019.939800601938;6055.515558755289;6068.757249709962;6084.148219249309;6110.4195101466175;6157.661328626879;6240.968795155995;6252.968735156295;6113.786017489456;6124.234470691164;6133.6319820810895;6136.6011209271255;6158;6168.414000669929;6183.84540386485;6189.96905015472;6195;6204.13142160098;4071.470708807836;4815.494373090845;4840.83057093;4852.417709874767;4858.902821943541;4190.078182799779;4290.163418133434;4303.053328267776;4385.627221686129;4404.053128577371;5569.415211402826;5641.830745077572;5643.5203007743985;5647.576431767634;5675.517581005578;5207.479252074838;6039;6140.504248697391;6141.731496609813;6247.00047992319;5668.914966275509;5704.11586204139;5728.570357223225;5734.139879018181;5744.425557444222;5212.452692467312;5300.2049692546425;5300.575953923677;5306.734663266821;5312.62811603184;6235.968820155961;6238.968805155945;6281.52888533371;6294.433500984934;6301.684915754286;6245.469135123565;6259.092431597484;6278.372162783685;6296;6304.495640348669;6188.257409110935;6203.503719702323;6294.622322660472;6302.905456418066;6321.367863213642;6146.815595532141;6150.753969841336;6151;6169.2288463942;6170.043643235305;5998.550108741949;6245.0632405139595;6245.6252624842655;6254.718537665907;6263.467605253422;5061.291419201241;5896.292444906639;6036.758529658764;6070.271567411939;6126.6017708848785;4909.803607855789;6007.939920600913;6052.515798736179;6053.485453736482;6084.665343406155;5817.883642327214;5930.851728706817;5940.55445841555;5942.821715348547;5943.554233432596;6022.668753218615;6066.726997285221;6090.756369745338;6104.32852386246;6141.508679305734;5914.526837852875;5935.97541264865;5951.702414879325;5955.67243801595;6015.939840601713 19:16:52 INFO - PROCESS | 1675 | |1;ext.html;490.39681192133696;514.5137844736726;528.7409169506941;538.4185080113476;573.541167066347;32462.513062304024;37832;38147;38539.61460385399;38609.61390386099;41179.17641647165;41748.37377439341;41789.582104178946;41866.372004419885;42021.94945126366;9368.95315523423;9557.952210238975;9596.424214547149;9613.375130616523;9621.951890240574;9647.276454265922;9820.656277030306;9824.115829575338;9837.311388202828;9839.606415743361;9757.024297570222;9870.605175792996;9881.95059024704;9882.851757223647;9893.060159284893;9754.170895473857;9828.606855725762;9830.311878168566;9850.310478266525;9875.60497580096;9501.477418741966;9635.13283804454;9667.468289244089;9673.03269673034;9679.177269931994;40024;40337.79831100855;40348;40379.788606341564;40643.390349144785;3161.8577164027674;3166.255929856482;3304.1244070321145;3356.9832150839334;3548.183917698918;28528.572071418945;29237.41525169506;29349.41301173986;29378.412431751247;29670.85164574185;2419.3709635494724;2779;2819.957700634492;2830.8584570771586;2874.3820078683184;479218.6039069817;482763;484766;484873.5756321231;485388;44698.77650611726;45034.09931801411;45124;45189.32216016763;63277.68361158165;43207.56792432098;43422.56577434185;43682.563174368486;43691.78154109209;43730.34404483935;14937.850621493646;15097.698046039017;15100.244987750568;15102.54692359231;15104.848951510345;12266.018718502499;12352.567660131852;12354.629361119181;12407.945324647326;12459.940905023175;14542.854571454362;14556.666169376938;14563.708725825423;14573.927130364493;14806.777898331533;5191.766370513336;6055.971249631335;6120.387961203933;6151.72317245725;6156.907646385308;889.5241046040467;906.3066753933247;1036.3367444835312;1124.8031594470935;1143.48488253065;29029.56455653167;29169;29274.707252927623;29760.851195743882;29881.402371952438;970.7039352997404;1022.2384323678907;1043.0820877627639;1056.8678915135608;1154.4977934598476;12147.93926030382;14140.363683634261;14552.781708274384;14729.705405892037;14932.925335373253;533219;539451;540239;540611;541434;57881.4211857876;58581.5354616138;58610.706946465;58618;58742.11886821701;1277.4570807406815;1397.622641886685;1399.6290982889543;1413.8868890488736;1426.621945184527;27787.888484460396;27929.72070279271;27936.86031569829;28178;28271.858640706665;44990.77504612456;44993;45297.09405811931;45329.77335113303;45339.31991020071;302878;305098;305297;305653;306260;32667.673323267412;32970;33388.83305583456;33569.83215083909;33696.83151584226;44203.11593768171;44654.3301850479;45128.77435612801;45321.54678453305;45658.77170614259;35756.82121589375;36473.81763091274;37479;37658.62341376551;37700;36369;36550;36563.791032726425;36772.63227367799;37153;34807.4778878312;35901.281974359845;36069.63930360663;36091;36178;29823.850880745456;32028.839855801503;32617.695292188997;32745.34509309848;32842.17894552655;22451.775482245623;22743.88628056849;24048;25351;25356.239312820646 19:16:52 INFO - PROCESS | 1675 | |2;jquery.html;296.5921857446012;358.66823188550586;359.42312588295783;360.72404610472995;366.0373218435514;14601.707965840676;15231.781457483403;19369.709454358177;19895.801041989576;21447.678284825703;18848.15183316754;19006.524836879085;19391.612167756637;19457.708134377997;19794.901025494888;4970.502949705036;5659.632123911953;5837.182794408786;5880.059190529516;5881.264841894763;4185.372194170884;4381.605655491006;5898.056310990242;5993.970030149843;6190.566660333779;6358.109864618957;6381.840453988641;6384;6385.393387628191;6392.360763923593;6050.636961782285;6257.7184026718905;6263.718132684017;6271.529635277327;6348.9682551587175;5400.054990376669;5429.104197807396;5429.67421954684;5437.782488700447;5462.289902312714;23667.88166059176;24796;25500;25697.74302256972;25731.48537029249;2136.583366243583;2272.3523795718143;2433.270018994295;2554.118829003991;2898.825975479934;14185.716285674333;14419.855801441956;14648.633784155374;15200.315985780666;15345.539633811004;1767.6641438126715;1803.7474753534516;1811.356968276256;1831.359024341483;1850.722391641251;105371.20458374787;106742.3988640171;108845;109137;109553.45223273912;8730.476171429735;10185.694429167137;10578.994995475417;10614.150867930546;10662.573497060032;12631.810522842165;12709.110362274738;12717.618471445687;12728.936355318165;12744.235345879277;8346.332293416512;8352.916470835335;8386;8460.323174146053;8471.364647651451;8561.272291855137;8587.012493563196;8591.656333746705;8688;8698.47809131454;6086.60437071589;6198.969005155035;6202.906956395657;6224.688765561704;6226.283977342573;1656.2278362152622;1718.9828101718822;1719.2693105430142;1781.8752687312024;1787.0350010993918;399.89402808255835;407.77776112019023;905.8731777551149;942.6229508196776;988.7231575158967;10668.413237271869;11182.776344473064;11759;11811.291322520676;11845.940770296265;426.5201648145836;429.7292705595517;438.160921834683;460.20614440090577;466.77594754517344;6015.789447369409;6103.84740381494;6228.408301211378;8405.621747021398;11542.826857597143;480514;627345;637026;652571;652774;104635.4768226154;114532;116639;121849.39075304744;123061;982.189693502863;983.5377372634994;998.14159822554;1002.173207104142;1003.2626019875386;18510.444686659423;18757.906210469406;18764.249430022646;18775;19123.426297211106;53481.4651853492;53660.46339536711;54452.18321725257;54649.36051918449;55486.722566388526;76471;77401.61299193469;78850;79686;79722.6013869927;7892.4080693947035;7928.365730741411;8171.060328062111;8189.631466583899;8198.221168988937;10696.41169735672;13125.146865453715;13404.664883377603;13584.184948903097;13662.111962722789;11556.826647600461;11746.35395053246;11817.054635629302;11850.585229516926;11860.406979651156;5187.974060129675;10341.482925853828;11026;11279.913016588798;11357.034652054668;8145.592720364077;11820.468078936641;12022.218555793845;12063.974562162315;12077.637670869888;6745.5952642841585;7993.280604745601;8003.799905002189;8206.384521160817;8324.916750832657;10508.42203678805;10924.268932766809;11203.551857925917;11573.074154067486;11623.709407264885 19:16:52 INFO - PROCESS | 1675 | |3;mootools.html;1363.420546267836;1488.56087454201;1529.6252418157549;1735.5140560643024;1893.6970084786428;7712;8467.788305292363;8587.871181932276;8591.785205369868;8596.785080372994;8280.254777070062;8526.53104079277;8527.275181609555;8528.061913189544;8567.314614830813;2100.5588826346448;2132.658774596065;2185.8360622953264;2185.868847869125;2448.8285819992607;2203.7796220377913;2406.8074554035634;2464.531738969599;2466.2477944227003;2468.160825319391;2356.8232382571377;2403.6995375578053;2417.758224177586;2419.50400167966;2421.636754486832;2376.607859703147;2408.5303365843665;2415.5651982643117;2416.492536567323;2420.394901274681;2413.1192114877945;2414.5895197816412;2417.8791060446906;2420.140849998243;2420.7579242075826;7462.664180111908;8682.652693892236;8723;8746.125387461267;8772.692955746583;5286.418493965661;5409.6213265071465;5412.539934105605;5424.186372044225;5426.565874730012;3485.093875592339;3485.5120283160377;3587.5694916609914;3595.3168897909577;3610.4042832932537;1004.0862814838534;1004.1765752083295;1037.7509397744486;1048.130052056791;1054.2883553601366;11651.067914566815;11692.649220523397;11692.999999999915;11693.766124677459;11720.706982325424;4727.405708863718;4767.95232047682;4797.304390863305;4830.758462076882;4837;9898.406095634286;9914.752131196778;9920.355176913477;9945.005499449997;9986.950065249772;5339.46605339463;5354.491323324278;5359.651622644516;5364.329458817648;5387.46125387466;4375.365571992043;4505.36924830524;4645.210314246586;4897.706137631753;4901.583365413909;3865.9613403866165;3871.5934826842777;3872.283627528916;3921.8823435296986;3928.194720082376;1244.440001999104;1258.2764910176686;1258.8804063613943;1263.8041103628768;1282.0576875996135;1047.9580816767243;1068.9251752377415;1068.951897164614;1210.673118258083;1353.4924403348743;7914.960425197837;8002.1997800219515;8095.55474448911;8095.676172953016;8118.634661440131;489.45670305960357;504.8409750928446;505.5500604462032;508.9923651145236;509.66107538487233;6125.1731016313115;6160.815175544741;6170.81487555374;6173.444390004831;6194.473469755121;8895.24390426808;10298.124659404035;10350.689479315633;10484.475776211159;10509.211809114347;8792.252658524098;8795.824083518293;10062.144717698931;10261.7434564135;10333.793324133476;7834.647440865175;7961.522308661499;7974.242446967645;8030.598470076473;8039.316658084128;7862.960685196537;7923.643436045507;7987.081485629227;7988.92011079905;8031.718889838828;9218.677346292847;9385.624575016924;9631.229501639711;9645.324827262024;9651;9588.041195880356;9901.10890019873;9902.306838521523;9902.752431189278;9913.950430247802;6782.491313151435;6931.4108300795;7227.241139680258;7411.888821667571;7554.169041405331;8067.0722866871065;8091.312238459797;8117.431779775359;8132.1867813218205;8166.183381661786;7117.359437650429;7211.314925082109;7222.6388680566815;7348.77953661391;7359.190489046094;7018.5788852669;7091.43268538526;7143.571385716874;7207.6756545956605;7341.3392794648735;7069.798134317076;7204.9279507204255;7521.360684341892;7632.389408847168;7638.236176382317;6856.005879147396;6953.513254072369;6956.478264130109;6960.512764106464;6961.79114626562;6885.931140688529;6989.405900498311;6997.230304666585;7002.859942801014;7012.333828286304 19:16:52 INFO - PROCESS | 1675 | |4;prototype.html;315.0501238765124;323.0647276135588;326.1471252674256;328.2958054972086;329.43337459569534;6528.08606795049;6543.934560654392;6557.344265573434;6587.143671322728;6587.275399706028;6621.106150669658;6625.238097618775;6627.469802415807;6630.3038180991025;6639.568428052174;4705;4812.711237325754;4813.278008298766;4953.950460495403;4955.529224723646;4891.730954797485;4898.24077268024;4906.852794416173;4909.656324057318;4924.926126108094;4852.9808740164435;4862.708237505743;4869.488703686097;4872.976674898276;4878.390201224847;4643.628509719214;4738.218193997986;4853.538913803183;4884.633652476078;4887.975560122177;4145.481814773153;4163.125743593849;4171.33258678613;4179.895502612429;4203.7057405981595;5116.820911268088;6232.407921247474;6341.492680585542;6344.984802431635;6371.362863713638;5767.769289228426;5768.798092066758;5777.855553611152;5778.855528611776;5783.161441590946;6998.895016574756;7004.369606735368;7008.439324853999;7010.369066784014;7013.263607321209;4318.244307246219;4485.775711214426;4486.685931984763;4487.775611219426;4489.663275254369;7247.094113235846;7350.926490735078;7379.852402951911;7386.0767404074495;7407.925920740831;3748.3815170496564;3925.841876646396;4632.189366860786;4636.397268355092;4644.9767751161025;4673.906521869543;4677.508861569486;4681.7190968542;4682.344471773954;4701.553352431513;4637.721736695809;5612.186232996192;5622.297212848394;5622.887542249214;5627.465390787868;6200.131981522591;6838.829029274308;7066.434685225273;7097.148342198969;7119.75080872167;1608.5335252776797;1611.5165450364843;1627.0481768165755;1631.4779270633283;1633.9264733087039;974.9902500975041;1011.6256984915481;1031.6750223679517;1037.0200160847926;1060.1571750458404;5396.892062158735;5549.750261238254;6689.4982876284475;6720.495962802809;6725.562838415487;7502.6623801929045;7504.137024242173;7510.924890751132;7511.549307041595;7538.283863033003;6758.5269031167345;6764;6767.018782276641;6772.830679233059;6779;3255.544223808669;3778.1688028633657;3880.3209438348176;3928.899908025757;3936.075022369741;7810.218978102144;7812.062552493623;7837.7648670539975;7840.176781437867;7861.882071768928;7685.346745526693;7687.923120768833;7693.192214817475;7696.076470823537;7703.653335599912;6379.393957574023;7792.649330780128;7795.57124358143;7802.999999999886;7817.296443320129;6928.960655901655;7194.964025179841;7438.851222975619;7450.813729656802;7451.254874512505;6580.473562115115;7321.158066822383;7321.853562928818;7333.779986600411;7338.449616278907;7825.5304681717;7826.256505631955;7828.256315650005;7830.960845195737;7832.843343132991;4595.954040459553;4650.581447669726;4662.860114196579;4664;4687.695299805502;7039.753608623673;7292.197858235696;7405.741473751532;7432.777016689508;7433.665485053294;7040.295970403124;7080.504364694422;7108.431325494052;7125.18060423058;7129.536580122275;5900.64596124234;7104.04095447108;7118.60847653384;7128.964355178191;7142.607261550722;5711.942880571307;6988.161420629557;6997.510174287954;7010.26392228829;7014.649267536704;6876.484263680344;7148.17795953472;7149.392301654418;7161.534500257467;7223.061002069698;5201.869953251047;6727.93272067273;6910.20532638753;6913.308669133046;6972.1981972071835 19:16:52 INFO - PROCESS | 1675 | |5;yui.html;668.4218151299126;728.5883475836156;729.9087614048242;745.1579714922141;792.2908996448175;15076.47232346868;15163.014404063728;15219.391224351026;15223.847761522382;15237.923810380946;13326.333683315845;13874.514391996283;13879.583612491617;13879.861201387983;13899;708.723597796857;714.7462650758957;856.400519636254;865.6796985115485;873.6418068591847;837.9832403351929;872.084311472954;872.8472517309477;875.7504111328273;878.8989266234369;739.5377888819488;750.8385697075128;911.2937473458056;917.5091326140516;917.9856258833993;734.6033142103231;882.6028287270753;909.895362033368;911.6307895302413;914.9725508234764;675.3887731602907;677.7051982387677;677.7729460630694;678.2335960364757;679.2121139478231;14827.332770025374;14861.628459288497;14897.702045959128;14907.105573665614;14919.2540372982;11225;11978.760424791455;12335;12612.117151799377;12638.747225055447;10008.96932095803;10052.86246764798;10084.899151008469;10097.091261786474;10105.141063009652;3525.2068284636007;3550.786952782841;3562.69717074049;3563.1448452371505;3566.35805555;70254;71340;78412.60793695995;80609;83360.16639833584;9438.528073596293;9457.007014263403;9466.621335146654;9492.240620750323;9581.281403894736;16783.664326713642;20296;20360.796392036187;20363.185472581226;20413.877236751825;6327.905081423783;7217.711291548279;7452.403807695371;7621.466497345244;7715.1899050600005;4067;4081.1429599783783;4094.191211136224;4124.092699606082;4161.209370219649;3504.6144924058844;3511.9297614047578;3544;3546.556680414948;3558.857645694195;645.9677016149174;657.273712547628;661.8610091880663;664.7507184805697;670.9597424154566;512.7205672908274;574.7557288152518;581.9738111784895;632.2792017100509;642.2197030607834;8435.072142064368;8471.618777155043;8755;9022.052684468168;9120.8631870522;553.8753780399459;609.6281268426256;613.4387035862226;619.891518984185;634.3688030409771;4007.899802504961;4030.6170913763144;4034.8789536313957;4103.466549348565;4108.548059713429;96088.51955740177;97763.0223697754;98086.50956745313;98274;99083;81993.18006819974;82040;82385.58807205925;83153.58423207846;83813;67379.32620673829;71454;71564.64217678878;71690.28309716836;72461;8696;8831.293496520135;8878.955605221932;9056.592453339485;9111.952125505652;47494;48179.518204817505;48605.27092093551;49452;50192.498075020245;66885.66557167182;70913.64543177251;71663.5667286641;71829.64085179541;72540;8915.465072095694;10723.30298530593;11134.944325278322;11232.157588181082;11266.324020558794;11752.23610465317;12085.395730213279;12414.131010829155;12435.942944849789;12514.624561263177;11009.504572294427;11559.36423496682;11575.942120289681;11617.941910290394;12241.816372754594;10997.945010274898;11096.833547496955;11176.329420234812;11588.420578970849;11745.588904388305;11015.173861960546;11209.943950280196;11319.660410187707;11544.076473881902;12179.817302740643;9491.061873241079;9498.905010949802;9519.666811661558;9831.31180817336;10312.226583006155;7864.21357864209;8956.373053886166;9152.58813353414;9403.4828084456;9968.50157492108 19:16:52 INFO - PROCESS | 1675 | __end_tp_report 19:16:52 INFO - PROCESS | 1675 | __start_cc_report 19:16:52 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,919 19:16:52 INFO - PROCESS | 1675 | __end_cc_report 19:16:52 INFO - PROCESS | 1675 | __startTimestamp1456283812403__endTimestamp 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | ------- Summary: start ------- 19:16:52 INFO - PROCESS | 1675 | Number of tests: 6 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5670.30 Median:5900.20 stddev:646.57 (11.0%) stddev-sans-first:621.26 19:16:52 INFO - PROCESS | 1675 | Values: 3300.8 3413.7 3470.8 3486.2 3531.8 5540.5 5577.4 5584.4 5596.6 5645.0 5637.0 5655.1 5689.9 5809.3 5818.3 5096.7 5122.8 5155.5 5172.4 5287.2 5235.5 5260.3 5295.9 5318.6 5350.1 5077.8 5129.4 5202.2 5211.9 5248.1 5185.3 5190.8 5198.1 5228.3 5249.0 4621.7 5006.6 5122.7 5205.0 5207.8 5473.0 5564.7 5578.2 5599.8 5613.3 6175.8 6199.1 6205.9 6217.5 6219.0 5208.9 6104.8 6242.1 6255.2 6258.3 5715.1 5740.9 5751.3 5752.7 5792.3 5291.3 6241.6 6271.6 6299.4 6310.8 5900.2 5987.5 6019.9 6055.5 6068.8 6084.1 6110.4 6157.7 6241.0 6253.0 6113.8 6124.2 6133.6 6136.6 6158.0 6168.4 6183.8 6190.0 6195.0 6204.1 4071.5 4815.5 4840.8 4852.4 4858.9 4190.1 4290.2 4303.1 4385.6 4404.1 5569.4 5641.8 5643.5 5647.6 5675.5 5207.5 6039.0 6140.5 6141.7 6247.0 5668.9 5704.1 5728.6 5734.1 5744.4 5212.5 5300.2 5300.6 5306.7 5312.6 6236.0 6239.0 6281.5 6294.4 6301.7 6245.5 6259.1 6278.4 6296.0 6304.5 6188.3 6203.5 6294.6 6302.9 6321.4 6146.8 6150.8 6151.0 6169.2 6170.0 5998.6 6245.1 6245.6 6254.7 6263.5 5061.3 5896.3 6036.8 6070.3 6126.6 4909.8 6007.9 6052.5 6053.5 6084.7 5817.9 5930.9 5940.6 5942.8 5943.6 6022.7 6066.7 6090.8 6104.3 6141.5 5914.5 5936.0 5951.7 5955.7 6015.9 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:58158.80 Median:37568.81 stddev:120818.90 (321.6%) stddev-sans-first:121080.24 19:16:52 INFO - PROCESS | 1675 | Values: 490.4 514.5 528.7 538.4 573.5 32462.5 37832.0 38147.0 38539.6 38609.6 41179.2 41748.4 41789.6 41866.4 42021.9 9369.0 9558.0 9596.4 9613.4 9622.0 9647.3 9820.7 9824.1 9837.3 9839.6 9757.0 9870.6 9882.0 9882.9 9893.1 9754.2 9828.6 9830.3 9850.3 9875.6 9501.5 9635.1 9667.5 9673.0 9679.2 40024.0 40337.8 40348.0 40379.8 40643.4 3161.9 3166.3 3304.1 3357.0 3548.2 28528.6 29237.4 29349.4 29378.4 29670.9 2419.4 2779.0 2820.0 2830.9 2874.4 479218.6 482763.0 484766.0 484873.6 485388.0 44698.8 45034.1 45124.0 45189.3 63277.7 43207.6 43422.6 43682.6 43691.8 43730.3 14937.9 15097.7 15100.2 15102.5 15104.8 12266.0 12352.6 12354.6 12407.9 12459.9 14542.9 14556.7 14563.7 14573.9 14806.8 5191.8 6056.0 6120.4 6151.7 6156.9 889.5 906.3 1036.3 1124.8 1143.5 29029.6 29169.0 29274.7 29760.9 29881.4 970.7 1022.2 1043.1 1056.9 1154.5 12147.9 14140.4 14552.8 14729.7 14932.9 533219.0 539451.0 540239.0 540611.0 541434.0 57881.4 58581.5 58610.7 58618.0 58742.1 1277.5 1397.6 1399.6 1413.9 1426.6 27787.9 27929.7 27936.9 28178.0 28271.9 44990.8 44993.0 45297.1 45329.8 45339.3 302878.0 305098.0 305297.0 305653.0 306260.0 32667.7 32970.0 33388.8 33569.8 33696.8 44203.1 44654.3 45128.8 45321.5 45658.8 35756.8 36473.8 37479.0 37658.6 37700.0 36369.0 36550.0 36563.8 36772.6 37153.0 34807.5 35901.3 36069.6 36091.0 36178.0 29823.9 32028.8 32617.7 32745.3 32842.2 22451.8 22743.9 24048.0 25351.0 25356.2 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34402.34 Median:327.63 stddev:101888.92 (31098.8%) stddev-sans-first:102142.56 19:16:52 INFO - PROCESS | 1675 | Values: 296.6 358.7 359.4 360.7 366.0 14601.7 15231.8 19369.7 19895.8 21447.7 18848.2 19006.5 19391.6 19457.7 19794.9 4970.5 5659.6 5837.2 5880.1 5881.3 4185.4 4381.6 5898.1 5994.0 6190.6 6358.1 6381.8 6384.0 6385.4 6392.4 6050.6 6257.7 6263.7 6271.5 6349.0 5400.1 5429.1 5429.7 5437.8 5462.3 23667.9 24796.0 25500.0 25697.7 25731.5 2136.6 2272.4 2433.3 2554.1 2898.8 14185.7 14419.9 14648.6 15200.3 15345.5 1767.7 1803.7 1811.4 1831.4 1850.7 105371.2 106742.4 108845.0 109137.0 109553.5 8730.5 10185.7 10579.0 10614.2 10662.6 12631.8 12709.1 12717.6 12728.9 12744.2 8346.3 8352.9 8386.0 8460.3 8471.4 8561.3 8587.0 8591.7 8688.0 8698.5 6086.6 6199.0 6202.9 6224.7 6226.3 1656.2 1719.0 1719.3 1781.9 1787.0 399.9 407.8 905.9 942.6 988.7 10668.4 11182.8 11759.0 11811.3 11845.9 426.5 429.7 438.2 460.2 466.8 6015.8 6103.8 6228.4 8405.6 11542.8 480514.0 627345.0 637026.0 652571.0 652774.0 104635.5 114532.0 116639.0 121849.4 123061.0 982.2 983.5 998.1 1002.2 1003.3 18510.4 18757.9 18764.2 18775.0 19123.4 53481.5 53660.5 54452.2 54649.4 55486.7 76471.0 77401.6 78850.0 79686.0 79722.6 7892.4 7928.4 8171.1 8189.6 8198.2 10696.4 13125.1 13404.7 13584.2 13662.1 11556.8 11746.4 11817.1 11850.6 11860.4 5188.0 10341.5 11026.0 11279.9 11357.0 8145.6 11820.5 12022.2 12064.0 12077.6 6745.6 7993.3 8003.8 8206.4 8324.9 10508.4 10924.3 11203.6 11573.1 11623.7 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5897.23 Median:5425.38 stddev:3124.74 (57.6%) stddev-sans-first:3114.92 19:16:52 INFO - PROCESS | 1675 | Values: 1363.4 1488.6 1529.6 1735.5 1893.7 7712.0 8467.8 8587.9 8591.8 8596.8 8280.3 8526.5 8527.3 8528.1 8567.3 2100.6 2132.7 2185.8 2185.9 2448.8 2203.8 2406.8 2464.5 2466.2 2468.2 2356.8 2403.7 2417.8 2419.5 2421.6 2376.6 2408.5 2415.6 2416.5 2420.4 2413.1 2414.6 2417.9 2420.1 2420.8 7462.7 8682.7 8723.0 8746.1 8772.7 5286.4 5409.6 5412.5 5424.2 5426.6 3485.1 3485.5 3587.6 3595.3 3610.4 1004.1 1004.2 1037.8 1048.1 1054.3 11651.1 11692.6 11693.0 11693.8 11720.7 4727.4 4768.0 4797.3 4830.8 4837.0 9898.4 9914.8 9920.4 9945.0 9987.0 5339.5 5354.5 5359.7 5364.3 5387.5 4375.4 4505.4 4645.2 4897.7 4901.6 3866.0 3871.6 3872.3 3921.9 3928.2 1244.4 1258.3 1258.9 1263.8 1282.1 1048.0 1068.9 1069.0 1210.7 1353.5 7915.0 8002.2 8095.6 8095.7 8118.6 489.5 504.8 505.6 509.0 509.7 6125.2 6160.8 6170.8 6173.4 6194.5 8895.2 10298.1 10350.7 10484.5 10509.2 8792.3 8795.8 10062.1 10261.7 10333.8 7834.6 7961.5 7974.2 8030.6 8039.3 7863.0 7923.6 7987.1 7988.9 8031.7 9218.7 9385.6 9631.2 9645.3 9651.0 9588.0 9901.1 9902.3 9902.8 9914.0 6782.5 6931.4 7227.2 7411.9 7554.2 8067.1 8091.3 8117.4 8132.2 8166.2 7117.4 7211.3 7222.6 7348.8 7359.2 7018.6 7091.4 7143.6 7207.7 7341.3 7069.8 7204.9 7521.4 7632.4 7638.2 6856.0 6953.5 6956.5 6960.5 6961.8 6885.9 6989.4 6997.2 7002.9 7012.3 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5768.49 Median:6587.21 stddev:1887.62 (28.7%) stddev-sans-first:1848.01 19:16:52 INFO - PROCESS | 1675 | Values: 315.1 323.1 326.1 328.3 329.4 6528.1 6543.9 6557.3 6587.1 6587.3 6621.1 6625.2 6627.5 6630.3 6639.6 4705.0 4812.7 4813.3 4954.0 4955.5 4891.7 4898.2 4906.9 4909.7 4924.9 4853.0 4862.7 4869.5 4873.0 4878.4 4643.6 4738.2 4853.5 4884.6 4888.0 4145.5 4163.1 4171.3 4179.9 4203.7 5116.8 6232.4 6341.5 6345.0 6371.4 5767.8 5768.8 5777.9 5778.9 5783.2 6998.9 7004.4 7008.4 7010.4 7013.3 4318.2 4485.8 4486.7 4487.8 4489.7 7247.1 7350.9 7379.9 7386.1 7407.9 3748.4 3925.8 4632.2 4636.4 4645.0 4673.9 4677.5 4681.7 4682.3 4701.6 4637.7 5612.2 5622.3 5622.9 5627.5 6200.1 6838.8 7066.4 7097.1 7119.8 1608.5 1611.5 1627.0 1631.5 1633.9 975.0 1011.6 1031.7 1037.0 1060.2 5396.9 5549.8 6689.5 6720.5 6725.6 7502.7 7504.1 7510.9 7511.5 7538.3 6758.5 6764.0 6767.0 6772.8 6779.0 3255.5 3778.2 3880.3 3928.9 3936.1 7810.2 7812.1 7837.8 7840.2 7861.9 7685.3 7687.9 7693.2 7696.1 7703.7 6379.4 7792.6 7795.6 7803.0 7817.3 6929.0 7195.0 7438.9 7450.8 7451.3 6580.5 7321.2 7321.9 7333.8 7338.4 7825.5 7826.3 7828.3 7831.0 7832.8 4596.0 4650.6 4662.9 4664.0 4687.7 7039.8 7292.2 7405.7 7432.8 7433.7 7040.3 7080.5 7108.4 7125.2 7129.5 5900.6 7104.0 7118.6 7129.0 7142.6 5711.9 6988.2 6997.5 7010.3 7014.6 6876.5 7148.2 7149.4 7161.5 7223.1 5201.9 6727.9 6910.2 6913.3 6972.2 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:18497.42 Median:644.09 stddev:26384.66 (4096.4%) stddev-sans-first:26424.71 19:16:52 INFO - PROCESS | 1675 | Values: 668.4 728.6 729.9 745.2 792.3 15076.5 15163.0 15219.4 15223.8 15237.9 13326.3 13874.5 13879.6 13879.9 13899.0 708.7 714.7 856.4 865.7 873.6 838.0 872.1 872.8 875.8 878.9 739.5 750.8 911.3 917.5 918.0 734.6 882.6 909.9 911.6 915.0 675.4 677.7 677.8 678.2 679.2 14827.3 14861.6 14897.7 14907.1 14919.3 11225.0 11978.8 12335.0 12612.1 12638.7 10009.0 10052.9 10084.9 10097.1 10105.1 3525.2 3550.8 3562.7 3563.1 3566.4 70254.0 71340.0 78412.6 80609.0 83360.2 9438.5 9457.0 9466.6 9492.2 9581.3 16783.7 20296.0 20360.8 20363.2 20413.9 6327.9 7217.7 7452.4 7621.5 7715.2 4067.0 4081.1 4094.2 4124.1 4161.2 3504.6 3511.9 3544.0 3546.6 3558.9 646.0 657.3 661.9 664.8 671.0 512.7 574.8 582.0 632.3 642.2 8435.1 8471.6 8755.0 9022.1 9120.9 553.9 609.6 613.4 619.9 634.4 4007.9 4030.6 4034.9 4103.5 4108.5 96088.5 97763.0 98086.5 98274.0 99083.0 81993.2 82040.0 82385.6 83153.6 83813.0 67379.3 71454.0 71564.6 71690.3 72461.0 8696.0 8831.3 8879.0 9056.6 9112.0 47494.0 48179.5 48605.3 49452.0 50192.5 66885.7 70913.6 71663.6 71829.6 72540.0 8915.5 10723.3 11134.9 11232.2 11266.3 11752.2 12085.4 12414.1 12435.9 12514.6 11009.5 11559.4 11575.9 11617.9 12241.8 10997.9 11096.8 11176.3 11588.4 11745.6 11015.2 11209.9 11319.7 11544.1 12179.8 9491.1 9498.9 9519.7 9831.3 10312.2 7864.2 8956.4 9152.6 9403.5 9968.5 19:16:52 INFO - PROCESS | 1675 | -------- Summary: end -------- 19:16:52 INFO - PROCESS | 1675 | 19:16:52 INFO - TEST-INFO | 1675: exit 0 19:16:52 INFO - TEST-OK | dromaeo_css | took 1114224ms 19:16:52 INFO - TEST-START | kraken 19:16:52 INFO - operating with platform_type : mac_ 19:16:52 INFO - Initialising browser for kraken test... 19:16:52 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpVSn16n/profile http://localhost:49275/getInfo.html) 19:16:55 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 19:16:55 INFO - PROCESS | 1685 | colorDepth:24 19:16:55 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 19:16:55 INFO - PROCESS | 1685 | __metrics 19:16:55 INFO - PROCESS | 1685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:16:55 INFO - PROCESS | 1685 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:16:55 INFO - TEST-INFO | 1685: exit 0 19:16:55 INFO - Browser initialized. 19:16:55 INFO - Running cycle 1/1 for kraken test... 19:16:55 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/T/tmpVSn16n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:07 INFO - PROCESS | 1687 | RSS: Main: 244195328 19:17:07 INFO - PROCESS | 1687 | 19:17:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:11 INFO - PROCESS | 1687 | RSS: Main: 290185216 19:17:11 INFO - PROCESS | 1687 | 19:17:13 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 19:17:14 INFO - PROCESS | 1687 | RSS: Main: 301682688 19:17:14 INFO - PROCESS | 1687 | 19:17:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 19:17:18 INFO - PROCESS | 1687 | RSS: Main: 288550912 19:17:18 INFO - PROCESS | 1687 | 19:17:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 19:17:20 INFO - PROCESS | 1687 | RSS: Main: 290488320 19:17:20 INFO - PROCESS | 1687 | 19:17:22 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:23 INFO - PROCESS | 1687 | RSS: Main: 289271808 19:17:23 INFO - PROCESS | 1687 | 19:17:26 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 19:17:26 INFO - PROCESS | 1687 | RSS: Main: 288980992 19:17:26 INFO - PROCESS | 1687 | 19:17:29 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:30 INFO - PROCESS | 1687 | RSS: Main: 290856960 19:17:30 INFO - PROCESS | 1687 | 19:17:32 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 19:17:33 INFO - PROCESS | 1687 | RSS: Main: 291336192 19:17:33 INFO - PROCESS | 1687 | 19:17:34 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:35 INFO - PROCESS | 1687 | RSS: Main: 324587520 19:17:35 INFO - PROCESS | 1687 | 19:17:37 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:37 INFO - PROCESS | 1687 | RSS: Main: 323084288 19:17:37 INFO - PROCESS | 1687 | 19:17:40 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:40 INFO - PROCESS | 1687 | RSS: Main: 332558336 19:17:40 INFO - PROCESS | 1687 | 19:17:43 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:17:43 INFO - PROCESS | 1687 | RSS: Main: 332558336 19:17:43 INFO - PROCESS | 1687 | 19:17:46 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:46 INFO - PROCESS | 1687 | RSS: Main: 333299712 19:17:46 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 19:17:48 INFO - PROCESS | 1687 | RSS: Main: 393646080 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | __start_tp_report 19:17:48 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 19:17:48 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 19:17:48 INFO - PROCESS | 1687 | |i|pagename|runs| 19:17:48 INFO - PROCESS | 1687 | |0;ai-astar;110;109;113;160;163;111;115;111;111;111 19:17:48 INFO - PROCESS | 1687 | |1;audio-beat-detection;156;124;142;155;121;143;140;118;153;120 19:17:48 INFO - PROCESS | 1687 | |2;audio-dft;186;185;186;185;183;184;185;181;184;179 19:17:48 INFO - PROCESS | 1687 | |3;audio-fft;77;76;88;100;82;79;82;81;80;79 19:17:48 INFO - PROCESS | 1687 | |4;audio-oscillator;91;93;124;78;78;79;110;77;77;115 19:17:48 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;85;90;83;90;84;89;85;93;83;89 19:17:48 INFO - PROCESS | 1687 | |6;imaging-darkroom;93;94;94;93;95;94;94;92;94;101 19:17:48 INFO - PROCESS | 1687 | |7;imaging-desaturate;85;85;89;129;84;86;87;87;85;85 19:17:48 INFO - PROCESS | 1687 | |8;json-parse-financial;55;54;55;52;55;53;54;64;53;53 19:17:48 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;62;63;71;79;70;66;65;67;67;68 19:17:48 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;83;82;99;105;74;77;97;102;103;101 19:17:48 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;128;129;139;109;131;125;126;121;122;120 19:17:48 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;137;128;138;138;144;159;145;140;134;137 19:17:48 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;65;67;68;66;66;65;77;91;84;67 19:17:48 INFO - PROCESS | 1687 | __end_tp_report 19:17:48 INFO - PROCESS | 1687 | __start_cc_report 19:17:48 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1134 19:17:48 INFO - PROCESS | 1687 | __end_cc_report 19:17:48 INFO - PROCESS | 1687 | __startTimestamp1456283868905__endTimestamp 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | ------- Summary: start ------- 19:17:48 INFO - PROCESS | 1687 | Number of tests: 14 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:121.40 Median:112.00 stddev:21.21 (18.9%) stddev-sans-first:22.09 19:17:48 INFO - PROCESS | 1687 | Values: 110.0 109.0 113.0 160.0 163.0 111.0 115.0 111.0 111.0 111.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:142.50 stddev:15.22 (10.7%) stddev-sans-first:14.55 19:17:48 INFO - PROCESS | 1687 | Values: 156.0 124.0 142.0 155.0 121.0 143.0 140.0 118.0 153.0 120.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:183.80 Median:185.00 stddev:2.25 (1.2%) stddev-sans-first:2.24 19:17:48 INFO - PROCESS | 1687 | Values: 186.0 185.0 186.0 185.0 183.0 184.0 185.0 181.0 184.0 179.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:82.40 Median:80.50 stddev:7.01 (8.7%) stddev-sans-first:7.16 19:17:48 INFO - PROCESS | 1687 | Values: 77.0 76.0 88.0 100.0 82.0 79.0 82.0 81.0 80.0 79.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:78.00 stddev:17.92 (23.0%) stddev-sans-first:19.00 19:17:48 INFO - PROCESS | 1687 | Values: 91.0 93.0 124.0 78.0 78.0 79.0 110.0 77.0 77.0 115.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:89.00 stddev:3.51 (3.9%) stddev-sans-first:3.64 19:17:48 INFO - PROCESS | 1687 | Values: 85.0 90.0 83.0 90.0 84.0 89.0 85.0 93.0 83.0 89.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.00 stddev:2.46 (2.6%) stddev-sans-first:2.55 19:17:48 INFO - PROCESS | 1687 | Values: 93.0 94.0 94.0 93.0 95.0 94.0 94.0 92.0 94.0 101.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:85.50 stddev:13.71 (16.0%) stddev-sans-first:14.41 19:17:48 INFO - PROCESS | 1687 | Values: 85.0 85.0 89.0 129.0 84.0 86.0 87.0 87.0 85.0 85.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.39 (6.2%) stddev-sans-first:3.60 19:17:48 INFO - PROCESS | 1687 | Values: 55.0 54.0 55.0 52.0 55.0 53.0 54.0 64.0 53.0 53.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:4.83 (7.1%) stddev-sans-first:4.64 19:17:48 INFO - PROCESS | 1687 | Values: 62.0 63.0 71.0 79.0 70.0 66.0 65.0 67.0 67.0 68.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:79.50 stddev:11.90 (15.0%) stddev-sans-first:12.13 19:17:48 INFO - PROCESS | 1687 | Values: 83.0 82.0 99.0 105.0 74.0 77.0 97.0 102.0 103.0 101.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:127.00 stddev:7.92 (6.2%) stddev-sans-first:8.32 19:17:48 INFO - PROCESS | 1687 | Values: 128.0 129.0 139.0 109.0 131.0 125.0 126.0 121.0 122.0 120.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:139.00 stddev:8.22 (5.9%) stddev-sans-first:8.65 19:17:48 INFO - PROCESS | 1687 | Values: 137.0 128.0 138.0 138.0 144.0 159.0 145.0 140.0 134.0 137.0 19:17:48 INFO - PROCESS | 1687 | 19:17:48 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:67.50 stddev:9.22 (13.7%) stddev-sans-first:9.46 19:17:48 INFO - PROCESS | 1687 | Values: 65.0 67.0 68.0 66.0 66.0 65.0 77.0 91.0 84.0 67.0 19:17:48 INFO - PROCESS | 1687 | -------- Summary: end -------- 19:17:48 INFO - PROCESS | 1687 | 19:17:49 INFO - TEST-INFO | 1687: exit 0 19:17:49 INFO - TEST-OK | kraken | took 56841ms 19:17:49 INFO - SUITE-END | took 1171s 19:17:50 INFO - Completed test suite (00:19:31) 19:17:50 INFO - Working with test: dromaeo_css 19:17:50 INFO - Generating results file: dromaeo_css 19:17:50 INFO - Working with test: kraken 19:17:50 INFO - Generating results file: kraken 19:17:50 INFO - javascript benchmark 19:17:50 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 19:17:50 INFO - process_Request line: dromaeo_css 7351.33 graph.html#tests=[[72,1,59]] 19:17:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:17:50 INFO - process_Request line: kraken 1440.20 graph.html#tests=[[232,1,59]] 19:17:50 INFO - RETURN: dromaeo_css: 7351.33 19:17:50 INFO - RETURN: kraken: 1440.20 19:17:50 INFO - javascript benchmark 19:17:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3300.8019518828874, 3413.7269018478523, 3470.8438120284586, 3486.2330287336786, 3531.7704349217297, 5540.5290550303225, 5577.414371490996, 5584.413636568158, 5596.608237423382, 5645.040343141665, 5636.971815140919, 5655.095184770437, 5689.886202275952, 5809.302883653967, 5818.272715910512, 5096.668716533413, 5122.8207012754565, 5155.458676838915, 5172.353455818023, 5287.233351164079, 5235.476452354753, 5260.342457192851, 5295.894082118355, 5318.6011049171275, 5350.063738845686, 5077.796888124471, 5129.358830146231, 5202.2456743771945, 5211.947880521222, 5248.134057880426, 5185.299984502081, 5190.766415511273, 5198.090334191501, 5228.2680424740565, 5249.0, 4621.659718681578, 5006.649534532584, 5122.692638441706, 5204.973975130138, 5207.765650545734, 5473.01485732568, 5564.693941833198, 5578.191162281487, 5599.776008959637, 5613.298337707786, 6175.84560385994, 6199.132121502948, 6205.875882482325, 6217.5336849735995, 6218.968905155445, 5208.921866172011, 6104.786332478387, 6242.09489624002, 6255.186825712673, 6258.311585725612, 5715.0855863062125, 5740.885182296414, 5751.25233719618, 5752.741126649311, 5792.275965504312, 5291.285676433709, 6241.594296370812, 6271.592346497463, 6299.433051025429, 6310.7791227306825, 5900.20347253124, 5987.520998320124, 6019.939800601938, 6055.515558755289, 6068.757249709962, 6084.148219249309, 6110.4195101466175, 6157.661328626879, 6240.968795155995, 6252.968735156295, 6113.786017489456, 6124.234470691164, 6133.6319820810895, 6136.6011209271255, 6158.0, 6168.414000669929, 6183.84540386485, 6189.96905015472, 6195.0, 6204.13142160098, 4071.470708807836, 4815.494373090845, 4840.83057093, 4852.417709874767, 4858.902821943541, 4190.078182799779, 4290.163418133434, 4303.053328267776, 4385.627221686129, 4404.053128577371, 5569.415211402826, 5641.830745077572, 5643.5203007743985, 5647.576431767634, 5675.517581005578, 5207.479252074838, 6039.0, 6140.504248697391, 6141.731496609813, 6247.00047992319, 5668.914966275509, 5704.11586204139, 5728.570357223225, 5734.139879018181, 5744.425557444222, 5212.452692467312, 5300.2049692546425, 5300.575953923677, 5306.734663266821, 5312.62811603184, 6235.968820155961, 6238.968805155945, 6281.52888533371, 6294.433500984934, 6301.684915754286, 6245.469135123565, 6259.092431597484, 6278.372162783685, 6296.0, 6304.495640348669, 6188.257409110935, 6203.503719702323, 6294.622322660472, 6302.905456418066, 6321.367863213642, 6146.815595532141, 6150.753969841336, 6151.0, 6169.2288463942, 6170.043643235305, 5998.550108741949, 6245.0632405139595, 6245.6252624842655, 6254.718537665907, 6263.467605253422, 5061.291419201241, 5896.292444906639, 6036.758529658764, 6070.271567411939, 6126.6017708848785, 4909.803607855789, 6007.939920600913, 6052.515798736179, 6053.485453736482, 6084.665343406155, 5817.883642327214, 5930.851728706817, 5940.55445841555, 5942.821715348547, 5943.554233432596, 6022.668753218615, 6066.726997285221, 6090.756369745338, 6104.32852386246, 6141.508679305734, 5914.526837852875, 5935.97541264865, 5951.702414879325, 5955.67243801595, 6015.939840601713], "unit": "score", "name": "dojo.html", "value": 5630.559785229674}, {"lowerIsBetter": false, "replicates": [490.39681192133696, 514.5137844736726, 528.7409169506941, 538.4185080113476, 573.541167066347, 32462.513062304024, 37832.0, 38147.0, 38539.61460385399, 38609.61390386099, 41179.17641647165, 41748.37377439341, 41789.582104178946, 41866.372004419885, 42021.94945126366, 9368.95315523423, 9557.952210238975, 9596.424214547149, 9613.375130616523, 9621.951890240574, 9647.276454265922, 9820.656277030306, 9824.115829575338, 9837.311388202828, 9839.606415743361, 9757.024297570222, 9870.605175792996, 9881.95059024704, 9882.851757223647, 9893.060159284893, 9754.170895473857, 9828.606855725762, 9830.311878168566, 9850.310478266525, 9875.60497580096, 9501.477418741966, 9635.13283804454, 9667.468289244089, 9673.03269673034, 9679.177269931994, 40024.0, 40337.79831100855, 40348.0, 40379.788606341564, 40643.390349144785, 3161.8577164027674, 3166.255929856482, 3304.1244070321145, 3356.9832150839334, 3548.183917698918, 28528.572071418945, 29237.41525169506, 29349.41301173986, 29378.412431751247, 29670.85164574185, 2419.3709635494724, 2779.0, 2819.957700634492, 2830.8584570771586, 2874.3820078683184, 479218.6039069817, 482763.0, 484766.0, 484873.5756321231, 485388.0, 44698.77650611726, 45034.09931801411, 45124.0, 45189.32216016763, 63277.68361158165, 43207.56792432098, 43422.56577434185, 43682.563174368486, 43691.78154109209, 43730.34404483935, 14937.850621493646, 15097.698046039017, 15100.244987750568, 15102.54692359231, 15104.848951510345, 12266.018718502499, 12352.567660131852, 12354.629361119181, 12407.945324647326, 12459.940905023175, 14542.854571454362, 14556.666169376938, 14563.708725825423, 14573.927130364493, 14806.777898331533, 5191.766370513336, 6055.971249631335, 6120.387961203933, 6151.72317245725, 6156.907646385308, 889.5241046040467, 906.3066753933247, 1036.3367444835312, 1124.8031594470935, 1143.48488253065, 29029.56455653167, 29169.0, 29274.707252927623, 29760.851195743882, 29881.402371952438, 970.7039352997404, 1022.2384323678907, 1043.0820877627639, 1056.8678915135608, 1154.4977934598476, 12147.93926030382, 14140.363683634261, 14552.781708274384, 14729.705405892037, 14932.925335373253, 533219.0, 539451.0, 540239.0, 540611.0, 541434.0, 57881.4211857876, 58581.5354616138, 58610.706946465, 58618.0, 58742.11886821701, 1277.4570807406815, 1397.622641886685, 1399.6290982889543, 1413.8868890488736, 1426.621945184527, 27787.888484460396, 27929.72070279271, 27936.86031569829, 28178.0, 28271.858640706665, 44990.77504612456, 44993.0, 45297.09405811931, 45329.77335113303, 45339.31991020071, 302878.0, 305098.0, 305297.0, 305653.0, 306260.0, 32667.673323267412, 32970.0, 33388.83305583456, 33569.83215083909, 33696.83151584226, 44203.11593768171, 44654.3301850479, 45128.77435612801, 45321.54678453305, 45658.77170614259, 35756.82121589375, 36473.81763091274, 37479.0, 37658.62341376551, 37700.0, 36369.0, 36550.0, 36563.791032726425, 36772.63227367799, 37153.0, 34807.4778878312, 35901.281974359845, 36069.63930360663, 36091.0, 36178.0, 29823.850880745456, 32028.839855801503, 32617.695292188997, 32745.34509309848, 32842.17894552655, 22451.775482245623, 22743.88628056849, 24048.0, 25351.0, 25356.239312820646], "unit": "score", "name": "ext.html", "value": 18628.213483928088}, {"lowerIsBetter": false, "replicates": [296.5921857446012, 358.66823188550586, 359.42312588295783, 360.72404610472995, 366.0373218435514, 14601.707965840676, 15231.781457483403, 19369.709454358177, 19895.801041989576, 21447.678284825703, 18848.15183316754, 19006.524836879085, 19391.612167756637, 19457.708134377997, 19794.901025494888, 4970.502949705036, 5659.632123911953, 5837.182794408786, 5880.059190529516, 5881.264841894763, 4185.372194170884, 4381.605655491006, 5898.056310990242, 5993.970030149843, 6190.566660333779, 6358.109864618957, 6381.840453988641, 6384.0, 6385.393387628191, 6392.360763923593, 6050.636961782285, 6257.7184026718905, 6263.718132684017, 6271.529635277327, 6348.9682551587175, 5400.054990376669, 5429.104197807396, 5429.67421954684, 5437.782488700447, 5462.289902312714, 23667.88166059176, 24796.0, 25500.0, 25697.74302256972, 25731.48537029249, 2136.583366243583, 2272.3523795718143, 2433.270018994295, 2554.118829003991, 2898.825975479934, 14185.716285674333, 14419.855801441956, 14648.633784155374, 15200.315985780666, 15345.539633811004, 1767.6641438126715, 1803.7474753534516, 1811.356968276256, 1831.359024341483, 1850.722391641251, 105371.20458374787, 106742.3988640171, 108845.0, 109137.0, 109553.45223273912, 8730.476171429735, 10185.694429167137, 10578.994995475417, 10614.150867930546, 10662.573497060032, 12631.810522842165, 12709.110362274738, 12717.618471445687, 12728.936355318165, 12744.235345879277, 8346.332293416512, 8352.916470835335, 8386.0, 8460.323174146053, 8471.364647651451, 8561.272291855137, 8587.012493563196, 8591.656333746705, 8688.0, 8698.47809131454, 6086.60437071589, 6198.969005155035, 6202.906956395657, 6224.688765561704, 6226.283977342573, 1656.2278362152622, 1718.9828101718822, 1719.2693105430142, 1781.8752687312024, 1787.0350010993918, 399.89402808255835, 407.77776112019023, 905.8731777551149, 942.6229508196776, 988.7231575158967, 10668.413237271869, 11182.776344473064, 11759.0, 11811.291322520676, 11845.940770296265, 426.5201648145836, 429.7292705595517, 438.160921834683, 460.20614440090577, 466.77594754517344, 6015.789447369409, 6103.84740381494, 6228.408301211378, 8405.621747021398, 11542.826857597143, 480514.0, 627345.0, 637026.0, 652571.0, 652774.0, 104635.4768226154, 114532.0, 116639.0, 121849.39075304744, 123061.0, 982.189693502863, 983.5377372634994, 998.14159822554, 1002.173207104142, 1003.2626019875386, 18510.444686659423, 18757.906210469406, 18764.249430022646, 18775.0, 19123.426297211106, 53481.4651853492, 53660.46339536711, 54452.18321725257, 54649.36051918449, 55486.722566388526, 76471.0, 77401.61299193469, 78850.0, 79686.0, 79722.6013869927, 7892.4080693947035, 7928.365730741411, 8171.060328062111, 8189.631466583899, 8198.221168988937, 10696.41169735672, 13125.146865453715, 13404.664883377603, 13584.184948903097, 13662.111962722789, 11556.826647600461, 11746.35395053246, 11817.054635629302, 11850.585229516926, 11860.406979651156, 5187.974060129675, 10341.482925853828, 11026.0, 11279.913016588798, 11357.034652054668, 8145.592720364077, 11820.468078936641, 12022.218555793845, 12063.974562162315, 12077.637670869888, 6745.5952642841585, 7993.280604745601, 8003.799905002189, 8206.384521160817, 8324.916750832657, 10508.42203678805, 10924.268932766809, 11203.551857925917, 11573.074154067486, 11623.709407264885], "unit": "score", "name": "jquery.html", "value": 9046.32195293923}, {"lowerIsBetter": false, "replicates": [1363.420546267836, 1488.56087454201, 1529.6252418157549, 1735.5140560643024, 1893.6970084786428, 7712.0, 8467.788305292363, 8587.871181932276, 8591.785205369868, 8596.785080372994, 8280.254777070062, 8526.53104079277, 8527.275181609555, 8528.061913189544, 8567.314614830813, 2100.5588826346448, 2132.658774596065, 2185.8360622953264, 2185.868847869125, 2448.8285819992607, 2203.7796220377913, 2406.8074554035634, 2464.531738969599, 2466.2477944227003, 2468.160825319391, 2356.8232382571377, 2403.6995375578053, 2417.758224177586, 2419.50400167966, 2421.636754486832, 2376.607859703147, 2408.5303365843665, 2415.5651982643117, 2416.492536567323, 2420.394901274681, 2413.1192114877945, 2414.5895197816412, 2417.8791060446906, 2420.140849998243, 2420.7579242075826, 7462.664180111908, 8682.652693892236, 8723.0, 8746.125387461267, 8772.692955746583, 5286.418493965661, 5409.6213265071465, 5412.539934105605, 5424.186372044225, 5426.565874730012, 3485.093875592339, 3485.5120283160377, 3587.5694916609914, 3595.3168897909577, 3610.4042832932537, 1004.0862814838534, 1004.1765752083295, 1037.7509397744486, 1048.130052056791, 1054.2883553601366, 11651.067914566815, 11692.649220523397, 11692.999999999915, 11693.766124677459, 11720.706982325424, 4727.405708863718, 4767.95232047682, 4797.304390863305, 4830.758462076882, 4837.0, 9898.406095634286, 9914.752131196778, 9920.355176913477, 9945.005499449997, 9986.950065249772, 5339.46605339463, 5354.491323324278, 5359.651622644516, 5364.329458817648, 5387.46125387466, 4375.365571992043, 4505.36924830524, 4645.210314246586, 4897.706137631753, 4901.583365413909, 3865.9613403866165, 3871.5934826842777, 3872.283627528916, 3921.8823435296986, 3928.194720082376, 1244.440001999104, 1258.2764910176686, 1258.8804063613943, 1263.8041103628768, 1282.0576875996135, 1047.9580816767243, 1068.9251752377415, 1068.951897164614, 1210.673118258083, 1353.4924403348743, 7914.960425197837, 8002.1997800219515, 8095.55474448911, 8095.676172953016, 8118.634661440131, 489.45670305960357, 504.8409750928446, 505.5500604462032, 508.9923651145236, 509.66107538487233, 6125.1731016313115, 6160.815175544741, 6170.81487555374, 6173.444390004831, 6194.473469755121, 8895.24390426808, 10298.124659404035, 10350.689479315633, 10484.475776211159, 10509.211809114347, 8792.252658524098, 8795.824083518293, 10062.144717698931, 10261.7434564135, 10333.793324133476, 7834.647440865175, 7961.522308661499, 7974.242446967645, 8030.598470076473, 8039.316658084128, 7862.960685196537, 7923.643436045507, 7987.081485629227, 7988.92011079905, 8031.718889838828, 9218.677346292847, 9385.624575016924, 9631.229501639711, 9645.324827262024, 9651.0, 9588.041195880356, 9901.10890019873, 9902.306838521523, 9902.752431189278, 9913.950430247802, 6782.491313151435, 6931.4108300795, 7227.241139680258, 7411.888821667571, 7554.169041405331, 8067.0722866871065, 8091.312238459797, 8117.431779775359, 8132.1867813218205, 8166.183381661786, 7117.359437650429, 7211.314925082109, 7222.6388680566815, 7348.77953661391, 7359.190489046094, 7018.5788852669, 7091.43268538526, 7143.571385716874, 7207.6756545956605, 7341.3392794648735, 7069.798134317076, 7204.9279507204255, 7521.360684341892, 7632.389408847168, 7638.236176382317, 6856.005879147396, 6953.513254072369, 6956.478264130109, 6960.512764106464, 6961.79114626562, 6885.931140688529, 6989.405900498311, 6997.230304666585, 7002.859942801014, 7012.333828286304], "unit": "score", "name": "mootools.html", "value": 4714.630502189807}, {"lowerIsBetter": false, "replicates": [315.0501238765124, 323.0647276135588, 326.1471252674256, 328.2958054972086, 329.43337459569534, 6528.08606795049, 6543.934560654392, 6557.344265573434, 6587.143671322728, 6587.275399706028, 6621.106150669658, 6625.238097618775, 6627.469802415807, 6630.3038180991025, 6639.568428052174, 4705.0, 4812.711237325754, 4813.278008298766, 4953.950460495403, 4955.529224723646, 4891.730954797485, 4898.24077268024, 4906.852794416173, 4909.656324057318, 4924.926126108094, 4852.9808740164435, 4862.708237505743, 4869.488703686097, 4872.976674898276, 4878.390201224847, 4643.628509719214, 4738.218193997986, 4853.538913803183, 4884.633652476078, 4887.975560122177, 4145.481814773153, 4163.125743593849, 4171.33258678613, 4179.895502612429, 4203.7057405981595, 5116.820911268088, 6232.407921247474, 6341.492680585542, 6344.984802431635, 6371.362863713638, 5767.769289228426, 5768.798092066758, 5777.855553611152, 5778.855528611776, 5783.161441590946, 6998.895016574756, 7004.369606735368, 7008.439324853999, 7010.369066784014, 7013.263607321209, 4318.244307246219, 4485.775711214426, 4486.685931984763, 4487.775611219426, 4489.663275254369, 7247.094113235846, 7350.926490735078, 7379.852402951911, 7386.0767404074495, 7407.925920740831, 3748.3815170496564, 3925.841876646396, 4632.189366860786, 4636.397268355092, 4644.9767751161025, 4673.906521869543, 4677.508861569486, 4681.7190968542, 4682.344471773954, 4701.553352431513, 4637.721736695809, 5612.186232996192, 5622.297212848394, 5622.887542249214, 5627.465390787868, 6200.131981522591, 6838.829029274308, 7066.434685225273, 7097.148342198969, 7119.75080872167, 1608.5335252776797, 1611.5165450364843, 1627.0481768165755, 1631.4779270633283, 1633.9264733087039, 974.9902500975041, 1011.6256984915481, 1031.6750223679517, 1037.0200160847926, 1060.1571750458404, 5396.892062158735, 5549.750261238254, 6689.4982876284475, 6720.495962802809, 6725.562838415487, 7502.6623801929045, 7504.137024242173, 7510.924890751132, 7511.549307041595, 7538.283863033003, 6758.5269031167345, 6764.0, 6767.018782276641, 6772.830679233059, 6779.0, 3255.544223808669, 3778.1688028633657, 3880.3209438348176, 3928.899908025757, 3936.075022369741, 7810.218978102144, 7812.062552493623, 7837.7648670539975, 7840.176781437867, 7861.882071768928, 7685.346745526693, 7687.923120768833, 7693.192214817475, 7696.076470823537, 7703.653335599912, 6379.393957574023, 7792.649330780128, 7795.57124358143, 7802.999999999886, 7817.296443320129, 6928.960655901655, 7194.964025179841, 7438.851222975619, 7450.813729656802, 7451.254874512505, 6580.473562115115, 7321.158066822383, 7321.853562928818, 7333.779986600411, 7338.449616278907, 7825.5304681717, 7826.256505631955, 7828.256315650005, 7830.960845195737, 7832.843343132991, 4595.954040459553, 4650.581447669726, 4662.860114196579, 4664.0, 4687.695299805502, 7039.753608623673, 7292.197858235696, 7405.741473751532, 7432.777016689508, 7433.665485053294, 7040.295970403124, 7080.504364694422, 7108.431325494052, 7125.18060423058, 7129.536580122275, 5900.64596124234, 7104.04095447108, 7118.60847653384, 7128.964355178191, 7142.607261550722, 5711.942880571307, 6988.161420629557, 6997.510174287954, 7010.26392228829, 7014.649267536704, 6876.484263680344, 7148.17795953472, 7149.392301654418, 7161.534500257467, 7223.061002069698, 5201.869953251047, 6727.93272067273, 6910.20532638753, 6913.308669133046, 6972.1981972071835], "unit": "score", "name": "prototype.html", "value": 5135.339198468477}, {"lowerIsBetter": false, "replicates": [668.4218151299126, 728.5883475836156, 729.9087614048242, 745.1579714922141, 792.2908996448175, 15076.47232346868, 15163.014404063728, 15219.391224351026, 15223.847761522382, 15237.923810380946, 13326.333683315845, 13874.514391996283, 13879.583612491617, 13879.861201387983, 13899.0, 708.723597796857, 714.7462650758957, 856.400519636254, 865.6796985115485, 873.6418068591847, 837.9832403351929, 872.084311472954, 872.8472517309477, 875.7504111328273, 878.8989266234369, 739.5377888819488, 750.8385697075128, 911.2937473458056, 917.5091326140516, 917.9856258833993, 734.6033142103231, 882.6028287270753, 909.895362033368, 911.6307895302413, 914.9725508234764, 675.3887731602907, 677.7051982387677, 677.7729460630694, 678.2335960364757, 679.2121139478231, 14827.332770025374, 14861.628459288497, 14897.702045959128, 14907.105573665614, 14919.2540372982, 11225.0, 11978.760424791455, 12335.0, 12612.117151799377, 12638.747225055447, 10008.96932095803, 10052.86246764798, 10084.899151008469, 10097.091261786474, 10105.141063009652, 3525.2068284636007, 3550.786952782841, 3562.69717074049, 3563.1448452371505, 3566.35805555, 70254.0, 71340.0, 78412.60793695995, 80609.0, 83360.16639833584, 9438.528073596293, 9457.007014263403, 9466.621335146654, 9492.240620750323, 9581.281403894736, 16783.664326713642, 20296.0, 20360.796392036187, 20363.185472581226, 20413.877236751825, 6327.905081423783, 7217.711291548279, 7452.403807695371, 7621.466497345244, 7715.1899050600005, 4067.0, 4081.1429599783783, 4094.191211136224, 4124.092699606082, 4161.209370219649, 3504.6144924058844, 3511.9297614047578, 3544.0, 3546.556680414948, 3558.857645694195, 645.9677016149174, 657.273712547628, 661.8610091880663, 664.7507184805697, 670.9597424154566, 512.7205672908274, 574.7557288152518, 581.9738111784895, 632.2792017100509, 642.2197030607834, 8435.072142064368, 8471.618777155043, 8755.0, 9022.052684468168, 9120.8631870522, 553.8753780399459, 609.6281268426256, 613.4387035862226, 619.891518984185, 634.3688030409771, 4007.899802504961, 4030.6170913763144, 4034.8789536313957, 4103.466549348565, 4108.548059713429, 96088.51955740177, 97763.0223697754, 98086.50956745313, 98274.0, 99083.0, 81993.18006819974, 82040.0, 82385.58807205925, 83153.58423207846, 83813.0, 67379.32620673829, 71454.0, 71564.64217678878, 71690.28309716836, 72461.0, 8696.0, 8831.293496520135, 8878.955605221932, 9056.592453339485, 9111.952125505652, 47494.0, 48179.518204817505, 48605.27092093551, 49452.0, 50192.498075020245, 66885.66557167182, 70913.64543177251, 71663.5667286641, 71829.64085179541, 72540.0, 8915.465072095694, 10723.30298530593, 11134.944325278322, 11232.157588181082, 11266.324020558794, 11752.23610465317, 12085.395730213279, 12414.131010829155, 12435.942944849789, 12514.624561263177, 11009.504572294427, 11559.36423496682, 11575.942120289681, 11617.941910290394, 12241.816372754594, 10997.945010274898, 11096.833547496955, 11176.329420234812, 11588.420578970849, 11745.588904388305, 11015.173861960546, 11209.943950280196, 11319.660410187707, 11544.076473881902, 12179.817302740643, 9491.061873241079, 9498.905010949802, 9519.666811661558, 9831.31180817336, 10312.226583006155, 7864.21357864209, 8956.373053886166, 9152.58813353414, 9403.4828084456, 9968.50157492108], "unit": "score", "name": "yui.html", "value": 6869.919181267663}], "name": "dromaeo_css", "value": 7351.3345682745185}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 113.0, 160.0, 163.0, 111.0, 115.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.4}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 142.0, 155.0, 121.0, 143.0, 140.0, 118.0, 153.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 137.2}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 186.0, 185.0, 183.0, 184.0, 185.0, 181.0, 184.0, 179.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 88.0, 100.0, 82.0, 79.0, 82.0, 81.0, 80.0, 79.0], "unit": "score", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 124.0, 78.0, 78.0, 79.0, 110.0, 77.0, 77.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 83.0, 90.0, 84.0, 89.0, 85.0, 93.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 92.0, 94.0, 101.0], "unit": "score", "name": "imaging-darkroom", "value": 94.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 89.0, 129.0, 84.0, 86.0, 87.0, 87.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 90.2}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 55.0, 52.0, 55.0, 53.0, 54.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 71.0, 79.0, 70.0, 66.0, 65.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 99.0, 105.0, 74.0, 77.0, 97.0, 102.0, 103.0, 101.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.3}, {"lowerIsBetter": true, "replicates": [128.0, 129.0, 139.0, 109.0, 131.0, 125.0, 126.0, 121.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [137.0, 128.0, 138.0, 138.0, 144.0, 159.0, 145.0, 140.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 66.0, 66.0, 65.0, 77.0, 91.0, 84.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1440.2}]} 19:17:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1440.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7351.33"}}} 19:17:50 INFO - Return code: 0 19:17:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:17:50 INFO - # TBPL SUCCESS # 19:17:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:17:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:17:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:17:50 INFO - 2016-02-23 19:17:50.606 screenresolution[1691:9621] starting screenresolution argv=screenresolution get 19:17:50 INFO - 2016-02-23 19:17:50.609 screenresolution[1691:9621] Display 0: 1600x1200x32@60 19:17:50 INFO - 2016-02-23 19:17:50.615 screenresolution[1692:9624] starting screenresolution argv=screenresolution list 19:17:50 INFO - Available Modes on Display 0 19:17:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:17:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:17:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:17:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:17:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:17:50 INFO - Intel Iris: 19:17:50 INFO - Chipset Model: Intel Iris 19:17:50 INFO - Type: GPU 19:17:50 INFO - Bus: Built-In 19:17:50 INFO - VRAM (Dynamic, Max): 1536 MB 19:17:50 INFO - Vendor: Intel (0x8086) 19:17:50 INFO - Device ID: 0x0a2e 19:17:50 INFO - Revision ID: 0x0009 19:17:50 INFO - Displays: 19:17:50 INFO - Display: 19:17:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:17:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:17:50 INFO - Display Serial Number: 1600x1200 60 19:17:50 INFO - Main Display: Yes 19:17:50 INFO - Mirror: Off 19:17:50 INFO - Online: Yes 19:17:50 INFO - Rotation: Supported 19:17:50 INFO - Return code: 0 19:17:50 INFO - Running post-action listener: _resource_record_post_action 19:17:50 INFO - Running post-run listener: _resource_record_post_run 19:17:51 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39212544; Write bytes: 706991616; Read time: 422; Write time: 2084 19:17:51 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399579648; Write bytes: 394255872; Read time: 29876; Write time: 715 19:17:51 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37389824; Write bytes: 299079680; Read time: 402; Write time: 1336 19:17:51 INFO - Running post-run listener: _upload_blobber_files 19:17:51 INFO - Blob upload gear active. 19:17:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:17:51 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 19:17:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:17:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:17:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:17:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:53 INFO - (blobuploader) - INFO - Done attempting. 19:17:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:17:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:54 INFO - (blobuploader) - INFO - Done attempting. 19:17:54 INFO - (blobuploader) - INFO - Iteration through files over. 19:17:54 INFO - Return code: 0 19:17:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:17:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:17:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b31b43250905f355a4fc01e8d5baeea3cd2ee370d9ccc9ee95e4d1eabb5fec737dee3b78ad5ec2b54b458f200b3ef574b7cb93bac574789bcf10b91300acfba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67c42dd1a17e1c5e8853280416e0a0ff104d3cb9ee8f8a711c4095c68fea3dfabbede68a9d55e916b9c008d1770179ae480f00d1d803fa7259a6f5c2f19acb70"} 19:17:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:17:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:17:54 INFO - Contents: 19:17:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b31b43250905f355a4fc01e8d5baeea3cd2ee370d9ccc9ee95e4d1eabb5fec737dee3b78ad5ec2b54b458f200b3ef574b7cb93bac574789bcf10b91300acfba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67c42dd1a17e1c5e8853280416e0a0ff104d3cb9ee8f8a711c4095c68fea3dfabbede68a9d55e916b9c008d1770179ae480f00d1d803fa7259a6f5c2f19acb70"} 19:17:54 INFO - Running post-run listener: copy_logs_to_upload_dir 19:17:54 INFO - Copying logs to upload dir... 19:17:54 INFO - mkdir: /builds/slave/test/build/upload/logs 19:17:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.690715 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-23 19:17:54.137886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 19:17:54.141453) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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/Firefox/sha512/b31b43250905f355a4fc01e8d5baeea3cd2ee370d9ccc9ee95e4d1eabb5fec737dee3b78ad5ec2b54b458f200b3ef574b7cb93bac574789bcf10b91300acfba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67c42dd1a17e1c5e8853280416e0a0ff104d3cb9ee8f8a711c4095c68fea3dfabbede68a9d55e916b9c008d1770179ae480f00d1d803fa7259a6f5c2f19acb70"} build_url:https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010774 build_url: 'https://queue.taskcluster.net/v1/task/KWmCMv3xSmmQZJGM9EVrvg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b31b43250905f355a4fc01e8d5baeea3cd2ee370d9ccc9ee95e4d1eabb5fec737dee3b78ad5ec2b54b458f200b3ef574b7cb93bac574789bcf10b91300acfba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67c42dd1a17e1c5e8853280416e0a0ff104d3cb9ee8f8a711c4095c68fea3dfabbede68a9d55e916b9c008d1770179ae480f00d1d803fa7259a6f5c2f19acb70"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 19:17:54.168272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 19:17:54.168619) ========= 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.iyFmrhoGvY/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.nY9v9PacI2/Listeners TMPDIR=/var/folders/fp/3qw0q0_13p72c8h456gldc9c00000w/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.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 19:17:54.223595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 19:17:54.223945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 19:17:54.224837) ========= ========= Total master_lag: 0.86 =========