builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0131 starttime: 1456360483.07 results: success (0) buildid: 20160224153526 builduid: a665cd512df747b3ac8931fa6e05945e revision: f587e62973847f5e8305e5961bce401a4d9fa5ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.067280) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.067880) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.068336) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005577 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.092954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.093308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.110871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.111191) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.005151 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.161046) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.161387) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.161784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.162112) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-24 16:34:43-- 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% 156M=0s 2016-02-24 16:34:43 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.283905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.284280) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.019912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:43.334350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 16:34:43.334918) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f587e62973847f5e8305e5961bce401a4d9fa5ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f587e62973847f5e8305e5961bce401a4d9fa5ba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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-24 16:34:43,409 truncating revision to first 12 chars 2016-02-24 16:34:43,409 Setting DEBUG logging. 2016-02-24 16:34:43,409 attempt 1/10 2016-02-24 16:34:43,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f587e6297384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 16:34:44,877 unpacking tar archive at: fx-team-f587e6297384/testing/mozharness/ program finished with exit code 0 elapsedTime=1.718487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 16:34:45.071672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:45.072169) ========= echo f587e62973847f5e8305e5961bce401a4d9fa5ba in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f587e62973847f5e8305e5961bce401a4d9fa5ba'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 f587e62973847f5e8305e5961bce401a4d9fa5ba program finished with exit code 0 elapsedTime=0.005083 script_repo_revision: 'f587e62973847f5e8305e5961bce401a4d9fa5ba' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:45.122600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:45.122946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 16:34:45.136973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-24 16:34:45.137400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:34:45 INFO - MultiFileLogger online at 20160224 16:34:45 in /builds/slave/test 16:34:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:34:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:34:45 INFO - {'append_to_log': False, 16:34:45 INFO - 'base_work_dir': '/builds/slave/test', 16:34:45 INFO - 'blob_upload_branch': 'Fx-Team', 16:34:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:34:45 INFO - 'branch': 'Fx-Team', 16:34:45 INFO - 'buildbot_json_path': 'buildprops.json', 16:34:45 INFO - 'config_files': ('talos/mac_config.py',), 16:34:45 INFO - 'default_actions': ('clobber', 16:34:45 INFO - 'read-buildbot-config', 16:34:45 INFO - 'download-and-extract', 16:34:45 INFO - 'populate-webroot', 16:34:45 INFO - 'create-virtualenv', 16:34:45 INFO - 'install', 16:34:45 INFO - 'run-tests'), 16:34:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:34:45 INFO - 'download_minidump_stackwalk': True, 16:34:45 INFO - 'download_symbols': 'ondemand', 16:34:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:34:45 INFO - 'tooltool.py': '/tools/tooltool.py', 16:34:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:34:45 INFO - '/tools/misc-python/virtualenv.py')}, 16:34:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:34:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:34:45 INFO - 'installer_path': 'installer.exe', 16:34:45 INFO - 'log_level': 'info', 16:34:45 INFO - 'log_name': 'talos', 16:34:45 INFO - 'log_to_console': True, 16:34:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:34:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:34:45 INFO - 'opt_config_files': (), 16:34:45 INFO - 'pip_index': False, 16:34:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:45 INFO - 'cmd': ('bash', 16:34:45 INFO - '-c', 16:34:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:45 INFO - 'enabled': True, 16:34:45 INFO - 'halt_on_failure': False, 16:34:45 INFO - 'name': 'check_screen_resolution'},), 16:34:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:34:45 INFO - 'cmd': ('bash', 16:34:45 INFO - '-c', 16:34:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:34:45 INFO - 'enabled': True, 16:34:45 INFO - 'halt_on_failure': False, 16:34:45 INFO - 'name': 'check_screen_resolution'},), 16:34:45 INFO - 'run_cmd_checks_enabled': True, 16:34:45 INFO - 'sps_profile': False, 16:34:45 INFO - 'sps_profile_interval': 0, 16:34:45 INFO - 'suite': 'dromaeojs', 16:34:45 INFO - 'system_bits': '32', 16:34:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:34:45 INFO - 'title': 't-yosemite-r7-0131', 16:34:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:34:45 INFO - 'use_talos_json': True, 16:34:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:34:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:34:45 INFO - 'work_dir': 'build'} 16:34:45 INFO - ##### 16:34:45 INFO - ##### Running clobber step. 16:34:45 INFO - ##### 16:34:45 INFO - Running pre-action listener: _resource_record_pre_action 16:34:45 INFO - Running main action method: clobber 16:34:45 INFO - rmtree: /builds/slave/test/build 16:34:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:34:46 INFO - Running post-action listener: _resource_record_post_action 16:34:46 INFO - ##### 16:34:46 INFO - ##### Running read-buildbot-config step. 16:34:46 INFO - ##### 16:34:46 INFO - Running pre-action listener: _resource_record_pre_action 16:34:46 INFO - Running main action method: read_buildbot_config 16:34:46 INFO - Using buildbot properties: 16:34:46 INFO - { 16:34:46 INFO - "project": "", 16:34:46 INFO - "product": "firefox", 16:34:46 INFO - "script_repo_revision": "production", 16:34:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:34:46 INFO - "repository": "", 16:34:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:34:46 INFO - "buildid": "20160224153526", 16:34:46 INFO - "pgo_build": "False", 16:34:46 INFO - "basedir": "/builds/slave/test", 16:34:46 INFO - "buildnumber": 493, 16:34:46 INFO - "slavename": "t-yosemite-r7-0131", 16:34:46 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:34:46 INFO - "platform": "yosemite_r7", 16:34:46 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:34:46 INFO - "branch": "fx-team", 16:34:46 INFO - "repo_path": "integration/fx-team", 16:34:46 INFO - "revision": "f587e62973847f5e8305e5961bce401a4d9fa5ba", 16:34:46 INFO - "stage_platform": "macosx64", 16:34:46 INFO - "builduid": "a665cd512df747b3ac8931fa6e05945e", 16:34:46 INFO - "slavebuilddir": "test" 16:34:46 INFO - } 16:34:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:34:46 INFO - Running post-action listener: _resource_record_post_action 16:34:46 INFO - ##### 16:34:46 INFO - ##### Running download-and-extract step. 16:34:46 INFO - ##### 16:34:46 INFO - Running pre-action listener: _resource_record_pre_action 16:34:46 INFO - Running main action method: download_and_extract 16:34:46 INFO - mkdir: /builds/slave/test/build/tests 16:34:46 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')]} 16:34:46 INFO - https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:34:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/test_packages.json 16:34:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/test_packages.json 16:34:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:34:48 INFO - Downloaded 1277 bytes. 16:34:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:34:48 INFO - Using the following test package requirements: 16:34:48 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:34:48 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:34:48 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:34:48 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'jsshell-mac.zip'], 16:34:48 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:34:48 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:34:48 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:34:48 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:34:48 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:34:48 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:34:48 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:34:48 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:34:48 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:34:48 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')]} 16:34:48 INFO - https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:34:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:34:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:49 INFO - Downloaded 17828714 bytes. 16:34:49 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'] 16:34:49 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 16:34:52 INFO - Return code: 0 16:34:52 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 16:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:52 INFO - https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:34:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:34:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:34:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:53 INFO - Downloaded 17828714 bytes. 16:34:53 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'] 16:34:53 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 16:34:57 INFO - Return code: 0 16:34:57 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')]} 16:34:57 INFO - https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:34:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:34:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:34:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:34:58 INFO - Downloaded 10707015 bytes. 16:34:58 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'] 16:34:58 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 16:34:58 INFO - Return code: 0 16:34: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')]} 16:34:58 INFO - https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:34:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:34:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:34:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QbMQU7wzRW-mksTL56SXhA/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 16:35:01 INFO - Downloaded 111438742 bytes. 16:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:35:01 INFO - mkdir: /builds/slave/test/properties 16:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:01 INFO - Contents: 16:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:35:02 INFO - Running post-action listener: _resource_record_post_action 16:35:02 INFO - Running post-action listener: set_extra_try_arguments 16:35:02 INFO - ##### 16:35:02 INFO - ##### Running populate-webroot step. 16:35:02 INFO - ##### 16:35:02 INFO - Running pre-action listener: _resource_record_pre_action 16:35:02 INFO - Running main action method: populate_webroot 16:35:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:02 INFO - '--tppagecycles', 16:35:02 INFO - '7'], 16:35:02 INFO - 'tests': ['tsvgm']}}, 16:35:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:35:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:35:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'tests': ['damp', 'tps']}, 16:35:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['damp', 'tps']}, 16:35:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:35:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:02 INFO - 'other': {'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'other_l64': {'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'other_nol64': {'tests': ['a11yr', 16:35:02 INFO - 'ts_paint', 16:35:02 INFO - 'tpaint', 16:35:02 INFO - 'sessionrestore', 16:35:02 INFO - 'sessionrestore_no_auto_restore']}, 16:35:02 INFO - 'svgr': {'tests': ['tsvgx', 16:35:02 INFO - 'tsvgr_opacity', 16:35:02 INFO - 'tart', 16:35:02 INFO - 'tscrollx', 16:35:02 INFO - 'cart']}, 16:35:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['tsvgx', 16:35:02 INFO - 'tsvgr_opacity', 16:35:02 INFO - 'tart', 16:35:02 INFO - 'tscrollx', 16:35:02 INFO - 'cart']}, 16:35:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'tests': ['tp5o']}, 16:35:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'talos_options': ['--e10s'], 16:35:02 INFO - 'tests': ['tp5o']}, 16:35:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'talos_options': ['--xperf_path', 16:35:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:02 INFO - 'tests': ['tp5n']}, 16:35:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:35:02 INFO - 'talos_options': ['--e10s', 16:35:02 INFO - '--xperf_path', 16:35:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:02 INFO - 'tests': ['tp5n']}}, 16:35:02 INFO - 'talos.zip': {'path': '', 16:35:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:02 INFO - Running post-action listener: _resource_record_post_action 16:35:02 INFO - ##### 16:35:02 INFO - ##### Running create-virtualenv step. 16:35:02 INFO - ##### 16:35:02 INFO - Running pre-action listener: _resource_record_pre_action 16:35:02 INFO - Running main action method: create_virtualenv 16:35:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:02 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 16:35:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:03 INFO - Using real prefix '/tools/python27' 16:35:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:06 INFO - Installing pip.................done. 16:35:06 INFO - Return code: 0 16:35:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:06 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:06 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 16:35:06 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 16:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:06 INFO - 'HOME': '/Users/cltbld', 16:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:06 INFO - 'LOGNAME': 'cltbld', 16:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:06 INFO - 'MOZ_NO_REMOTE': '1', 16:35:06 INFO - 'NO_EM_RESTART': '1', 16:35:06 INFO - 'PAGER': '/bin/cat', 16:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:06 INFO - 'PWD': '/builds/slave/test', 16:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:06 INFO - 'SHELL': '/bin/bash', 16:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:06 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:06 INFO - 'USER': 'cltbld', 16:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:06 INFO - 'XPC_FLAGS': '0x0', 16:35:06 INFO - 'XPC_SERVICE_NAME': '0', 16:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:06 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 16:35:06 INFO - Cleaning up... 16:35:06 INFO - Return code: 0 16:35:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:06 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:06 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 16:35:06 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 16:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:06 INFO - 'HOME': '/Users/cltbld', 16:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:06 INFO - 'LOGNAME': 'cltbld', 16:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:06 INFO - 'MOZ_NO_REMOTE': '1', 16:35:06 INFO - 'NO_EM_RESTART': '1', 16:35:06 INFO - 'PAGER': '/bin/cat', 16:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:06 INFO - 'PWD': '/builds/slave/test', 16:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:06 INFO - 'SHELL': '/bin/bash', 16:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:06 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:06 INFO - 'USER': 'cltbld', 16:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:06 INFO - 'XPC_FLAGS': '0x0', 16:35:06 INFO - 'XPC_SERVICE_NAME': '0', 16:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:07 INFO - Downloading/unpacking psutil>=0.7.1 16:35:07 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 16:35:07 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 16:35:07 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 16:35:07 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 16:35:07 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 16:35:07 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 16:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:10 INFO - Installing collected packages: psutil 16:35:10 INFO - Running setup.py install for psutil 16:35:10 INFO - building 'psutil._psutil_osx' extension 16:35:10 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 16:35:10 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 16:35:10 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 16:35:10 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 16:35:10 INFO - building 'psutil._psutil_posix' extension 16:35:10 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 16:35:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:10 INFO - ^ 16:35:10 INFO - 1 warning generated. 16:35:10 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 16:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:10 INFO - Successfully installed psutil 16:35:10 INFO - Cleaning up... 16:35:10 INFO - Return code: 0 16:35:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:35:10 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')]} 16:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:10 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')]} 16:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:10 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:10 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 16:35:10 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 16:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:10 INFO - 'HOME': '/Users/cltbld', 16:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:10 INFO - 'LOGNAME': 'cltbld', 16:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:10 INFO - 'MOZ_NO_REMOTE': '1', 16:35:10 INFO - 'NO_EM_RESTART': '1', 16:35:10 INFO - 'PAGER': '/bin/cat', 16:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:10 INFO - 'PWD': '/builds/slave/test', 16:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:10 INFO - 'SHELL': '/bin/bash', 16:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:10 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:10 INFO - 'USER': 'cltbld', 16:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:10 INFO - 'XPC_FLAGS': '0x0', 16:35:10 INFO - 'XPC_SERVICE_NAME': '0', 16:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:35:11 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 16:35:11 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 16:35:11 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 16:35:11 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 16:35:11 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 16:35:11 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 16:35:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:35:13 INFO - Installing collected packages: mozsystemmonitor 16:35:13 INFO - Running setup.py install for mozsystemmonitor 16:35:13 INFO - Successfully installed mozsystemmonitor 16:35:13 INFO - Cleaning up... 16:35:13 INFO - Return code: 0 16:35:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:13 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')]} 16:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:13 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')]} 16:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:13 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:13 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 16:35:13 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 16:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:13 INFO - 'HOME': '/Users/cltbld', 16:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:13 INFO - 'LOGNAME': 'cltbld', 16:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:13 INFO - 'MOZ_NO_REMOTE': '1', 16:35:13 INFO - 'NO_EM_RESTART': '1', 16:35:13 INFO - 'PAGER': '/bin/cat', 16:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:13 INFO - 'PWD': '/builds/slave/test', 16:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:13 INFO - 'SHELL': '/bin/bash', 16:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:13 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:13 INFO - 'USER': 'cltbld', 16:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:13 INFO - 'XPC_FLAGS': '0x0', 16:35:13 INFO - 'XPC_SERVICE_NAME': '0', 16:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:16 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:17 INFO - Downloading docopt-0.6.1.tar.gz 16:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:17 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:17 INFO - Running setup.py install for blobuploader 16:35:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:17 INFO - Running setup.py install for requests 16:35:18 INFO - Running setup.py install for docopt 16:35:18 INFO - Successfully installed blobuploader requests docopt 16:35:18 INFO - Cleaning up... 16:35:18 INFO - Return code: 0 16:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:18 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:18 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 16:35:18 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 16:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:18 INFO - 'HOME': '/Users/cltbld', 16:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:18 INFO - 'LOGNAME': 'cltbld', 16:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:18 INFO - 'MOZ_NO_REMOTE': '1', 16:35:18 INFO - 'NO_EM_RESTART': '1', 16:35:18 INFO - 'PAGER': '/bin/cat', 16:35:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:18 INFO - 'PWD': '/builds/slave/test', 16:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:18 INFO - 'SHELL': '/bin/bash', 16:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:18 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:18 INFO - 'USER': 'cltbld', 16:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:18 INFO - 'XPC_FLAGS': '0x0', 16:35:18 INFO - 'XPC_SERVICE_NAME': '0', 16:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:18 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-R7JAdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-gbuXST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-8AxJka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-LKMua_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-HEGgNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-K3VNxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-_p9h_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Ftlkns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-Amc_vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:19 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-qFASZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-1M9TWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-TZLmDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-ZVZyFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-cfFuRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-dmvVDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-4IO_59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:20 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-dQeRX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:20 INFO - Running setup.py install for manifestparser 16:35:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:20 INFO - Running setup.py install for mozcrash 16:35:21 INFO - Running setup.py install for mozdebug 16:35:21 INFO - Running setup.py install for mozdevice 16:35:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Running setup.py install for mozfile 16:35:21 INFO - Running setup.py install for mozhttpd 16:35:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Running setup.py install for mozinfo 16:35:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Running setup.py install for mozInstall 16:35:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:21 INFO - Running setup.py install for mozleak 16:35:22 INFO - Running setup.py install for mozlog 16:35:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Running setup.py install for moznetwork 16:35:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Running setup.py install for mozprocess 16:35:22 INFO - Running setup.py install for mozprofile 16:35:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Running setup.py install for mozrunner 16:35:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:22 INFO - Running setup.py install for mozscreenshot 16:35:22 INFO - Running setup.py install for moztest 16:35:23 INFO - Running setup.py install for mozversion 16:35:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:23 INFO - Cleaning up... 16:35:23 INFO - Return code: 0 16:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:23 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:23 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 16:35:23 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 16:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:23 INFO - 'HOME': '/Users/cltbld', 16:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:23 INFO - 'LOGNAME': 'cltbld', 16:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:23 INFO - 'MOZ_NO_REMOTE': '1', 16:35:23 INFO - 'NO_EM_RESTART': '1', 16:35:23 INFO - 'PAGER': '/bin/cat', 16:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:23 INFO - 'PWD': '/builds/slave/test', 16:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:23 INFO - 'SHELL': '/bin/bash', 16:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:23 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:23 INFO - 'USER': 'cltbld', 16:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:23 INFO - 'XPC_FLAGS': '0x0', 16:35:23 INFO - 'XPC_SERVICE_NAME': '0', 16:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-L4kB4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:23 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)) 16:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hHufHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:23 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)) 16:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-YOhWTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:23 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)) 16:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:23 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-NKF60K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:23 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)) 16:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-gtLhM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-GlCbFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-O4lruV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-FHAPZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-lZrmPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-vNZCkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-hrt8dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-e_DQVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-yF598t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:24 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)) 16:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:24 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-MXejKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:25 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)) 16:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-H8Lqal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:25 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)) 16:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-eTwoj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:25 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)) 16:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:25 INFO - Running setup.py (path:/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/pip-5nZiPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:25 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)) 16:35:25 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)) 16:35:25 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)) 16:35:25 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)) 16:35:25 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)) 16:35:25 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)) 16:35:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:27 INFO - Downloading blessings-1.6.tar.gz 16:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:35:27 INFO - Installing collected packages: blessings 16:35:27 INFO - Running setup.py install for blessings 16:35:27 INFO - Successfully installed blessings 16:35:27 INFO - Cleaning up... 16:35:28 INFO - Return code: 0 16:35:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:28 INFO - Reading from file tmpfile_stdout 16:35:28 INFO - Current package versions: 16:35:28 INFO - blessings == 1.6 16:35:28 INFO - blobuploader == 1.2.4 16:35:28 INFO - docopt == 0.6.1 16:35:28 INFO - manifestparser == 1.1 16:35:28 INFO - mozInstall == 1.12 16:35:28 INFO - mozcrash == 0.16 16:35:28 INFO - mozdebug == 0.1 16:35:28 INFO - mozdevice == 0.48 16:35:28 INFO - mozfile == 1.2 16:35:28 INFO - mozhttpd == 0.7 16:35:28 INFO - mozinfo == 0.9 16:35:28 INFO - mozleak == 0.1 16:35:28 INFO - mozlog == 3.1 16:35:28 INFO - moznetwork == 0.27 16:35:28 INFO - mozprocess == 0.22 16:35:28 INFO - mozprofile == 0.28 16:35:28 INFO - mozrunner == 6.11 16:35:28 INFO - mozscreenshot == 0.1 16:35:28 INFO - mozsystemmonitor == 0.0 16:35:28 INFO - moztest == 0.7 16:35:28 INFO - mozversion == 1.4 16:35:28 INFO - psutil == 3.1.1 16:35:28 INFO - requests == 1.2.3 16:35:28 INFO - wsgiref == 0.1.2 16:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:28 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')]} 16:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:28 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')]} 16:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:28 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:28 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 16:35:28 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 16:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:28 INFO - 'HOME': '/Users/cltbld', 16:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:28 INFO - 'LOGNAME': 'cltbld', 16:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:28 INFO - 'MOZ_NO_REMOTE': '1', 16:35:28 INFO - 'NO_EM_RESTART': '1', 16:35:28 INFO - 'PAGER': '/bin/cat', 16:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:28 INFO - 'PWD': '/builds/slave/test', 16:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:28 INFO - 'SHELL': '/bin/bash', 16:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:28 INFO - 'USER': 'cltbld', 16:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:28 INFO - 'XPC_FLAGS': '0x0', 16:35:28 INFO - 'XPC_SERVICE_NAME': '0', 16:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 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)) 16:35:28 INFO - Cleaning up... 16:35:28 INFO - Return code: 0 16:35:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:35:28 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')]} 16:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:28 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')]} 16:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:28 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:28 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 16:35:28 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 16:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:28 INFO - 'HOME': '/Users/cltbld', 16:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:28 INFO - 'LOGNAME': 'cltbld', 16:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:28 INFO - 'MOZ_NO_REMOTE': '1', 16:35:28 INFO - 'NO_EM_RESTART': '1', 16:35:28 INFO - 'PAGER': '/bin/cat', 16:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:28 INFO - 'PWD': '/builds/slave/test', 16:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:28 INFO - 'SHELL': '/bin/bash', 16:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:28 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:28 INFO - 'USER': 'cltbld', 16:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:28 INFO - 'XPC_FLAGS': '0x0', 16:35:28 INFO - 'XPC_SERVICE_NAME': '0', 16:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:28 INFO - Downloading/unpacking jsonschema 16:35:28 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 16:35:28 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 16:35:28 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 16:35:28 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 16:35:28 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 16:35:28 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 16:35:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:31 INFO - Downloading/unpacking functools32 (from jsonschema) 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:31 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:31 INFO - warning: no files found matching '*.txt' 16:35:31 INFO - no previously-included directories found matching 'build' 16:35:31 INFO - no previously-included directories found matching 'dist' 16:35:31 INFO - no previously-included directories found matching '.git*' 16:35:31 INFO - Installing collected packages: jsonschema, functools32 16:35:31 INFO - Running setup.py install for functools32 16:35:31 INFO - warning: no files found matching '*.txt' 16:35:31 INFO - no previously-included directories found matching 'build' 16:35:31 INFO - no previously-included directories found matching 'dist' 16:35:31 INFO - no previously-included directories found matching '.git*' 16:35:31 INFO - Successfully installed jsonschema functools32 16:35:31 INFO - Cleaning up... 16:35:32 INFO - Return code: 0 16:35:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:32 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 0x10fae9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6895a1730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, '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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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 16:35:32 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 16:35:32 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 16:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:32 INFO - 'HOME': '/Users/cltbld', 16:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:32 INFO - 'LOGNAME': 'cltbld', 16:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:32 INFO - 'MOZ_NO_REMOTE': '1', 16:35:32 INFO - 'NO_EM_RESTART': '1', 16:35:32 INFO - 'PAGER': '/bin/cat', 16:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:32 INFO - 'PWD': '/builds/slave/test', 16:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:32 INFO - 'SHELL': '/bin/bash', 16:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:35:32 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:32 INFO - 'USER': 'cltbld', 16:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:32 INFO - 'XPC_FLAGS': '0x0', 16:35:32 INFO - 'XPC_SERVICE_NAME': '0', 16:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:32 INFO - Downloading/unpacking flake8 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:35:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:35:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35: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 16:35:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:35 INFO - no previously-included directories found matching 'docs/_build' 16:35:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:35:35 INFO - Running setup.py install for pep8 16:35:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:35:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:35:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:35:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:35:36 INFO - no previously-included directories found matching 'docs/_build' 16:35:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:35:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:35:36 INFO - Cleaning up... 16:35:36 INFO - Return code: 0 16:35:36 INFO - Running post-action listener: _resource_record_post_action 16:35:36 INFO - Running post-action listener: _start_resource_monitoring 16:35:36 INFO - Starting resource monitoring. 16:35:36 INFO - ##### 16:35:36 INFO - ##### Running install step. 16:35:36 INFO - ##### 16:35:36 INFO - Running pre-action listener: _resource_record_pre_action 16:35:36 INFO - Running main action method: install 16:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:35:36 INFO - Reading from file tmpfile_stdout 16:35:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:35:36 INFO - Reading from file tmpfile_stdout 16:35:36 INFO - Output received: 16:35:36 INFO - Usage: mozinstall [options] installer 16:35:36 INFO - Options: 16:35:36 INFO - -h, --help show this help message and exit 16:35:36 INFO - -d DEST, --destination=DEST 16:35:36 INFO - Directory to install application into. [default: 16:35:36 INFO - "/builds/slave/test"] 16:35:36 INFO - --app=APP Application being installed. [default: firefox] 16:35:36 INFO - mkdir: /builds/slave/test/build/application 16:35:36 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'] 16:35:36 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 16:36:10 INFO - Reading from file tmpfile_stdout 16:36:10 INFO - Output received: 16:36:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:36:10 INFO - Running post-action listener: _resource_record_post_action 16:36:10 INFO - ##### 16:36:10 INFO - ##### Running run-tests step. 16:36:10 INFO - ##### 16:36:10 INFO - Running pre-action listener: _resource_record_pre_action 16:36:10 INFO - Running main action method: run_tests 16:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:10 INFO - 2016-02-24 16:36:10.800 screenresolution[1958:14166] starting screenresolution argv=screenresolution get 16:36:10 INFO - 2016-02-24 16:36:10.802 screenresolution[1958:14166] Display 0: 1600x1200x32@60 16:36:10 INFO - 2016-02-24 16:36:10.808 screenresolution[1959:14168] starting screenresolution argv=screenresolution list 16:36:10 INFO - Available Modes on Display 0 16:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:11 INFO - Intel Iris: 16:36:11 INFO - Chipset Model: Intel Iris 16:36:11 INFO - Type: GPU 16:36:11 INFO - Bus: Built-In 16:36:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:11 INFO - Vendor: Intel (0x8086) 16:36:11 INFO - Device ID: 0x0a2e 16:36:11 INFO - Revision ID: 0x0009 16:36:11 INFO - Displays: 16:36:11 INFO - Display: 16:36:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:11 INFO - Display Serial Number: 1600x1200 60 16:36:11 INFO - Main Display: Yes 16:36:11 INFO - Mirror: Off 16:36:11 INFO - Online: Yes 16:36:11 INFO - Rotation: Supported 16:36:11 INFO - Return code: 0 16:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:11 INFO - Python 2.7.3 16:36:11 INFO - Return code: 0 16:36:11 INFO - grabbing minidump binary from tooltool 16:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:11 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 0x10f98dd30>, '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 0x10f7b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f984b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:11 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 16:36:11 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 16:36:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:11 INFO - Return code: 0 16:36:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:36:12 INFO - Return code: 0 16:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 16:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0131 --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 16:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg6kVT4PmO/Render', 16:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:12 INFO - 'HOME': '/Users/cltbld', 16:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:12 INFO - 'LOGNAME': 'cltbld', 16:36:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:12 INFO - 'MOZ_NO_REMOTE': '1', 16:36:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:12 INFO - 'NO_EM_RESTART': '1', 16:36:12 INFO - 'PAGER': '/bin/cat', 16:36:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:12 INFO - 'PWD': '/builds/slave/test', 16:36:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:12 INFO - 'SHELL': '/bin/bash', 16:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HtXvZBVWWd/Listeners', 16:36:12 INFO - 'TMPDIR': '/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/', 16:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:12 INFO - 'USER': 'cltbld', 16:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:12 INFO - 'XPC_FLAGS': '0x0', 16:36:12 INFO - 'XPC_SERVICE_NAME': '0', 16:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0131', '--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 16:36:12 INFO - mozversion application_buildid: 20160224153526 16:36:12 INFO - mozversion application_changeset: f587e62973847f5e8305e5961bce401a4d9fa5ba 16:36:12 INFO - mozversion application_display_name: Nightly 16:36:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:12 INFO - mozversion application_name: Firefox 16:36:12 INFO - mozversion application_remotingname: firefox 16:36:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:36:12 INFO - mozversion application_vendor: Mozilla 16:36:12 INFO - mozversion application_version: 47.0a1 16:36:12 INFO - mozversion platform_buildid: 20160224153526 16:36:12 INFO - mozversion platform_changeset: f587e62973847f5e8305e5961bce401a4d9fa5ba 16:36:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:36:12 INFO - mozversion platform_version: 47.0a1 16:36:12 INFO - using testdate: 1456360572 16:36:12 INFO - actual date: 1456360572 16:36:12 INFO - starting webserver on 'localhost:49765' 16:36:12 INFO - SUITE-START | Running 2 tests 16:36:12 INFO - TEST-START | dromaeo_css 16:36:12 INFO - operating with platform_type : mac_ 16:36:12 INFO - Initialising browser for dromaeo_css test... 16:36:12 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpvBn5cN/profile http://localhost:49765/getInfo.html) 16:36:15 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 16:36:15 INFO - PROCESS | 1977 | colorDepth:24 16:36:15 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 16:36:15 INFO - PROCESS | 1977 | __metrics 16:36:15 INFO - PROCESS | 1977 | 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" 16:36:15 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:36:15 INFO - TEST-INFO | 1977: exit 0 16:36:15 INFO - Browser initialized. 16:36:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:15 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpvBn5cN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:27 INFO - PROCESS | 1980 | RSS: Main: 242782208 16:36:27 INFO - PROCESS | 1980 | 16:37:19 INFO - PROCESS | 1980 | 1456360639075 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] 16:39:29 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49765/tests/dromaeo/cssquery-ext.html) 16:39:30 INFO - PROCESS | 1980 | RSS: Main: 365789184 16:39:30 INFO - PROCESS | 1980 | 16:42:33 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-ext.html (next: http://localhost:49765/tests/dromaeo/cssquery-jquery.html) 16:42:33 INFO - PROCESS | 1980 | RSS: Main: 379461632 16:42:33 INFO - PROCESS | 1980 | 16:45:36 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49765/tests/dromaeo/cssquery-mootools.html) 16:45:36 INFO - PROCESS | 1980 | RSS: Main: 378277888 16:45:36 INFO - PROCESS | 1980 | 16:48:38 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49765/tests/dromaeo/cssquery-prototype.html) 16:48:39 INFO - PROCESS | 1980 | RSS: Main: 333287424 16:48:39 INFO - PROCESS | 1980 | 16:51:42 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49765/tests/dromaeo/cssquery-yui.html) 16:51:43 INFO - PROCESS | 1980 | RSS: Main: 335638528 16:51:43 INFO - PROCESS | 1980 | 16:54:45 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49765/tests/dromaeo/cssquery-yui.html (next: http://localhost:49765/tests/dromaeo/cssquery-dojo.html) 16:54:46 INFO - PROCESS | 1980 | RSS: Main: 394641408 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | __start_tp_report 16:54:46 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 16:54:46 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 16:54:46 INFO - PROCESS | 1980 | |i|pagename|runs| 16:54:46 INFO - PROCESS | 1980 | |0;dojo.html;3400.251944572194;3436.4501679731234;3472.270823127143;3477.1828620274214;3517.577890653122;5476.863078423042;5560;5640.125780504023;5641.943580564193;5663.490285874265;5543.057680194366;5588.776448942038;5598.692071936042;5602.719864006794;5603.943960560393;4391.5827996340295;5085.364329458827;5111.08000559899;5180;5190.195519694435;5159.406668233164;5209.984053109645;5211.635185537014;5211.843644690665;5225.163973764198;5110.591152707793;5139.25480805283;5162.561182299491;5170.172772356424;5177.352830896138;5153.3815942087;5204.713740744258;5227.398849132361;5236.842894713165;5271.314729085233;5049.772760225762;5074.517920797518;5104.2088476286235;5139.229115632647;5166.767495462713;5523.337199536041;5550.72246387683;5562.749676264578;5571.9721401392735;5583.190437386556;5984.700764961734;6104.4200800923845;6111.633302001894;6119.020956646959;6131.785387511416;6060;6139.38606139387;6209.254889413254;6239.469645080174;6256.2492500899725;5713.2572765541045;5727.8568035799435;5753.8561535961935;5769.68266745333;5775.306963164405;6143.72682107623;6333.113364129025;6333.113364129025;6336.619802811846;6341.904871426932;5957.702114894238;6024.144190614116;6026.055402431072;6040.879182416415;6072.271327440735;6119.592622739286;6190.938090619036;6192.938070619326;6195.535334849904;6203.565750397429;5926.318473375531;6049.395060494004;6073.423024812636;6096.969515152396;6118.512537567861;6108;6125.693326622233;6129.264488261437;6129.601575897553;6141.263048434216;4834.540718631724;4838.685485443435;4844.757762111951;4844.806207751721;4849.684770489906;4274.337477690963;4281.443412356373;4334.45819272591;4344.761038142932;4360.4331436913;5621.662700237999;5667.971660141756;5672.716364181774;5679.5172410345585;5683.460071293221;6060.939390606038;6242.625442473375;6247.687615619201;6254.499640028786;6267.561270711007;5618.887622247532;5633.802816901389;5695.686737229492;5700.37295897451;5757.596968212185;5290.047791397508;5292.311999440049;5297.311349524537;5298.655587386807;5305.920411193835;6218.9378106220165;6226.62640241587;6301.684915754194;6316.747330106836;6317.905231421532;5323.387810401853;6237.220347456568;6244.438000579969;6245.594036387621;6247.187865577446;6237.169514019721;6280.968595157177;6307.274663413583;6308.053791931247;6311.274203466476;5903.173555702291;6007.729652165751;6066.1507388966465;6090.330063692902;6135.14108024868;6122.530036739116;6153.2000839890525;6154.107654390178;6181.690915454119;6187.443130118311;5833.387494313206;5937.554683398676;5997.790077347272;6025.337212906489;6054.8183554493435;5847.415258474119;5905.704714764331;5910.261217347832;5925.259342582177;5965.28416590012;5222.686638801684;5586.1062230043;5812.622179558315;5834.649921004753;5840.299164100165;5839.065749480233;5921.970390148022;6013.819585412444;6014.759409623741;6076.392360763888;5724.227229324155;5832.9708351457975;5863.589548731547;5895.322037965689;5897.144913987362 16:54:46 INFO - PROCESS | 1980 | |1;ext.html;428.87562606844017;552.2599716380051;561.7387914619699;584.8479395357206;637.0189907542385;25011;37952.81023594882;38421.423678644845;38457.23085538294;38504.80747596262;40801;41246.7937660312;41267.38098928511;41296.17407651845;41491.58508414915;9510.714678559638;9737.659181928633;9738.367006144577;9745.658901938434;9756.560954757053;9561.665341713042;9696.175825054843;9712.368696034735;9738;9827.262955278382;9773.560189791477;9824.263180261509;9858.211343092535;9859.457729824893;9877.06167914047;9749.171320437736;9830.852537211947;9838.016198380175;9850.507474626276;9864.704058878246;9597.47213903235;9827.557759900821;9840.65557705477;9845.45849978251;9845.704628861145;39763;40132.79933600313;40146.19707605831;40175.59824401777;40214;3119.5008798592344;3167.667394923523;3231.8384080795868;3269;3517.736169787276;28093.578596321073;29200.831966721307;29865;29928.401431971455;29987.550186747216;2695.299222202222;2786.7213278672175;2791.232411086947;2823.209501339608;2829.7453229209264;477607.9999999965;482456;484141;484799;485255;44154.55845441569;44858.55141448609;44897;44910.55089449129;44923.87690307703;43894.463693771206;44270.77864610721;44273.55726442759;44287.11425771531;44297.33553996692;15031.947763656657;15210.543683689508;15213.31540080699;15216.619584510254;15221.238938053053;12148.21036632616;12208.816867746991;12252.509899604094;12391.380430978596;12546.686332841751;12739.490420383081;12786.209930609723;13775.655608609864;14454.927725361516;14516.927415362856;5651.943480565142;6151.96924015377;6209.658468784261;6279.623222606659;6307.148534947723;949.4350861237552;973.9220862330997;979.5200351827554;1102.97974373704;1103.7682086761708;28594.857025714737;28881;29486.852565737463;29624.851875740915;29793.553096703567;941;993.2352088891513;1067.887871773468;1134.5802053240354;1148;12532.122751407314;14057.94565407578;14117.647058823612;14162.150270983773;14542.4910128145;536353;540550;540878;542585;571449.1427542836;52723;52902.20646690303;53393;53521.73239133779;53595.46404535905;1265.411583613624;1379.9862001380059;1399.0276757653332;1401.3623801170443;1430.978535321971;25562.36094097588;28806.85596572004;29595.112146635634;30239;30275;48181;48500.02999940052;48851.755741221066;48865.755671221414;48876.5112348872;357300;357855;358419;359744;360538;32631.347373051933;32774.50838237381;42215;43437.13125737531;44403.77798110989;41841;41903;41928.790356048026;42164.36753448762;43066.78466607772;35552;36180.45729314115;36941.89174324775;37210.883673489836;37223.627763723096;35502;35744.463833042006;36567;36569.45145822762;36670.633293666724;35887.461688074174;36000.639993599725;36536;36772;36984.89045328645;32342.514862276614;33046.83476582602;33424.83287583546;34123.80566680154;34198.48702269418;24009;25226.62160067637;25368.365790855376;25494.362640934127;25935.22194334173 16:54:46 INFO - PROCESS | 1980 | |2;jquery.html;348.1470397526062;355.28410253339507;361.5354269763354;363.1810267846007;371.7472118959108;15730.134842583653;16254.674906501863;19398.612027759453;19561;20291.594168116648;15488.5353439397;19189;19286.228550857984;19314.51713707158;19359.612807743837;5443.755031023604;5716.8284951451315;5981.58128930975;6022.156898034279;6063.878722425548;4175.603317684815;5295.364556253255;5890.352061273256;6017.277926648786;6289.276733175698;6464.870702585946;6479.5788273762055;6480;6480.513961452886;6483.1247781549355;6378.808635740912;6399.26408463028;6460.483161347081;6530.608163510205;6534.640594767286;5595.1886976388605;5619.297587801525;5619.550435965113;5623.268975033219;5624.3813180550105;23895;24484.387890302707;24746;24792.876035619705;24946.875265623738;2217.46780772615;2298.988505057481;2338.5673650374733;2539.682539682521;2782.984210763077;13618.18290902549;14098.50655227062;14293.928530357385;14898.106113633217;15140.470083547134;1710.1278348042463;1772.0519522055638;1782.6612943540686;1788.4724006418137;1799.1813724755336;95944.52027739887;96354;96469.9999999993;97305.51347243218;100725;9977.505623594101;10248.692539223835;10763.784724305626;10821.891781082246;10920.12638988879;12075.57735479254;12355.073369497324;12356.691082722824;12978.740425191632;13106;7012;7545.245475452521;7768.2231776823;8075.071366792777;8142.83714325722;8225.670973161126;8237.588120593946;8289.8342033159;8305.792355191168;8307.584620768937;4238.936415953764;4329.783510824446;4329.870103896888;4361.302191649321;4366.956330436655;1736.965260694779;1838.2371315904018;1854.1934258597553;1859.2191279662575;1887.3960332693407;404.70860980094284;413.95860413958366;450.83995181710674;858.553552152877;1047.0105750066114;10977.506012229469;11418.143639227092;11658.475368608433;11698.532058717727;11747.29516229029;437.7676839696245;444.46442037344923;452.08452882912366;452.53615044579567;460.15102136558;5083.38999320084;5891.675957822361;6006.909896351558;6157.261128664589;6180.134781130645;509584;516109.41945290036;516362;571425;617329;92492;116493.41753291179;118878;120446;121885;978.8923218445965;1011.9089281964658;1013.6198925402974;1024.6208902706046;1065.2223876569992;17361.47520110283;18223.81776182221;18241.45275641733;18361.72457413113;18765.90617046906;33709.15727106842;39550.80224598858;44325;47058;52929.735351323;68778.62442751016;69577.30422695709;70770.93843592453;71112;72974.27025729675;7708.768736937901;7776.766696999099;7890.763277101696;8095.635696393559;8100.797480063045;9822.508874556386;12966.675833104247;13358.93128549733;13363.933180334036;13439.932800335935;11502.309861408343;11645.126615503701;11664.94167529157;11671.35807530594;11713.765724685629;8413.45312554682;11091.833622495507;11138.33170009802;11234.3259404436;11419.942900285445;11594.362310073027;11917.284962902253;11925;11931;11937.761244775229;7809.101953275219;7868.960655196687;8006.519608823489;8059.3552515799765;8173.877391839246;8430.6206220719;11276.492557835081;11806.409679515818;11833.822492662444;11844.407779610812 16:54:46 INFO - PROCESS | 1980 | |3;mootools.html;1413.0885578801667;1503.4362114207172;1558.6103474131467;1782.4741701198154;1925.3068895197734;7361.668724907378;8462.746117616474;8647.827043459127;8657.913420865789;8685.0880657531;8521.744347669564;8720.651173953034;8725.12409831886;8733.737987860375;8754.037055923844;2157.320444060124;2359.127122964497;2426.284246147382;2437.841540299875;2468.2101727447134;2442.511497700467;2448.571499987504;2451.718052423976;2455.6439316299125;2455.9877200613973;2362.11420717231;2435.0990133650484;2441.5594799068544;2441.829071964963;2445.5475736988624;2146.549224662823;2341.812654987597;2388.6297623868327;2389.2951579284154;2393.1623931623967;2390.22317746733;2406.8074554035634;2418.0811291709038;2422.043292899295;2455.6193789962585;8726.171013753683;8852.64589416429;8864.202221800004;8880.644774209024;8886;5317.335333083364;5476.2333273341765;5481.040817856859;5483.561315094783;5485.957668043059;3549.396602577568;3597.0827439003147;3666;3668.9633103669157;3691.53855768029;1037.3879411147384;1043.5617040842865;1046.5499835070916;1059.3326204491198;1075.1076606416655;11600.303981761037;11762.588309409215;11776.646700598996;11791.469383877746;11852.407379630984;4856.757162141878;4885.1206782779445;4930.260460930817;4946.183879659816;4955;10094.091531762177;10106.595736170471;10111.696649100539;10112.191024718006;10115.039071288216;4911.877203069952;5437.592180586472;5447.918281225785;5462.7268636568015;5470.179473078991;4508.729476231437;4512.187806194916;4514.164879497238;4553.134904368159;4784.736839473862;3874.9806250968563;3918.8432462701744;3922.843086276517;3934.350832112669;3971.6822654187595;1162.4594563528;1290.5031562848371;1307.2091384712303;1323.2589749740175;1326.1843965961057;1318.2222488731695;1341.8792308692264;1348.575198812371;1355.037923074628;1360.6734383748028;7985.2014798519685;7997.600119993977;8322.70870519529;8331;8345.874811877828;1103.9448027598748;1133.7449073958294;1206.3787149617954;1206.7888119579038;1221.096388672376;6368.936310636927;6391.744330226832;6436.613803171825;6442.6778661066755;6455.4512866406885;10345.327553708985;10812.35125892449;10814.29707069038;10823.891761082446;10829.83755243672;10511.896250893698;10563.524641391155;10608.522616482276;10667.946660266649;10773.946130269298;8180;8285.088640249567;8333.541655209021;8371.372147088992;8384.580770961427;7764.6894124234395;7814.531128132103;7855.135935047255;7875.881861772193;7906.841863162819;9543.713688589354;9598.9040109598;9658.661946832108;9723.173530249725;9795.461249631338;9874.703758887244;10124.493775311057;10124.84812727795;10161.695149145537;10165.745856353651;6281.277653069956;6472.417482426604;6945.826354341182;6985.5808651481075;7115.786526404217;8221.958890205511;8223;8270.37972152079;8271.255586997198;8283.213094755989;7220.566765994057;7288.12542494904;7334.449916256409;7509.249075092447;7511.436642251743;7029.437644988491;7155.534890232118;7213.1704853942465;7217.566945983258;7238.420926325986;7511.173770885089;7558.941748155373;7616.885746713693;7632.771016869503;7633.770986870402;6854;6882.346177113166;6955.443564514725;6960.9303906962305;6969.16370035599;6963.721451141898;6966.164060312795;7026.718931242693;7032.542884712478;7044.6125463100025 16:54:46 INFO - PROCESS | 1980 | |4;prototype.html;290.22075726673876;316.65642777586316;324.4775910783638;330.48609412363777;336.1763678986484;6361.491080713543;6617.404433600975;6625.2380976187815;6625.271220165778;6635.469162467003;6496.317886621908;6582.374674405935;6591.769288074918;6597.307282735315;6598.538102332838;4601.987562736193;4645.117427688729;4750.76246187691;4849.781759820808;4862.465128835825;4752.12085764133;4769.236922092466;4770.666053376265;4770.785314660849;4784.78468468918;4724.102420540104;4739.668223224376;4739.92890106647;4745.122152401799;4762.690425122356;4530.07133537624;4735.052989402134;4756.7859446325;4808.519148085198;4824.0834241494;4130.318497447917;4147.7926103695;4151.667866570667;4153.314703073989;4153.6677065834665;5097.368841970571;5224.973875130638;6154.384561543855;6253.1245625612455;6279.780207692709;4723.834665786681;4785.784639691222;5664.348599910981;5677.091665333527;5678.205051292823;5701.230333904911;6190.845228869314;6468.159139311906;6884.070650462174;6939.20199177096;3882.165334453078;4476.060027394251;4634.351190833286;4642.814287428532;4660;7110.32451917067;7287.7449289275155;7308.780736577911;7309.963450182769;7313.926860731378;4707.411573553306;4719.95280047202;4757.9286310705365;4762.761861906891;4763.261694437368;4821.083994041121;4821.63837712173;4826.541478559531;4840.080384726961;4859.003904199631;5662.85842853932;5667.631603945731;5676.233708449389;5677.318721753416;5678.3186017678145;6704.932950670528;6973.476989225828;6977;6991.510594258353;7021.543599666005;1664.5672125247522;1674.5980964568416;1677.270387381493;1685.848273655377;1690.0789069956902;982.8918818929913;999.4602914426129;1039.095986491757;1100.290312748273;1128.3906690387264;6215.285242197115;6216.751329946752;6233.438990490878;6345.460635846005;6501.252355979028;7194.568325900463;7202.639868006579;7205.567665940061;7209.783706488814;7217.278272172845;6538.444232240313;6552.705128269239;6556.704948277244;6559;6569.310222426672;3448.3103379324234;3786.3373909565717;3827.0432391902023;3834.616538346143;3838.3858582626644;6492.64290464029;6562.967185164043;6927.792166235021;7291.125064992235;7609.695612175451;7522.736704215436;7531.698732050657;7535.434842386843;7536.24637536242;7545.7358992435;7617.047869016373;7633.809154771064;7639.923600764032;7643.082830060428;7648.388128949559;6996.930030699627;7221.819454513469;7267.636618168965;7285.125784905846;7287.125544934642;7125.394341480825;7140.107486564179;7165.426765858614;7171.282871712787;7185.137783465809;7623.085229772241;7624.351930086005;7630.351420129351;7643.197464266172;7654.578998155155;4795.736234507136;4803.903921921612;4805.423349198119;4805.519448055166;4814.253790662453;6970.686319115551;7227.27727227273;7230.891536626849;7235.746748863765;7248.96375518119;6990.26602206761;7047.577145371294;7053.259407762316;7059.399951004222;7064.434845212473;5833.212516310244;6948.687309071205;6948.722051117898;6948.756793512202;6961.129858767654;6822.283660215606;6839.69221385029;6849.589024658537;6857.931420685729;6858.657067146523;6801.863962720817;6942.548734332252;7018.894716579358;7028.4728645352825;7036.788896333118;6175.536834737323;6241.282252541016;6557.639329836714;6680.899786503303;6725.092112564741 16:54:46 INFO - PROCESS | 1980 | |5;yui.html;688.5902887781771;744.8249661329587;750.2984709296804;762.3634265388399;781.413939545341;14841.257937103142;15172.08967461953;15172.54482365528;15186.848131518667;15205.543833684993;13567.253801040939;13647.317634118279;13711;13731.862681373183;13737.17576945384;704.8308405982579;713.7394850879417;855.8331125430559;871;872.5506364222399;850.8808766772626;858.7295002074358;866.4757821517985;866.774638593967;866.8483015472299;926.754410081329;927.9396839205464;928.2852203803068;928.4475736936512;930.986035209469;743.6281859070465;755.5542230084277;757.4357103957559;903.3044555692146;926.9907300926972;677.806825054862;678.5419841606896;679.1544527063837;682.2870100744734;683.9418649414806;14627.195504247262;14708.117512949257;14718.822494200438;14720;14721.779173312409;12226.388680565937;12342.568010119692;12546.247225166519;12799.040071994545;13052.021098417561;9831.90168098317;10063.69808905734;10187.401801158752;10665;10706.304090234109;3299.7195238404524;3640.5085313482605;3646.8358923848227;3715.3126671565847;3741.120836603396;78293.82559261673;79567.20432795714;80228.59885700593;80306.5984670073;80388.59805700992;8889.422187557788;9054.275657947348;9265.953670231605;9284.7678808029;9385.671501497414;20049.09779059946;20455.8977205113;20484.590308193754;20501.38495845127;20508.282210122576;7280.162781280114;7331.706731730671;7388.519746216586;7527.774166775005;7529.284717951786;3998.620131087542;4041.393790931325;4049.493813273341;4074.8810618478224;4135.29699951003;3519.436890097572;3545.840437180333;3556.0398692353438;3563.501109844624;3571.23218508022;664.942741041746;675.8614484030762;683.7265093962454;691.7233106757237;702.1562671181694;574.2907509226102;594.2007999241014;618.1315252070848;627.4885967936209;632.4055387935326;8662.350323725746;9158.221551168092;9209.63161473547;9294.814103718023;9311.674091406769;540.6999115490862;590.7341696236625;606.4148097086332;617.8795134948642;626.4737620398887;4039.596040395937;4050.4531888195306;4134.793260336971;4221.027246446305;4266.637335826489;87176.564117179;88189;89139.10860891438;89243.55378223068;90150;77088;79559.20440795633;80043.59869203817;80824;80925.59537202277;68015.63968720598;68262.31737682658;68609;69922.99999999898;71794;8502.064772875103;8680.392372534114;8886.155815197546;9042.20892371718;9058.909410905806;48108;49335.75332123316;50175.24737128873;51060.93634381949;51706;62829.68585157045;67815.3218467809;67885.66057169682;68475;68791;10850.348979061282;10863.67408977732;11015.559377624806;11258.66224013281;11378.715532111764;11893.226940249202;12028.518859245532;12084.697882553006;12216.450259738156;12314.199577027464;11366;11509.654710358702;11623.916319739714;11667.6499705009;11718.824217636571;11167.218294719292;11409.657710268706;11492.425378730863;11601.18791684574;11632.302061876315;11241.264196454715;11356.886431135583;11691.415429228675;11692.240004400028;11914.404279785802;9527.57125929321;9586.712398628053;9796.510174491104;9890.554925028247;9901.603935842773;9524.571394287135;9919.553620087258;10053.748656283651;10070.194384449373;10129.493525323851 16:54:46 INFO - PROCESS | 1980 | __end_tp_report 16:54:46 INFO - PROCESS | 1980 | __start_cc_report 16:54:46 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,1169 16:54:46 INFO - PROCESS | 1980 | __end_cc_report 16:54:46 INFO - PROCESS | 1980 | __startTimestamp1456361686102__endTimestamp 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | ------- Summary: start ------- 16:54:46 INFO - PROCESS | 1980 | Number of tests: 6 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#0] dojo.html Cycles:165 Average:5659.93 Median:5834.65 stddev:624.67 (10.7%) stddev-sans-first:600.90 16:54:46 INFO - PROCESS | 1980 | Values: 3400.3 3436.5 3472.3 3477.2 3517.6 5476.9 5560.0 5640.1 5641.9 5663.5 5543.1 5588.8 5598.7 5602.7 5603.9 4391.6 5085.4 5111.1 5180.0 5190.2 5159.4 5210.0 5211.6 5211.8 5225.2 5110.6 5139.3 5162.6 5170.2 5177.4 5153.4 5204.7 5227.4 5236.8 5271.3 5049.8 5074.5 5104.2 5139.2 5166.8 5523.3 5550.7 5562.7 5572.0 5583.2 5984.7 6104.4 6111.6 6119.0 6131.8 6060.0 6139.4 6209.3 6239.5 6256.2 5713.3 5727.9 5753.9 5769.7 5775.3 6143.7 6333.1 6333.1 6336.6 6341.9 5957.7 6024.1 6026.1 6040.9 6072.3 6119.6 6190.9 6192.9 6195.5 6203.6 5926.3 6049.4 6073.4 6097.0 6118.5 6108.0 6125.7 6129.3 6129.6 6141.3 4834.5 4838.7 4844.8 4844.8 4849.7 4274.3 4281.4 4334.5 4344.8 4360.4 5621.7 5668.0 5672.7 5679.5 5683.5 6060.9 6242.6 6247.7 6254.5 6267.6 5618.9 5633.8 5695.7 5700.4 5757.6 5290.0 5292.3 5297.3 5298.7 5305.9 6218.9 6226.6 6301.7 6316.7 6317.9 5323.4 6237.2 6244.4 6245.6 6247.2 6237.2 6281.0 6307.3 6308.1 6311.3 5903.2 6007.7 6066.2 6090.3 6135.1 6122.5 6153.2 6154.1 6181.7 6187.4 5833.4 5937.6 5997.8 6025.3 6054.8 5847.4 5905.7 5910.3 5925.3 5965.3 5222.7 5586.1 5812.6 5834.6 5840.3 5839.1 5922.0 6013.8 6014.8 6076.4 5724.2 5833.0 5863.6 5895.3 5897.1 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#1] ext.html Cycles:180 Average:59795.03 Median:38481.02 stddev:124904.99 (324.6%) stddev-sans-first:125175.85 16:54:46 INFO - PROCESS | 1980 | Values: 428.9 552.3 561.7 584.8 637.0 25011.0 37952.8 38421.4 38457.2 38504.8 40801.0 41246.8 41267.4 41296.2 41491.6 9510.7 9737.7 9738.4 9745.7 9756.6 9561.7 9696.2 9712.4 9738.0 9827.3 9773.6 9824.3 9858.2 9859.5 9877.1 9749.2 9830.9 9838.0 9850.5 9864.7 9597.5 9827.6 9840.7 9845.5 9845.7 39763.0 40132.8 40146.2 40175.6 40214.0 3119.5 3167.7 3231.8 3269.0 3517.7 28093.6 29200.8 29865.0 29928.4 29987.6 2695.3 2786.7 2791.2 2823.2 2829.7 477608.0 482456.0 484141.0 484799.0 485255.0 44154.6 44858.6 44897.0 44910.6 44923.9 43894.5 44270.8 44273.6 44287.1 44297.3 15031.9 15210.5 15213.3 15216.6 15221.2 12148.2 12208.8 12252.5 12391.4 12546.7 12739.5 12786.2 13775.7 14454.9 14516.9 5651.9 6152.0 6209.7 6279.6 6307.1 949.4 973.9 979.5 1103.0 1103.8 28594.9 28881.0 29486.9 29624.9 29793.6 941.0 993.2 1067.9 1134.6 1148.0 12532.1 14057.9 14117.6 14162.2 14542.5 536353.0 540550.0 540878.0 542585.0 571449.1 52723.0 52902.2 53393.0 53521.7 53595.5 1265.4 1380.0 1399.0 1401.4 1431.0 25562.4 28806.9 29595.1 30239.0 30275.0 48181.0 48500.0 48851.8 48865.8 48876.5 357300.0 357855.0 358419.0 359744.0 360538.0 32631.3 32774.5 42215.0 43437.1 44403.8 41841.0 41903.0 41928.8 42164.4 43066.8 35552.0 36180.5 36941.9 37210.9 37223.6 35502.0 35744.5 36567.0 36569.5 36670.6 35887.5 36000.6 36536.0 36772.0 36984.9 32342.5 33046.8 33424.8 34123.8 34198.5 24009.0 25226.6 25368.4 25494.4 25935.2 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#2] jquery.html Cycles:180 Average:31627.33 Median:367.46 stddev:91081.12 (24786.4%) stddev-sans-first:91306.34 16:54:46 INFO - PROCESS | 1980 | Values: 348.1 355.3 361.5 363.2 371.7 15730.1 16254.7 19398.6 19561.0 20291.6 15488.5 19189.0 19286.2 19314.5 19359.6 5443.8 5716.8 5981.6 6022.2 6063.9 4175.6 5295.4 5890.4 6017.3 6289.3 6464.9 6479.6 6480.0 6480.5 6483.1 6378.8 6399.3 6460.5 6530.6 6534.6 5595.2 5619.3 5619.6 5623.3 5624.4 23895.0 24484.4 24746.0 24792.9 24946.9 2217.5 2299.0 2338.6 2539.7 2783.0 13618.2 14098.5 14293.9 14898.1 15140.5 1710.1 1772.1 1782.7 1788.5 1799.2 95944.5 96354.0 96470.0 97305.5 100725.0 9977.5 10248.7 10763.8 10821.9 10920.1 12075.6 12355.1 12356.7 12978.7 13106.0 7012.0 7545.2 7768.2 8075.1 8142.8 8225.7 8237.6 8289.8 8305.8 8307.6 4238.9 4329.8 4329.9 4361.3 4367.0 1737.0 1838.2 1854.2 1859.2 1887.4 404.7 414.0 450.8 858.6 1047.0 10977.5 11418.1 11658.5 11698.5 11747.3 437.8 444.5 452.1 452.5 460.2 5083.4 5891.7 6006.9 6157.3 6180.1 509584.0 516109.4 516362.0 571425.0 617329.0 92492.0 116493.4 118878.0 120446.0 121885.0 978.9 1011.9 1013.6 1024.6 1065.2 17361.5 18223.8 18241.5 18361.7 18765.9 33709.2 39550.8 44325.0 47058.0 52929.7 68778.6 69577.3 70770.9 71112.0 72974.3 7708.8 7776.8 7890.8 8095.6 8100.8 9822.5 12966.7 13358.9 13363.9 13439.9 11502.3 11645.1 11664.9 11671.4 11713.8 8413.5 11091.8 11138.3 11234.3 11419.9 11594.4 11917.3 11925.0 11931.0 11937.8 7809.1 7869.0 8006.5 8059.4 8173.9 8430.6 11276.5 11806.4 11833.8 11844.4 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#3] mootools.html Cycles:180 Average:6029.01 Median:4898.50 stddev:3179.31 (64.9%) stddev-sans-first:3169.29 16:54:46 INFO - PROCESS | 1980 | Values: 1413.1 1503.4 1558.6 1782.5 1925.3 7361.7 8462.7 8647.8 8657.9 8685.1 8521.7 8720.7 8725.1 8733.7 8754.0 2157.3 2359.1 2426.3 2437.8 2468.2 2442.5 2448.6 2451.7 2455.6 2456.0 2362.1 2435.1 2441.6 2441.8 2445.5 2146.5 2341.8 2388.6 2389.3 2393.2 2390.2 2406.8 2418.1 2422.0 2455.6 8726.2 8852.6 8864.2 8880.6 8886.0 5317.3 5476.2 5481.0 5483.6 5486.0 3549.4 3597.1 3666.0 3669.0 3691.5 1037.4 1043.6 1046.5 1059.3 1075.1 11600.3 11762.6 11776.6 11791.5 11852.4 4856.8 4885.1 4930.3 4946.2 4955.0 10094.1 10106.6 10111.7 10112.2 10115.0 4911.9 5437.6 5447.9 5462.7 5470.2 4508.7 4512.2 4514.2 4553.1 4784.7 3875.0 3918.8 3922.8 3934.4 3971.7 1162.5 1290.5 1307.2 1323.3 1326.2 1318.2 1341.9 1348.6 1355.0 1360.7 7985.2 7997.6 8322.7 8331.0 8345.9 1103.9 1133.7 1206.4 1206.8 1221.1 6368.9 6391.7 6436.6 6442.7 6455.5 10345.3 10812.4 10814.3 10823.9 10829.8 10511.9 10563.5 10608.5 10667.9 10773.9 8180.0 8285.1 8333.5 8371.4 8384.6 7764.7 7814.5 7855.1 7875.9 7906.8 9543.7 9598.9 9658.7 9723.2 9795.5 9874.7 10124.5 10124.8 10161.7 10165.7 6281.3 6472.4 6945.8 6985.6 7115.8 8222.0 8223.0 8270.4 8271.3 8283.2 7220.6 7288.1 7334.4 7509.2 7511.4 7029.4 7155.5 7213.2 7217.6 7238.4 7511.2 7558.9 7616.9 7632.8 7633.8 6854.0 6882.3 6955.4 6960.9 6969.2 6963.7 6966.2 7026.7 7032.5 7044.6 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#4] prototype.html Cycles:180 Average:5688.53 Median:6498.79 stddev:1807.78 (27.8%) stddev-sans-first:1766.86 16:54:46 INFO - PROCESS | 1980 | Values: 290.2 316.7 324.5 330.5 336.2 6361.5 6617.4 6625.2 6625.3 6635.5 6496.3 6582.4 6591.8 6597.3 6598.5 4602.0 4645.1 4750.8 4849.8 4862.5 4752.1 4769.2 4770.7 4770.8 4784.8 4724.1 4739.7 4739.9 4745.1 4762.7 4530.1 4735.1 4756.8 4808.5 4824.1 4130.3 4147.8 4151.7 4153.3 4153.7 5097.4 5225.0 6154.4 6253.1 6279.8 4723.8 4785.8 5664.3 5677.1 5678.2 5701.2 6190.8 6468.2 6884.1 6939.2 3882.2 4476.1 4634.4 4642.8 4660.0 7110.3 7287.7 7308.8 7310.0 7313.9 4707.4 4720.0 4757.9 4762.8 4763.3 4821.1 4821.6 4826.5 4840.1 4859.0 5662.9 5667.6 5676.2 5677.3 5678.3 6704.9 6973.5 6977.0 6991.5 7021.5 1664.6 1674.6 1677.3 1685.8 1690.1 982.9 999.5 1039.1 1100.3 1128.4 6215.3 6216.8 6233.4 6345.5 6501.3 7194.6 7202.6 7205.6 7209.8 7217.3 6538.4 6552.7 6556.7 6559.0 6569.3 3448.3 3786.3 3827.0 3834.6 3838.4 6492.6 6563.0 6927.8 7291.1 7609.7 7522.7 7531.7 7535.4 7536.2 7545.7 7617.0 7633.8 7639.9 7643.1 7648.4 6996.9 7221.8 7267.6 7285.1 7287.1 7125.4 7140.1 7165.4 7171.3 7185.1 7623.1 7624.4 7630.4 7643.2 7654.6 4795.7 4803.9 4805.4 4805.5 4814.3 6970.7 7227.3 7230.9 7235.7 7249.0 6990.3 7047.6 7053.3 7059.4 7064.4 5833.2 6948.7 6948.7 6948.8 6961.1 6822.3 6839.7 6849.6 6857.9 6858.7 6801.9 6942.5 7018.9 7028.5 7036.8 6175.5 6241.3 6557.6 6680.9 6725.1 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - PROCESS | 1980 | [#5] yui.html Cycles:180 Average:18213.21 Median:31728.59 stddev:25361.59 (79.9%) stddev-sans-first:25398.60 16:54:46 INFO - PROCESS | 1980 | Values: 688.6 744.8 750.3 762.4 781.4 14841.3 15172.1 15172.5 15186.8 15205.5 13567.3 13647.3 13711.0 13731.9 13737.2 704.8 713.7 855.8 871.0 872.6 850.9 858.7 866.5 866.8 866.8 926.8 927.9 928.3 928.4 931.0 743.6 755.6 757.4 903.3 927.0 677.8 678.5 679.2 682.3 683.9 14627.2 14708.1 14718.8 14720.0 14721.8 12226.4 12342.6 12546.2 12799.0 13052.0 9831.9 10063.7 10187.4 10665.0 10706.3 3299.7 3640.5 3646.8 3715.3 3741.1 78293.8 79567.2 80228.6 80306.6 80388.6 8889.4 9054.3 9266.0 9284.8 9385.7 20049.1 20455.9 20484.6 20501.4 20508.3 7280.2 7331.7 7388.5 7527.8 7529.3 3998.6 4041.4 4049.5 4074.9 4135.3 3519.4 3545.8 3556.0 3563.5 3571.2 664.9 675.9 683.7 691.7 702.2 574.3 594.2 618.1 627.5 632.4 8662.4 9158.2 9209.6 9294.8 9311.7 540.7 590.7 606.4 617.9 626.5 4039.6 4050.5 4134.8 4221.0 4266.6 87176.6 88189.0 89139.1 89243.6 90150.0 77088.0 79559.2 80043.6 80824.0 80925.6 68015.6 68262.3 68609.0 69923.0 71794.0 8502.1 8680.4 8886.2 9042.2 9058.9 48108.0 49335.8 50175.2 51060.9 51706.0 62829.7 67815.3 67885.7 68475.0 68791.0 10850.3 10863.7 11015.6 11258.7 11378.7 11893.2 12028.5 12084.7 12216.5 12314.2 11366.0 11509.7 11623.9 11667.6 11718.8 11167.2 11409.7 11492.4 11601.2 11632.3 11241.3 11356.9 11691.4 11692.2 11914.4 9527.6 9586.7 9796.5 9890.6 9901.6 9524.6 9919.6 10053.7 10070.2 10129.5 16:54:46 INFO - PROCESS | 1980 | -------- Summary: end -------- 16:54:46 INFO - PROCESS | 1980 | 16:54:46 INFO - TEST-INFO | 1980: exit 0 16:54:46 INFO - TEST-OK | dromaeo_css | took 1113685ms 16:54:46 INFO - TEST-START | kraken 16:54:46 INFO - operating with platform_type : mac_ 16:54:46 INFO - Initialising browser for kraken test... 16:54:46 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpbnd29R/profile http://localhost:49765/getInfo.html) 16:54:48 INFO - PROCESS | 1983 | __metrics Screen width/height:1600/1200 16:54:48 INFO - PROCESS | 1983 | colorDepth:24 16:54:48 INFO - PROCESS | 1983 | Browser inner width/height: 1024/689 16:54:48 INFO - PROCESS | 1983 | __metrics 16:54:49 INFO - PROCESS | 1983 | 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" 16:54:49 INFO - PROCESS | 1983 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:54:49 INFO - TEST-INFO | 1983: exit 0 16:54:49 INFO - Browser initialized. 16:54:49 INFO - Running cycle 1/1 for kraken test... 16:54:49 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/T/tmpbnd29R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:01 INFO - PROCESS | 1985 | RSS: Main: 242946048 16:55:01 INFO - PROCESS | 1985 | 16:55:04 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:04 INFO - PROCESS | 1985 | RSS: Main: 290275328 16:55:04 INFO - PROCESS | 1985 | 16:55:07 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-dft) 16:55:08 INFO - PROCESS | 1985 | RSS: Main: 300281856 16:55:08 INFO - PROCESS | 1985 | 16:55:11 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-fft) 16:55:11 INFO - PROCESS | 1985 | RSS: Main: 285495296 16:55:11 INFO - PROCESS | 1985 | 16:55:13 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49765/tests/kraken/driver.html?testName=audio-oscillator) 16:55:14 INFO - PROCESS | 1985 | RSS: Main: 290275328 16:55:14 INFO - PROCESS | 1985 | 16:55:16 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:17 INFO - PROCESS | 1985 | RSS: Main: 290775040 16:55:17 INFO - PROCESS | 1985 | 16:55:20 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:20 INFO - PROCESS | 1985 | RSS: Main: 291819520 16:55:20 INFO - PROCESS | 1985 | 16:55:23 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49765/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:24 INFO - PROCESS | 1985 | RSS: Main: 289947648 16:55:24 INFO - PROCESS | 1985 | 16:55:26 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49765/tests/kraken/driver.html?testName=json-parse-financial) 16:55:27 INFO - PROCESS | 1985 | RSS: Main: 292343808 16:55:27 INFO - PROCESS | 1985 | 16:55:28 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49765/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:29 INFO - PROCESS | 1985 | RSS: Main: 325963776 16:55:29 INFO - PROCESS | 1985 | 16:55:31 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:32 INFO - PROCESS | 1985 | RSS: Main: 324681728 16:55:32 INFO - PROCESS | 1985 | 16:55:34 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:34 INFO - PROCESS | 1985 | RSS: Main: 331890688 16:55:34 INFO - PROCESS | 1985 | 16:55:37 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:38 INFO - PROCESS | 1985 | RSS: Main: 333479936 16:55:38 INFO - PROCESS | 1985 | 16:55:40 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:55:41 INFO - PROCESS | 1985 | RSS: Main: 334053376 16:55:41 INFO - PROCESS | 1985 | 16:55:42 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:49765/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49765/tests/kraken/driver.html?testName=ai-astar) 16:55:43 INFO - PROCESS | 1985 | RSS: Main: 394854400 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | __start_tp_report 16:55:43 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 16:55:43 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 16:55:43 INFO - PROCESS | 1985 | |i|pagename|runs| 16:55:43 INFO - PROCESS | 1985 | |0;ai-astar;111;112;112;111;110;112;116;111;111;112 16:55:43 INFO - PROCESS | 1985 | |1;audio-beat-detection;159;125;142;161;119;141;140;119;162;119 16:55:43 INFO - PROCESS | 1985 | |2;audio-dft;186;183;185;187;189;186;186;187;184;183 16:55:43 INFO - PROCESS | 1985 | |3;audio-fft;77;74;76;119;73;76;77;58;111;55 16:55:43 INFO - PROCESS | 1985 | |4;audio-oscillator;90;94;125;79;79;84;113;77;79;117 16:55:43 INFO - PROCESS | 1985 | |5;imaging-gaussian-blur;86;92;85;93;90;114;115;123;88;93 16:55:43 INFO - PROCESS | 1985 | |6;imaging-darkroom;95;98;95;95;95;97;96;96;95;106 16:55:43 INFO - PROCESS | 1985 | |7;imaging-desaturate;87;85;84;87;87;85;87;84;85;85 16:55:43 INFO - PROCESS | 1985 | |8;json-parse-financial;55;54;54;52;54;54;55;64;52;52 16:55:43 INFO - PROCESS | 1985 | |9;json-stringify-tinderbox;64;62;70;75;72;68;67;65;67;67 16:55:43 INFO - PROCESS | 1985 | |10;stanford-crypto-aes;84;82;83;82;81;97;98;98;98;83 16:55:43 INFO - PROCESS | 1985 | |11;stanford-crypto-ccm;133;134;128;109;122;125;142;108;135;107 16:55:43 INFO - PROCESS | 1985 | |12;stanford-crypto-pbkdf2;139;127;136;137;139;125;137;137;137;137 16:55:43 INFO - PROCESS | 1985 | |13;stanford-crypto-sha256-iterative;67;67;66;79;87;94;90;90;67;65 16:55:43 INFO - PROCESS | 1985 | __end_tp_report 16:55:43 INFO - PROCESS | 1985 | __start_cc_report 16:55:43 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,1215 16:55:43 INFO - PROCESS | 1985 | __end_cc_report 16:55:43 INFO - PROCESS | 1985 | __startTimestamp1456361743129__endTimestamp 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | ------- Summary: start ------- 16:55:43 INFO - PROCESS | 1985 | Number of tests: 14 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.62 (1.4%) stddev-sans-first:1.69 16:55:43 INFO - PROCESS | 1985 | Values: 111.0 112.0 112.0 111.0 110.0 112.0 116.0 111.0 111.0 112.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:141.50 stddev:17.71 (12.5%) stddev-sans-first:17.19 16:55:43 INFO - PROCESS | 1985 | Values: 159.0 125.0 142.0 161.0 119.0 141.0 140.0 119.0 162.0 119.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:1.90 (1.0%) stddev-sans-first:2.01 16:55:43 INFO - PROCESS | 1985 | Values: 186.0 183.0 185.0 187.0 189.0 186.0 186.0 187.0 184.0 183.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#3] audio-fft Cycles:10 Average:79.60 Median:75.00 stddev:20.34 (27.1%) stddev-sans-first:21.55 16:55:43 INFO - PROCESS | 1985 | Values: 77.0 74.0 76.0 119.0 73.0 76.0 77.0 58.0 111.0 55.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:79.00 stddev:18.04 (22.8%) stddev-sans-first:19.09 16:55:43 INFO - PROCESS | 1985 | Values: 90.0 94.0 125.0 79.0 79.0 84.0 113.0 77.0 79.0 117.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:89.00 stddev:13.88 (15.6%) stddev-sans-first:14.03 16:55:43 INFO - PROCESS | 1985 | Values: 86.0 92.0 85.0 93.0 90.0 114.0 115.0 123.0 88.0 93.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:95.50 stddev:3.39 (3.6%) stddev-sans-first:3.54 16:55:43 INFO - PROCESS | 1985 | Values: 95.0 98.0 95.0 95.0 95.0 97.0 96.0 96.0 95.0 106.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.24 16:55:43 INFO - PROCESS | 1985 | Values: 87.0 85.0 84.0 87.0 87.0 85.0 87.0 84.0 85.0 85.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.50 (6.5%) stddev-sans-first:3.71 16:55:43 INFO - PROCESS | 1985 | Values: 55.0 54.0 54.0 52.0 54.0 54.0 55.0 64.0 52.0 52.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.50 stddev:3.83 (5.7%) stddev-sans-first:3.82 16:55:43 INFO - PROCESS | 1985 | Values: 64.0 62.0 70.0 75.0 72.0 68.0 67.0 65.0 67.0 67.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:90.50 stddev:7.92 (8.8%) stddev-sans-first:8.22 16:55:43 INFO - PROCESS | 1985 | Values: 84.0 82.0 83.0 82.0 81.0 97.0 98.0 98.0 98.0 83.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:130.50 stddev:12.54 (9.6%) stddev-sans-first:12.90 16:55:43 INFO - PROCESS | 1985 | Values: 133.0 134.0 128.0 109.0 122.0 125.0 142.0 108.0 135.0 107.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:137.00 stddev:4.91 (3.6%) stddev-sans-first:5.00 16:55:43 INFO - PROCESS | 1985 | Values: 139.0 127.0 136.0 137.0 139.0 125.0 137.0 137.0 137.0 137.0 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - PROCESS | 1985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:83.00 stddev:12.00 (14.5%) stddev-sans-first:12.14 16:55:43 INFO - PROCESS | 1985 | Values: 67.0 67.0 66.0 79.0 87.0 94.0 90.0 90.0 67.0 65.0 16:55:43 INFO - PROCESS | 1985 | -------- Summary: end -------- 16:55:43 INFO - PROCESS | 1985 | 16:55:43 INFO - TEST-INFO | 1985: exit 0 16:55:43 INFO - TEST-OK | kraken | took 57252ms 16:55:43 INFO - SUITE-END | took 1170s 16:55:44 INFO - Completed test suite (00:19:31) 16:55:44 INFO - Working with test: dromaeo_css 16:55:44 INFO - Generating results file: dromaeo_css 16:55:44 INFO - Working with test: kraken 16:55:44 INFO - Generating results file: kraken 16:55:44 INFO - javascript benchmark 16:55:44 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 16:55:44 INFO - process_Request line: dromaeo_css 7364.90 graph.html#tests=[[72,64,59]] 16:55:44 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:55:44 INFO - process_Request line: kraken 1437.20 graph.html#tests=[[232,64,59]] 16:55:44 INFO - RETURN: dromaeo_css: 7364.90 16:55:44 INFO - RETURN: kraken: 1437.20 16:55:44 INFO - javascript benchmark 16:55:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3400.251944572194, 3436.4501679731234, 3472.270823127143, 3477.1828620274214, 3517.577890653122, 5476.863078423042, 5560.0, 5640.125780504023, 5641.943580564193, 5663.490285874265, 5543.057680194366, 5588.776448942038, 5598.692071936042, 5602.719864006794, 5603.943960560393, 4391.5827996340295, 5085.364329458827, 5111.08000559899, 5180.0, 5190.195519694435, 5159.406668233164, 5209.984053109645, 5211.635185537014, 5211.843644690665, 5225.163973764198, 5110.591152707793, 5139.25480805283, 5162.561182299491, 5170.172772356424, 5177.352830896138, 5153.3815942087, 5204.713740744258, 5227.398849132361, 5236.842894713165, 5271.314729085233, 5049.772760225762, 5074.517920797518, 5104.2088476286235, 5139.229115632647, 5166.767495462713, 5523.337199536041, 5550.72246387683, 5562.749676264578, 5571.9721401392735, 5583.190437386556, 5984.700764961734, 6104.4200800923845, 6111.633302001894, 6119.020956646959, 6131.785387511416, 6060.0, 6139.38606139387, 6209.254889413254, 6239.469645080174, 6256.2492500899725, 5713.2572765541045, 5727.8568035799435, 5753.8561535961935, 5769.68266745333, 5775.306963164405, 6143.72682107623, 6333.113364129025, 6333.113364129025, 6336.619802811846, 6341.904871426932, 5957.702114894238, 6024.144190614116, 6026.055402431072, 6040.879182416415, 6072.271327440735, 6119.592622739286, 6190.938090619036, 6192.938070619326, 6195.535334849904, 6203.565750397429, 5926.318473375531, 6049.395060494004, 6073.423024812636, 6096.969515152396, 6118.512537567861, 6108.0, 6125.693326622233, 6129.264488261437, 6129.601575897553, 6141.263048434216, 4834.540718631724, 4838.685485443435, 4844.757762111951, 4844.806207751721, 4849.684770489906, 4274.337477690963, 4281.443412356373, 4334.45819272591, 4344.761038142932, 4360.4331436913, 5621.662700237999, 5667.971660141756, 5672.716364181774, 5679.5172410345585, 5683.460071293221, 6060.939390606038, 6242.625442473375, 6247.687615619201, 6254.499640028786, 6267.561270711007, 5618.887622247532, 5633.802816901389, 5695.686737229492, 5700.37295897451, 5757.596968212185, 5290.047791397508, 5292.311999440049, 5297.311349524537, 5298.655587386807, 5305.920411193835, 6218.9378106220165, 6226.62640241587, 6301.684915754194, 6316.747330106836, 6317.905231421532, 5323.387810401853, 6237.220347456568, 6244.438000579969, 6245.594036387621, 6247.187865577446, 6237.169514019721, 6280.968595157177, 6307.274663413583, 6308.053791931247, 6311.274203466476, 5903.173555702291, 6007.729652165751, 6066.1507388966465, 6090.330063692902, 6135.14108024868, 6122.530036739116, 6153.2000839890525, 6154.107654390178, 6181.690915454119, 6187.443130118311, 5833.387494313206, 5937.554683398676, 5997.790077347272, 6025.337212906489, 6054.8183554493435, 5847.415258474119, 5905.704714764331, 5910.261217347832, 5925.259342582177, 5965.28416590012, 5222.686638801684, 5586.1062230043, 5812.622179558315, 5834.649921004753, 5840.299164100165, 5839.065749480233, 5921.970390148022, 6013.819585412444, 6014.759409623741, 6076.392360763888, 5724.227229324155, 5832.9708351457975, 5863.589548731547, 5895.322037965689, 5897.144913987362], "unit": "score", "name": "dojo.html", "value": 5621.105484343271}, {"lowerIsBetter": false, "replicates": [428.87562606844017, 552.2599716380051, 561.7387914619699, 584.8479395357206, 637.0189907542385, 25011.0, 37952.81023594882, 38421.423678644845, 38457.23085538294, 38504.80747596262, 40801.0, 41246.7937660312, 41267.38098928511, 41296.17407651845, 41491.58508414915, 9510.714678559638, 9737.659181928633, 9738.367006144577, 9745.658901938434, 9756.560954757053, 9561.665341713042, 9696.175825054843, 9712.368696034735, 9738.0, 9827.262955278382, 9773.560189791477, 9824.263180261509, 9858.211343092535, 9859.457729824893, 9877.06167914047, 9749.171320437736, 9830.852537211947, 9838.016198380175, 9850.507474626276, 9864.704058878246, 9597.47213903235, 9827.557759900821, 9840.65557705477, 9845.45849978251, 9845.704628861145, 39763.0, 40132.79933600313, 40146.19707605831, 40175.59824401777, 40214.0, 3119.5008798592344, 3167.667394923523, 3231.8384080795868, 3269.0, 3517.736169787276, 28093.578596321073, 29200.831966721307, 29865.0, 29928.401431971455, 29987.550186747216, 2695.299222202222, 2786.7213278672175, 2791.232411086947, 2823.209501339608, 2829.7453229209264, 477607.9999999965, 482456.0, 484141.0, 484799.0, 485255.0, 44154.55845441569, 44858.55141448609, 44897.0, 44910.55089449129, 44923.87690307703, 43894.463693771206, 44270.77864610721, 44273.55726442759, 44287.11425771531, 44297.33553996692, 15031.947763656657, 15210.543683689508, 15213.31540080699, 15216.619584510254, 15221.238938053053, 12148.21036632616, 12208.816867746991, 12252.509899604094, 12391.380430978596, 12546.686332841751, 12739.490420383081, 12786.209930609723, 13775.655608609864, 14454.927725361516, 14516.927415362856, 5651.943480565142, 6151.96924015377, 6209.658468784261, 6279.623222606659, 6307.148534947723, 949.4350861237552, 973.9220862330997, 979.5200351827554, 1102.97974373704, 1103.7682086761708, 28594.857025714737, 28881.0, 29486.852565737463, 29624.851875740915, 29793.553096703567, 941.0, 993.2352088891513, 1067.887871773468, 1134.5802053240354, 1148.0, 12532.122751407314, 14057.94565407578, 14117.647058823612, 14162.150270983773, 14542.4910128145, 536353.0, 540550.0, 540878.0, 542585.0, 571449.1427542836, 52723.0, 52902.20646690303, 53393.0, 53521.73239133779, 53595.46404535905, 1265.411583613624, 1379.9862001380059, 1399.0276757653332, 1401.3623801170443, 1430.978535321971, 25562.36094097588, 28806.85596572004, 29595.112146635634, 30239.0, 30275.0, 48181.0, 48500.02999940052, 48851.755741221066, 48865.755671221414, 48876.5112348872, 357300.0, 357855.0, 358419.0, 359744.0, 360538.0, 32631.347373051933, 32774.50838237381, 42215.0, 43437.13125737531, 44403.77798110989, 41841.0, 41903.0, 41928.790356048026, 42164.36753448762, 43066.78466607772, 35552.0, 36180.45729314115, 36941.89174324775, 37210.883673489836, 37223.627763723096, 35502.0, 35744.463833042006, 36567.0, 36569.45145822762, 36670.633293666724, 35887.461688074174, 36000.639993599725, 36536.0, 36772.0, 36984.89045328645, 32342.514862276614, 33046.83476582602, 33424.83287583546, 34123.80566680154, 34198.48702269418, 24009.0, 25226.62160067637, 25368.365790855376, 25494.362640934127, 25935.22194334173], "unit": "score", "name": "ext.html", "value": 18763.886312522598}, {"lowerIsBetter": false, "replicates": [348.1470397526062, 355.28410253339507, 361.5354269763354, 363.1810267846007, 371.7472118959108, 15730.134842583653, 16254.674906501863, 19398.612027759453, 19561.0, 20291.594168116648, 15488.5353439397, 19189.0, 19286.228550857984, 19314.51713707158, 19359.612807743837, 5443.755031023604, 5716.8284951451315, 5981.58128930975, 6022.156898034279, 6063.878722425548, 4175.603317684815, 5295.364556253255, 5890.352061273256, 6017.277926648786, 6289.276733175698, 6464.870702585946, 6479.5788273762055, 6480.0, 6480.513961452886, 6483.1247781549355, 6378.808635740912, 6399.26408463028, 6460.483161347081, 6530.608163510205, 6534.640594767286, 5595.1886976388605, 5619.297587801525, 5619.550435965113, 5623.268975033219, 5624.3813180550105, 23895.0, 24484.387890302707, 24746.0, 24792.876035619705, 24946.875265623738, 2217.46780772615, 2298.988505057481, 2338.5673650374733, 2539.682539682521, 2782.984210763077, 13618.18290902549, 14098.50655227062, 14293.928530357385, 14898.106113633217, 15140.470083547134, 1710.1278348042463, 1772.0519522055638, 1782.6612943540686, 1788.4724006418137, 1799.1813724755336, 95944.52027739887, 96354.0, 96469.9999999993, 97305.51347243218, 100725.0, 9977.505623594101, 10248.692539223835, 10763.784724305626, 10821.891781082246, 10920.12638988879, 12075.57735479254, 12355.073369497324, 12356.691082722824, 12978.740425191632, 13106.0, 7012.0, 7545.245475452521, 7768.2231776823, 8075.071366792777, 8142.83714325722, 8225.670973161126, 8237.588120593946, 8289.8342033159, 8305.792355191168, 8307.584620768937, 4238.936415953764, 4329.783510824446, 4329.870103896888, 4361.302191649321, 4366.956330436655, 1736.965260694779, 1838.2371315904018, 1854.1934258597553, 1859.2191279662575, 1887.3960332693407, 404.70860980094284, 413.95860413958366, 450.83995181710674, 858.553552152877, 1047.0105750066114, 10977.506012229469, 11418.143639227092, 11658.475368608433, 11698.532058717727, 11747.29516229029, 437.7676839696245, 444.46442037344923, 452.08452882912366, 452.53615044579567, 460.15102136558, 5083.38999320084, 5891.675957822361, 6006.909896351558, 6157.261128664589, 6180.134781130645, 509584.0, 516109.41945290036, 516362.0, 571425.0, 617329.0, 92492.0, 116493.41753291179, 118878.0, 120446.0, 121885.0, 978.8923218445965, 1011.9089281964658, 1013.6198925402974, 1024.6208902706046, 1065.2223876569992, 17361.47520110283, 18223.81776182221, 18241.45275641733, 18361.72457413113, 18765.90617046906, 33709.15727106842, 39550.80224598858, 44325.0, 47058.0, 52929.735351323, 68778.62442751016, 69577.30422695709, 70770.93843592453, 71112.0, 72974.27025729675, 7708.768736937901, 7776.766696999099, 7890.763277101696, 8095.635696393559, 8100.797480063045, 9822.508874556386, 12966.675833104247, 13358.93128549733, 13363.933180334036, 13439.932800335935, 11502.309861408343, 11645.126615503701, 11664.94167529157, 11671.35807530594, 11713.765724685629, 8413.45312554682, 11091.833622495507, 11138.33170009802, 11234.3259404436, 11419.942900285445, 11594.362310073027, 11917.284962902253, 11925.0, 11931.0, 11937.761244775229, 7809.101953275219, 7868.960655196687, 8006.519608823489, 8059.3552515799765, 8173.877391839246, 8430.6206220719, 11276.492557835081, 11806.409679515818, 11833.822492662444, 11844.407779610812], "unit": "score", "name": "jquery.html", "value": 8751.230751942861}, {"lowerIsBetter": false, "replicates": [1413.0885578801667, 1503.4362114207172, 1558.6103474131467, 1782.4741701198154, 1925.3068895197734, 7361.668724907378, 8462.746117616474, 8647.827043459127, 8657.913420865789, 8685.0880657531, 8521.744347669564, 8720.651173953034, 8725.12409831886, 8733.737987860375, 8754.037055923844, 2157.320444060124, 2359.127122964497, 2426.284246147382, 2437.841540299875, 2468.2101727447134, 2442.511497700467, 2448.571499987504, 2451.718052423976, 2455.6439316299125, 2455.9877200613973, 2362.11420717231, 2435.0990133650484, 2441.5594799068544, 2441.829071964963, 2445.5475736988624, 2146.549224662823, 2341.812654987597, 2388.6297623868327, 2389.2951579284154, 2393.1623931623967, 2390.22317746733, 2406.8074554035634, 2418.0811291709038, 2422.043292899295, 2455.6193789962585, 8726.171013753683, 8852.64589416429, 8864.202221800004, 8880.644774209024, 8886.0, 5317.335333083364, 5476.2333273341765, 5481.040817856859, 5483.561315094783, 5485.957668043059, 3549.396602577568, 3597.0827439003147, 3666.0, 3668.9633103669157, 3691.53855768029, 1037.3879411147384, 1043.5617040842865, 1046.5499835070916, 1059.3326204491198, 1075.1076606416655, 11600.303981761037, 11762.588309409215, 11776.646700598996, 11791.469383877746, 11852.407379630984, 4856.757162141878, 4885.1206782779445, 4930.260460930817, 4946.183879659816, 4955.0, 10094.091531762177, 10106.595736170471, 10111.696649100539, 10112.191024718006, 10115.039071288216, 4911.877203069952, 5437.592180586472, 5447.918281225785, 5462.7268636568015, 5470.179473078991, 4508.729476231437, 4512.187806194916, 4514.164879497238, 4553.134904368159, 4784.736839473862, 3874.9806250968563, 3918.8432462701744, 3922.843086276517, 3934.350832112669, 3971.6822654187595, 1162.4594563528, 1290.5031562848371, 1307.2091384712303, 1323.2589749740175, 1326.1843965961057, 1318.2222488731695, 1341.8792308692264, 1348.575198812371, 1355.037923074628, 1360.6734383748028, 7985.2014798519685, 7997.600119993977, 8322.70870519529, 8331.0, 8345.874811877828, 1103.9448027598748, 1133.7449073958294, 1206.3787149617954, 1206.7888119579038, 1221.096388672376, 6368.936310636927, 6391.744330226832, 6436.613803171825, 6442.6778661066755, 6455.4512866406885, 10345.327553708985, 10812.35125892449, 10814.29707069038, 10823.891761082446, 10829.83755243672, 10511.896250893698, 10563.524641391155, 10608.522616482276, 10667.946660266649, 10773.946130269298, 8180.0, 8285.088640249567, 8333.541655209021, 8371.372147088992, 8384.580770961427, 7764.6894124234395, 7814.531128132103, 7855.135935047255, 7875.881861772193, 7906.841863162819, 9543.713688589354, 9598.9040109598, 9658.661946832108, 9723.173530249725, 9795.461249631338, 9874.703758887244, 10124.493775311057, 10124.84812727795, 10161.695149145537, 10165.745856353651, 6281.277653069956, 6472.417482426604, 6945.826354341182, 6985.5808651481075, 7115.786526404217, 8221.958890205511, 8223.0, 8270.37972152079, 8271.255586997198, 8283.213094755989, 7220.566765994057, 7288.12542494904, 7334.449916256409, 7509.249075092447, 7511.436642251743, 7029.437644988491, 7155.534890232118, 7213.1704853942465, 7217.566945983258, 7238.420926325986, 7511.173770885089, 7558.941748155373, 7616.885746713693, 7632.771016869503, 7633.770986870402, 6854.0, 6882.346177113166, 6955.443564514725, 6960.9303906962305, 6969.16370035599, 6963.721451141898, 6966.164060312795, 7026.718931242693, 7032.542884712478, 7044.6125463100025], "unit": "score", "name": "mootools.html", "value": 4921.020337192533}, {"lowerIsBetter": false, "replicates": [290.22075726673876, 316.65642777586316, 324.4775910783638, 330.48609412363777, 336.1763678986484, 6361.491080713543, 6617.404433600975, 6625.2380976187815, 6625.271220165778, 6635.469162467003, 6496.317886621908, 6582.374674405935, 6591.769288074918, 6597.307282735315, 6598.538102332838, 4601.987562736193, 4645.117427688729, 4750.76246187691, 4849.781759820808, 4862.465128835825, 4752.12085764133, 4769.236922092466, 4770.666053376265, 4770.785314660849, 4784.78468468918, 4724.102420540104, 4739.668223224376, 4739.92890106647, 4745.122152401799, 4762.690425122356, 4530.07133537624, 4735.052989402134, 4756.7859446325, 4808.519148085198, 4824.0834241494, 4130.318497447917, 4147.7926103695, 4151.667866570667, 4153.314703073989, 4153.6677065834665, 5097.368841970571, 5224.973875130638, 6154.384561543855, 6253.1245625612455, 6279.780207692709, 4723.834665786681, 4785.784639691222, 5664.348599910981, 5677.091665333527, 5678.205051292823, 5701.230333904911, 6190.845228869314, 6468.159139311906, 6884.070650462174, 6939.20199177096, 3882.165334453078, 4476.060027394251, 4634.351190833286, 4642.814287428532, 4660.0, 7110.32451917067, 7287.7449289275155, 7308.780736577911, 7309.963450182769, 7313.926860731378, 4707.411573553306, 4719.95280047202, 4757.9286310705365, 4762.761861906891, 4763.261694437368, 4821.083994041121, 4821.63837712173, 4826.541478559531, 4840.080384726961, 4859.003904199631, 5662.85842853932, 5667.631603945731, 5676.233708449389, 5677.318721753416, 5678.3186017678145, 6704.932950670528, 6973.476989225828, 6977.0, 6991.510594258353, 7021.543599666005, 1664.5672125247522, 1674.5980964568416, 1677.270387381493, 1685.848273655377, 1690.0789069956902, 982.8918818929913, 999.4602914426129, 1039.095986491757, 1100.290312748273, 1128.3906690387264, 6215.285242197115, 6216.751329946752, 6233.438990490878, 6345.460635846005, 6501.252355979028, 7194.568325900463, 7202.639868006579, 7205.567665940061, 7209.783706488814, 7217.278272172845, 6538.444232240313, 6552.705128269239, 6556.704948277244, 6559.0, 6569.310222426672, 3448.3103379324234, 3786.3373909565717, 3827.0432391902023, 3834.616538346143, 3838.3858582626644, 6492.64290464029, 6562.967185164043, 6927.792166235021, 7291.125064992235, 7609.695612175451, 7522.736704215436, 7531.698732050657, 7535.434842386843, 7536.24637536242, 7545.7358992435, 7617.047869016373, 7633.809154771064, 7639.923600764032, 7643.082830060428, 7648.388128949559, 6996.930030699627, 7221.819454513469, 7267.636618168965, 7285.125784905846, 7287.125544934642, 7125.394341480825, 7140.107486564179, 7165.426765858614, 7171.282871712787, 7185.137783465809, 7623.085229772241, 7624.351930086005, 7630.351420129351, 7643.197464266172, 7654.578998155155, 4795.736234507136, 4803.903921921612, 4805.423349198119, 4805.519448055166, 4814.253790662453, 6970.686319115551, 7227.27727227273, 7230.891536626849, 7235.746748863765, 7248.96375518119, 6990.26602206761, 7047.577145371294, 7053.259407762316, 7059.399951004222, 7064.434845212473, 5833.212516310244, 6948.687309071205, 6948.722051117898, 6948.756793512202, 6961.129858767654, 6822.283660215606, 6839.69221385029, 6849.589024658537, 6857.931420685729, 6858.657067146523, 6801.863962720817, 6942.548734332252, 7018.894716579358, 7028.4728645352825, 7036.788896333118, 6175.536834737323, 6241.282252541016, 6557.639329836714, 6680.899786503303, 6725.092112564741], "unit": "score", "name": "prototype.html", "value": 5083.9815458625935}, {"lowerIsBetter": false, "replicates": [688.5902887781771, 744.8249661329587, 750.2984709296804, 762.3634265388399, 781.413939545341, 14841.257937103142, 15172.08967461953, 15172.54482365528, 15186.848131518667, 15205.543833684993, 13567.253801040939, 13647.317634118279, 13711.0, 13731.862681373183, 13737.17576945384, 704.8308405982579, 713.7394850879417, 855.8331125430559, 871.0, 872.5506364222399, 850.8808766772626, 858.7295002074358, 866.4757821517985, 866.774638593967, 866.8483015472299, 926.754410081329, 927.9396839205464, 928.2852203803068, 928.4475736936512, 930.986035209469, 743.6281859070465, 755.5542230084277, 757.4357103957559, 903.3044555692146, 926.9907300926972, 677.806825054862, 678.5419841606896, 679.1544527063837, 682.2870100744734, 683.9418649414806, 14627.195504247262, 14708.117512949257, 14718.822494200438, 14720.0, 14721.779173312409, 12226.388680565937, 12342.568010119692, 12546.247225166519, 12799.040071994545, 13052.021098417561, 9831.90168098317, 10063.69808905734, 10187.401801158752, 10665.0, 10706.304090234109, 3299.7195238404524, 3640.5085313482605, 3646.8358923848227, 3715.3126671565847, 3741.120836603396, 78293.82559261673, 79567.20432795714, 80228.59885700593, 80306.5984670073, 80388.59805700992, 8889.422187557788, 9054.275657947348, 9265.953670231605, 9284.7678808029, 9385.671501497414, 20049.09779059946, 20455.8977205113, 20484.590308193754, 20501.38495845127, 20508.282210122576, 7280.162781280114, 7331.706731730671, 7388.519746216586, 7527.774166775005, 7529.284717951786, 3998.620131087542, 4041.393790931325, 4049.493813273341, 4074.8810618478224, 4135.29699951003, 3519.436890097572, 3545.840437180333, 3556.0398692353438, 3563.501109844624, 3571.23218508022, 664.942741041746, 675.8614484030762, 683.7265093962454, 691.7233106757237, 702.1562671181694, 574.2907509226102, 594.2007999241014, 618.1315252070848, 627.4885967936209, 632.4055387935326, 8662.350323725746, 9158.221551168092, 9209.63161473547, 9294.814103718023, 9311.674091406769, 540.6999115490862, 590.7341696236625, 606.4148097086332, 617.8795134948642, 626.4737620398887, 4039.596040395937, 4050.4531888195306, 4134.793260336971, 4221.027246446305, 4266.637335826489, 87176.564117179, 88189.0, 89139.10860891438, 89243.55378223068, 90150.0, 77088.0, 79559.20440795633, 80043.59869203817, 80824.0, 80925.59537202277, 68015.63968720598, 68262.31737682658, 68609.0, 69922.99999999898, 71794.0, 8502.064772875103, 8680.392372534114, 8886.155815197546, 9042.20892371718, 9058.909410905806, 48108.0, 49335.75332123316, 50175.24737128873, 51060.93634381949, 51706.0, 62829.68585157045, 67815.3218467809, 67885.66057169682, 68475.0, 68791.0, 10850.348979061282, 10863.67408977732, 11015.559377624806, 11258.66224013281, 11378.715532111764, 11893.226940249202, 12028.518859245532, 12084.697882553006, 12216.450259738156, 12314.199577027464, 11366.0, 11509.654710358702, 11623.916319739714, 11667.6499705009, 11718.824217636571, 11167.218294719292, 11409.657710268706, 11492.425378730863, 11601.18791684574, 11632.302061876315, 11241.264196454715, 11356.886431135583, 11691.415429228675, 11692.240004400028, 11914.404279785802, 9527.57125929321, 9586.712398628053, 9796.510174491104, 9890.554925028247, 9901.603935842773, 9524.571394287135, 9919.553620087258, 10053.748656283651, 10070.194384449373, 10129.493525323851], "unit": "score", "name": "yui.html", "value": 6910.256741305318}], "name": "dromaeo_css", "value": 7364.896005443906}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 112.0, 111.0, 110.0, 112.0, 116.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [159.0, 125.0, 142.0, 161.0, 119.0, 141.0, 140.0, 119.0, 162.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 185.0, 187.0, 189.0, 186.0, 186.0, 187.0, 184.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 76.0, 119.0, 73.0, 76.0, 77.0, 58.0, 111.0, 55.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 125.0, 79.0, 79.0, 84.0, 113.0, 77.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 85.0, 93.0, 90.0, 114.0, 115.0, 123.0, 88.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.9}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 106.0], "unit": "score", "name": "imaging-darkroom", "value": 96.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 84.0, 87.0, 87.0, 85.0, 87.0, 84.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 52.0, 54.0, 54.0, 55.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 70.0, 75.0, 72.0, 68.0, 67.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 82.0, 81.0, 97.0, 98.0, 98.0, 98.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [133.0, 134.0, 128.0, 109.0, 122.0, 125.0, 142.0, 108.0, 135.0, 107.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 136.0, 137.0, 139.0, 125.0, 137.0, 137.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 79.0, 87.0, 94.0, 90.0, 90.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.2}], "name": "kraken", "value": 1437.2}]} 16:55:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1437.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7364.90"}}} 16:55:44 INFO - Return code: 0 16:55:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:55:44 INFO - # TBPL SUCCESS # 16:55:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:44 INFO - 2016-02-24 16:55:44.488 screenresolution[1989:15991] starting screenresolution argv=screenresolution get 16:55:44 INFO - 2016-02-24 16:55:44.490 screenresolution[1989:15991] Display 0: 1600x1200x32@60 16:55:44 INFO - 2016-02-24 16:55:44.496 screenresolution[1990:15994] starting screenresolution argv=screenresolution list 16:55:44 INFO - Available Modes on Display 0 16:55:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:44 INFO - Intel Iris: 16:55:44 INFO - Chipset Model: Intel Iris 16:55:44 INFO - Type: GPU 16:55:44 INFO - Bus: Built-In 16:55:44 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:44 INFO - Vendor: Intel (0x8086) 16:55:44 INFO - Device ID: 0x0a2e 16:55:44 INFO - Revision ID: 0x0009 16:55:44 INFO - Displays: 16:55:44 INFO - Display: 16:55:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:44 INFO - Display Serial Number: 1600x1200 60 16:55:44 INFO - Main Display: Yes 16:55:44 INFO - Mirror: Off 16:55:44 INFO - Online: Yes 16:55:44 INFO - Rotation: Supported 16:55:44 INFO - Return code: 0 16:55:44 INFO - Running post-action listener: _resource_record_post_action 16:55:44 INFO - Running post-run listener: _resource_record_post_run 16:55:45 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2322432; Write bytes: 706750976; Read time: 34; Write time: 2035 16:55:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393069056; Write bytes: 387634688; Read time: 29819; Write time: 741 16:55:45 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2322432; Write bytes: 299168768; Read time: 34; Write time: 1252 16:55:45 INFO - Running post-run listener: _upload_blobber_files 16:55:45 INFO - Blob upload gear active. 16:55:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:55:45 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 16:55:45 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:55:45 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:55:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:55:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:55:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:46 INFO - (blobuploader) - INFO - Done attempting. 16:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:55:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:55:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:55:48 INFO - (blobuploader) - INFO - Done attempting. 16:55:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:55:48 INFO - Return code: 0 16:55:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:55:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:55:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef5baa82a31858850979a21a4d33014446c476b24f904b7330b28ef9b6168425285c539673a591e6d254869703b9e0ae3ea883e108d5c435cdb2bd0dff7f6f45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95e35b5e013869e218bd8dd77c2b99afa09f2db36e1a57a77a8a1757c0740d7ec2eaf193f70ada5b40a8e41974044375d6bcbe07406bb394127e6e5d76aa2b59"} 16:55:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:55:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:55:48 INFO - Contents: 16:55:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef5baa82a31858850979a21a4d33014446c476b24f904b7330b28ef9b6168425285c539673a591e6d254869703b9e0ae3ea883e108d5c435cdb2bd0dff7f6f45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95e35b5e013869e218bd8dd77c2b99afa09f2db36e1a57a77a8a1757c0740d7ec2eaf193f70ada5b40a8e41974044375d6bcbe07406bb394127e6e5d76aa2b59"} 16:55:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:55:48 INFO - Copying logs to upload dir... 16:55:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:55:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.018516 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-24 16:55:48.188829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 16:55:48.192450) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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/Fx-Team/sha512/ef5baa82a31858850979a21a4d33014446c476b24f904b7330b28ef9b6168425285c539673a591e6d254869703b9e0ae3ea883e108d5c435cdb2bd0dff7f6f45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95e35b5e013869e218bd8dd77c2b99afa09f2db36e1a57a77a8a1757c0740d7ec2eaf193f70ada5b40a8e41974044375d6bcbe07406bb394127e6e5d76aa2b59"} build_url:https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010685 build_url: 'https://queue.taskcluster.net/v1/task/QbMQU7wzRW-mksTL56SXhA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef5baa82a31858850979a21a4d33014446c476b24f904b7330b28ef9b6168425285c539673a591e6d254869703b9e0ae3ea883e108d5c435cdb2bd0dff7f6f45", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95e35b5e013869e218bd8dd77c2b99afa09f2db36e1a57a77a8a1757c0740d7ec2eaf193f70ada5b40a8e41974044375d6bcbe07406bb394127e6e5d76aa2b59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 16:55:48.218510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:55:48.218819) ========= 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.sg6kVT4PmO/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.HtXvZBVWWd/Listeners TMPDIR=/var/folders/9j/4fh549jj3szc5hrvft_030_w00000w/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.004987 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 16:55:48.267638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 16:55:48.267944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 16:55:48.268311) ========= ========= Total master_lag: 0.27 =========