builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0126 starttime: 1454034170.52 results: success (0) buildid: 20160128163036 builduid: 527d92b1a77344d5b9d5aa9b1b056c5f revision: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.519245) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.519620) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.519903) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005443 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.543962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.544229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.564484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.564764) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005908 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.612788) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.613055) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.613372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:50.613656) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-01-28 18:22:50-- 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% 28.9M=0s 2016-01-28 18:22:51 (28.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.553725 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.205450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.205722) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.025867 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:51.279014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 18:22:51.279311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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-01-28 18:22:51,388 truncating revision to first 12 chars 2016-01-28 18:22:51,388 Setting DEBUG logging. 2016-01-28 18:22:51,388 attempt 1/10 2016-01-28 18:22:51,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a152a1cbdcf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 18:22:52,502 unpacking tar archive at: mozilla-central-a152a1cbdcf0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361905 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 18:22:52.693672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.693973) ========= echo a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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 a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac program finished with exit code 0 elapsedTime=0.005570 script_repo_revision: 'a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.753009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.753286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 18:22:52.779882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-28 18:22:52.780133) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:22:52 INFO - MultiFileLogger online at 20160128 18:22:52 in /builds/slave/test 18:22:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:22:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:52 INFO - {'append_to_log': False, 18:22:52 INFO - 'base_work_dir': '/builds/slave/test', 18:22:52 INFO - 'blob_upload_branch': 'Firefox', 18:22:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:52 INFO - 'branch': 'Firefox', 18:22:52 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:52 INFO - 'config_files': ('talos/mac_config.py',), 18:22:52 INFO - 'default_actions': ('clobber', 18:22:52 INFO - 'read-buildbot-config', 18:22:52 INFO - 'download-and-extract', 18:22:52 INFO - 'populate-webroot', 18:22:52 INFO - 'create-virtualenv', 18:22:52 INFO - 'install', 18:22:52 INFO - 'run-tests'), 18:22:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:52 INFO - 'download_minidump_stackwalk': True, 18:22:52 INFO - 'download_symbols': 'ondemand', 18:22:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:52 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:52 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:52 INFO - 'installer_path': 'installer.exe', 18:22:52 INFO - 'log_level': 'info', 18:22:52 INFO - 'log_name': 'talos', 18:22:52 INFO - 'log_to_console': True, 18:22:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:22:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:22:52 INFO - 'opt_config_files': (), 18:22:52 INFO - 'pip_index': False, 18:22:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:52 INFO - 'cmd': ('bash', 18:22:52 INFO - '-c', 18:22:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:52 INFO - 'enabled': True, 18:22:52 INFO - 'halt_on_failure': False, 18:22:52 INFO - 'name': 'check_screen_resolution'},), 18:22:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:22:52 INFO - 'cmd': ('bash', 18:22:52 INFO - '-c', 18:22:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:22:52 INFO - 'enabled': True, 18:22:52 INFO - 'halt_on_failure': False, 18:22:52 INFO - 'name': 'check_screen_resolution'},), 18:22:52 INFO - 'run_cmd_checks_enabled': True, 18:22:52 INFO - 'sps_profile': False, 18:22:52 INFO - 'sps_profile_interval': 0, 18:22:52 INFO - 'suite': 'dromaeojs-e10s', 18:22:52 INFO - 'system_bits': '32', 18:22:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:52 INFO - 'title': 't-yosemite-r7-0126', 18:22:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:52 INFO - 'use_talos_json': True, 18:22:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:52 INFO - 'work_dir': 'build'} 18:22:52 INFO - ##### 18:22:52 INFO - ##### Running clobber step. 18:22:52 INFO - ##### 18:22:52 INFO - Running pre-action listener: _resource_record_pre_action 18:22:52 INFO - Running main action method: clobber 18:22:52 INFO - rmtree: /builds/slave/test/build 18:22:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:54 INFO - Running post-action listener: _resource_record_post_action 18:22:54 INFO - ##### 18:22:54 INFO - ##### Running read-buildbot-config step. 18:22:54 INFO - ##### 18:22:54 INFO - Running pre-action listener: _resource_record_pre_action 18:22:54 INFO - Running main action method: read_buildbot_config 18:22:54 INFO - Using buildbot properties: 18:22:54 INFO - { 18:22:54 INFO - "project": "", 18:22:54 INFO - "product": "firefox", 18:22:54 INFO - "script_repo_revision": "production", 18:22:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:22:54 INFO - "repository": "", 18:22:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:22:54 INFO - "buildid": "20160128163036", 18:22:54 INFO - "pgo_build": "False", 18:22:54 INFO - "basedir": "/builds/slave/test", 18:22:54 INFO - "buildnumber": 140, 18:22:54 INFO - "slavename": "t-yosemite-r7-0126", 18:22:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:22:54 INFO - "platform": "yosemite_r7", 18:22:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:22:54 INFO - "branch": "mozilla-central", 18:22:54 INFO - "repo_path": "mozilla-central", 18:22:54 INFO - "revision": "a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac", 18:22:54 INFO - "stage_platform": "macosx64", 18:22:54 INFO - "builduid": "527d92b1a77344d5b9d5aa9b1b056c5f", 18:22:54 INFO - "slavebuilddir": "test" 18:22:54 INFO - } 18:22:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:22:54 INFO - Running post-action listener: _resource_record_post_action 18:22:54 INFO - ##### 18:22:54 INFO - ##### Running download-and-extract step. 18:22:54 INFO - ##### 18:22:54 INFO - Running pre-action listener: _resource_record_pre_action 18:22:54 INFO - Running main action method: download_and_extract 18:22:54 INFO - mkdir: /builds/slave/test/build/tests 18:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:54 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json 18:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json 18:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:22:56 INFO - Downloaded 1277 bytes. 18:22:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:22:56 INFO - Using the following test package requirements: 18:22:56 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:56 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:22:56 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:22:56 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'jsshell-mac.zip'], 18:22:56 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:22:56 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:56 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:22:56 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:22:56 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:22:56 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:22:56 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:22:56 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:22:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:56 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:22:57 INFO - Downloaded 16726789 bytes. 18:22:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:22:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:00 INFO - Return code: 0 18:23:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:00 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:23:02 INFO - Downloaded 16726789 bytes. 18:23:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:23:05 INFO - Return code: 0 18:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:05 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:23:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:23:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:23:07 INFO - Downloaded 10706582 bytes. 18:23:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:23:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:23:07 INFO - Return code: 0 18:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:07 INFO - https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:23:10 INFO - Downloaded 111012885 bytes. 18:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:10 INFO - mkdir: /builds/slave/test/properties 18:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:10 INFO - Contents: 18:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:23:10 INFO - Running post-action listener: _resource_record_post_action 18:23:10 INFO - Running post-action listener: set_extra_try_arguments 18:23:10 INFO - ##### 18:23:10 INFO - ##### Running populate-webroot step. 18:23:10 INFO - ##### 18:23:10 INFO - Running pre-action listener: _resource_record_pre_action 18:23:10 INFO - Running main action method: populate_webroot 18:23:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:10 INFO - '--tppagecycles', 18:23:10 INFO - '7'], 18:23:10 INFO - 'tests': ['tsvgm']}}, 18:23:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:23:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:23:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:23:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'tests': ['damp', 'tps']}, 18:23:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['damp', 'tps']}, 18:23:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:23:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:10 INFO - 'other': {'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'other_l64': {'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'other_nol64': {'tests': ['a11yr', 18:23:10 INFO - 'ts_paint', 18:23:10 INFO - 'tpaint', 18:23:10 INFO - 'sessionrestore', 18:23:10 INFO - 'sessionrestore_no_auto_restore']}, 18:23:10 INFO - 'svgr': {'tests': ['tsvgx', 18:23:10 INFO - 'tsvgr_opacity', 18:23:10 INFO - 'tart', 18:23:10 INFO - 'tscrollx', 18:23:10 INFO - 'cart']}, 18:23:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['tsvgx', 18:23:10 INFO - 'tsvgr_opacity', 18:23:10 INFO - 'tart', 18:23:10 INFO - 'tscrollx', 18:23:10 INFO - 'cart']}, 18:23:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'tests': ['tp5o']}, 18:23:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'talos_options': ['--e10s'], 18:23:10 INFO - 'tests': ['tp5o']}, 18:23:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'talos_options': ['--xperf_path', 18:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:10 INFO - 'tests': ['tp5n']}, 18:23:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:10 INFO - 'talos_options': ['--e10s', 18:23:10 INFO - '--xperf_path', 18:23:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:10 INFO - 'tests': ['tp5n']}}, 18:23:10 INFO - 'talos.zip': {'path': '', 18:23:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:10 INFO - Running post-action listener: _resource_record_post_action 18:23:10 INFO - ##### 18:23:10 INFO - ##### Running create-virtualenv step. 18:23:10 INFO - ##### 18:23:10 INFO - Running pre-action listener: _resource_record_pre_action 18:23:10 INFO - Running main action method: create_virtualenv 18:23:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:23:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:10 INFO - Using real prefix '/tools/python27' 18:23:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:14 INFO - Installing pip.................done. 18:23:14 INFO - Return code: 0 18:23:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:14 INFO - 'HOME': '/Users/cltbld', 18:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:14 INFO - 'LOGNAME': 'cltbld', 18:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:14 INFO - 'MOZ_NO_REMOTE': '1', 18:23:14 INFO - 'NO_EM_RESTART': '1', 18:23:14 INFO - 'PAGER': '/bin/cat', 18:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:14 INFO - 'PWD': '/builds/slave/test', 18:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:14 INFO - 'SHELL': '/bin/bash', 18:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:14 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:14 INFO - 'USER': 'cltbld', 18:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:14 INFO - 'XPC_FLAGS': '0x0', 18:23:14 INFO - 'XPC_SERVICE_NAME': '0', 18:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:23:14 INFO - Cleaning up... 18:23:14 INFO - Return code: 0 18:23:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:14 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:23:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:14 INFO - 'HOME': '/Users/cltbld', 18:23:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:14 INFO - 'LOGNAME': 'cltbld', 18:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:14 INFO - 'MOZ_NO_REMOTE': '1', 18:23:14 INFO - 'NO_EM_RESTART': '1', 18:23:14 INFO - 'PAGER': '/bin/cat', 18:23:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:14 INFO - 'PWD': '/builds/slave/test', 18:23:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:14 INFO - 'SHELL': '/bin/bash', 18:23:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:14 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:14 INFO - 'USER': 'cltbld', 18:23:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:14 INFO - 'XPC_FLAGS': '0x0', 18:23:14 INFO - 'XPC_SERVICE_NAME': '0', 18:23:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:14 INFO - Downloading/unpacking psutil>=0.7.1 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:18 INFO - Installing collected packages: psutil 18:23:18 INFO - Running setup.py install for psutil 18:23:18 INFO - building 'psutil._psutil_osx' extension 18:23:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:23:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:23:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:23:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:23:19 INFO - building 'psutil._psutil_posix' extension 18:23:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:23:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:23:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:23:19 INFO - ^ 18:23:19 INFO - 1 warning generated. 18:23:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:23:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:19 INFO - Successfully installed psutil 18:23:19 INFO - Cleaning up... 18:23:19 INFO - Return code: 0 18:23:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:23:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:19 INFO - 'HOME': '/Users/cltbld', 18:23:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:19 INFO - 'LOGNAME': 'cltbld', 18:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:19 INFO - 'MOZ_NO_REMOTE': '1', 18:23:19 INFO - 'NO_EM_RESTART': '1', 18:23:19 INFO - 'PAGER': '/bin/cat', 18:23:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:19 INFO - 'PWD': '/builds/slave/test', 18:23:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:19 INFO - 'SHELL': '/bin/bash', 18:23:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:19 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:19 INFO - 'USER': 'cltbld', 18:23:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:19 INFO - 'XPC_FLAGS': '0x0', 18:23:19 INFO - 'XPC_SERVICE_NAME': '0', 18:23:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:23:22 INFO - Installing collected packages: mozsystemmonitor 18:23:22 INFO - Running setup.py install for mozsystemmonitor 18:23:22 INFO - Successfully installed mozsystemmonitor 18:23:22 INFO - Cleaning up... 18:23:22 INFO - Return code: 0 18:23:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:22 INFO - 'HOME': '/Users/cltbld', 18:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:22 INFO - 'LOGNAME': 'cltbld', 18:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:22 INFO - 'MOZ_NO_REMOTE': '1', 18:23:22 INFO - 'NO_EM_RESTART': '1', 18:23:22 INFO - 'PAGER': '/bin/cat', 18:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:22 INFO - 'PWD': '/builds/slave/test', 18:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:22 INFO - 'SHELL': '/bin/bash', 18:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:22 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:22 INFO - 'USER': 'cltbld', 18:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:22 INFO - 'XPC_FLAGS': '0x0', 18:23:22 INFO - 'XPC_SERVICE_NAME': '0', 18:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:22 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:24 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23: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 18:23:25 INFO - Downloading docopt-0.6.1.tar.gz 18:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:26 INFO - Running setup.py install for blobuploader 18:23:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:26 INFO - Running setup.py install for requests 18:23:26 INFO - Running setup.py install for docopt 18:23:26 INFO - Successfully installed blobuploader requests docopt 18:23:26 INFO - Cleaning up... 18:23:26 INFO - Return code: 0 18:23:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:26 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:23:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:26 INFO - 'HOME': '/Users/cltbld', 18:23:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:26 INFO - 'LOGNAME': 'cltbld', 18:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:26 INFO - 'MOZ_NO_REMOTE': '1', 18:23:26 INFO - 'NO_EM_RESTART': '1', 18:23:26 INFO - 'PAGER': '/bin/cat', 18:23:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:26 INFO - 'PWD': '/builds/slave/test', 18:23:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:26 INFO - 'SHELL': '/bin/bash', 18:23:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:26 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:26 INFO - 'USER': 'cltbld', 18:23:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:26 INFO - 'XPC_FLAGS': '0x0', 18:23:26 INFO - 'XPC_SERVICE_NAME': '0', 18:23:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-iVvwN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-5cVEJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-RYwB8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-27IjT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-GS8NgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-AMc4t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-74DP7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:27 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-PkwDJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VKtwo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-VY79bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-4bDlhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-oY2IzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-1RS2YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-RS1gv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-lkulpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-bo7XMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:28 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-T8pyIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:28 INFO - Running setup.py install for manifestparser 18:23:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:29 INFO - Running setup.py install for mozcrash 18:23:29 INFO - Running setup.py install for mozdebug 18:23:29 INFO - Running setup.py install for mozdevice 18:23:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:29 INFO - Running setup.py install for mozfile 18:23:29 INFO - Running setup.py install for mozhttpd 18:23:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:29 INFO - Running setup.py install for mozinfo 18:23:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Running setup.py install for mozInstall 18:23:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Running setup.py install for mozleak 18:23:30 INFO - Running setup.py install for mozlog 18:23:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Running setup.py install for moznetwork 18:23:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Running setup.py install for mozprocess 18:23:30 INFO - Running setup.py install for mozprofile 18:23:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:30 INFO - Running setup.py install for mozrunner 18:23:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:31 INFO - Running setup.py install for mozscreenshot 18:23:31 INFO - Running setup.py install for moztest 18:23:31 INFO - Running setup.py install for mozversion 18:23:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:31 INFO - Cleaning up... 18:23:31 INFO - Return code: 0 18:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:31 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:31 INFO - 'HOME': '/Users/cltbld', 18:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:31 INFO - 'LOGNAME': 'cltbld', 18:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:31 INFO - 'MOZ_NO_REMOTE': '1', 18:23:31 INFO - 'NO_EM_RESTART': '1', 18:23:31 INFO - 'PAGER': '/bin/cat', 18:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:31 INFO - 'PWD': '/builds/slave/test', 18:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:31 INFO - 'SHELL': '/bin/bash', 18:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:31 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:31 INFO - 'USER': 'cltbld', 18:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:31 INFO - 'XPC_FLAGS': '0x0', 18:23:31 INFO - 'XPC_SERVICE_NAME': '0', 18:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-tsMkhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:23:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:31 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-X3Wsrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-mzkw9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-Wia2rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-FJbTuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-xdAu22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-vsLWZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-aL8Ijc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-ZiTFqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-BpbHnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:32 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-qj9yja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-26n4bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-SS_INg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-EFGlh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-lWaTMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-yZ_NYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:23:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:33 INFO - Running setup.py (path:/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/pip-_1_xhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:23:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:35 INFO - Downloading blessings-1.6.tar.gz 18:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:36 INFO - Installing collected packages: blessings 18:23:36 INFO - Running setup.py install for blessings 18:23:36 INFO - Successfully installed blessings 18:23:36 INFO - Cleaning up... 18:23:36 INFO - Return code: 0 18:23:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:36 INFO - Reading from file tmpfile_stdout 18:23:36 INFO - Current package versions: 18:23:36 INFO - blessings == 1.6 18:23:36 INFO - blobuploader == 1.2.4 18:23:36 INFO - docopt == 0.6.1 18:23:36 INFO - manifestparser == 1.1 18:23:36 INFO - mozInstall == 1.12 18:23:36 INFO - mozcrash == 0.16 18:23:36 INFO - mozdebug == 0.1 18:23:36 INFO - mozdevice == 0.48 18:23:36 INFO - mozfile == 1.2 18:23:36 INFO - mozhttpd == 0.7 18:23:36 INFO - mozinfo == 0.9 18:23:36 INFO - mozleak == 0.1 18:23:36 INFO - mozlog == 3.1 18:23:36 INFO - moznetwork == 0.27 18:23:36 INFO - mozprocess == 0.22 18:23:36 INFO - mozprofile == 0.28 18:23:36 INFO - mozrunner == 6.11 18:23:36 INFO - mozscreenshot == 0.1 18:23:36 INFO - mozsystemmonitor == 0.0 18:23:36 INFO - moztest == 0.7 18:23:36 INFO - mozversion == 1.4 18:23:36 INFO - psutil == 3.1.1 18:23:36 INFO - requests == 1.2.3 18:23:36 INFO - wsgiref == 0.1.2 18:23:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:36 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:36 INFO - 'HOME': '/Users/cltbld', 18:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:36 INFO - 'LOGNAME': 'cltbld', 18:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:36 INFO - 'MOZ_NO_REMOTE': '1', 18:23:36 INFO - 'NO_EM_RESTART': '1', 18:23:36 INFO - 'PAGER': '/bin/cat', 18:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:36 INFO - 'PWD': '/builds/slave/test', 18:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:36 INFO - 'SHELL': '/bin/bash', 18:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:36 INFO - 'USER': 'cltbld', 18:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:36 INFO - 'XPC_FLAGS': '0x0', 18:23:36 INFO - 'XPC_SERVICE_NAME': '0', 18:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:23:36 INFO - Cleaning up... 18:23:36 INFO - Return code: 0 18:23:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:36 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 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:36 INFO - 'HOME': '/Users/cltbld', 18:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:36 INFO - 'LOGNAME': 'cltbld', 18:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:36 INFO - 'MOZ_NO_REMOTE': '1', 18:23:36 INFO - 'NO_EM_RESTART': '1', 18:23:36 INFO - 'PAGER': '/bin/cat', 18:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:36 INFO - 'PWD': '/builds/slave/test', 18:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:36 INFO - 'SHELL': '/bin/bash', 18:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:36 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:36 INFO - 'USER': 'cltbld', 18:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:36 INFO - 'XPC_FLAGS': '0x0', 18:23:36 INFO - 'XPC_SERVICE_NAME': '0', 18:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:37 INFO - Downloading/unpacking jsonschema 18:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:23:39 INFO - Downloading/unpacking functools32 (from jsonschema) 18:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:39 INFO - Downloading functools32-3.2.3-2.tar.gz 18:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:23:39 INFO - warning: no files found matching '*.txt' 18:23:39 INFO - no previously-included directories found matching 'build' 18:23:39 INFO - no previously-included directories found matching 'dist' 18:23:39 INFO - no previously-included directories found matching '.git*' 18:23:39 INFO - Installing collected packages: jsonschema, functools32 18:23:39 INFO - Running setup.py install for functools32 18:23:40 INFO - warning: no files found matching '*.txt' 18:23:40 INFO - no previously-included directories found matching 'build' 18:23:40 INFO - no previously-included directories found matching 'dist' 18:23:40 INFO - no previously-included directories found matching '.git*' 18:23:40 INFO - Successfully installed jsonschema functools32 18:23:40 INFO - Cleaning up... 18:23:40 INFO - Return code: 0 18:23:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c870a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8774c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd978da9fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, '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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:23:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:23:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:40 INFO - 'HOME': '/Users/cltbld', 18:23:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:40 INFO - 'LOGNAME': 'cltbld', 18:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:40 INFO - 'MOZ_NO_REMOTE': '1', 18:23:40 INFO - 'NO_EM_RESTART': '1', 18:23:40 INFO - 'PAGER': '/bin/cat', 18:23:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:40 INFO - 'PWD': '/builds/slave/test', 18:23:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:40 INFO - 'SHELL': '/bin/bash', 18:23:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:23:40 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:23:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:40 INFO - 'USER': 'cltbld', 18:23:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:40 INFO - 'XPC_FLAGS': '0x0', 18:23:40 INFO - 'XPC_SERVICE_NAME': '0', 18:23:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:40 INFO - Downloading/unpacking flake8 18:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:23:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:23:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:23:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:23:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:23:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:23:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:23:43 INFO - no previously-included directories found matching 'docs/_build' 18:23:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:23:44 INFO - Running setup.py install for pep8 18:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:23:44 INFO - no previously-included directories found matching 'docs/_build' 18:23:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:23:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:23:44 INFO - Cleaning up... 18:23:44 INFO - Return code: 0 18:23:44 INFO - Running post-action listener: _resource_record_post_action 18:23:44 INFO - Running post-action listener: _start_resource_monitoring 18:23:44 INFO - Starting resource monitoring. 18:23:44 INFO - ##### 18:23:44 INFO - ##### Running install step. 18:23:44 INFO - ##### 18:23:44 INFO - Running pre-action listener: _resource_record_pre_action 18:23:44 INFO - Running main action method: install 18:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:44 INFO - Reading from file tmpfile_stdout 18:23:44 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:44 INFO - Reading from file tmpfile_stdout 18:23:44 INFO - Output received: 18:23:44 INFO - Usage: mozinstall [options] installer 18:23:44 INFO - Options: 18:23:44 INFO - -h, --help show this help message and exit 18:23:44 INFO - -d DEST, --destination=DEST 18:23:44 INFO - Directory to install application into. [default: 18:23:44 INFO - "/builds/slave/test"] 18:23:44 INFO - --app=APP Application being installed. [default: firefox] 18:23:44 INFO - mkdir: /builds/slave/test/build/application 18:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:24:18 INFO - Reading from file tmpfile_stdout 18:24:18 INFO - Output received: 18:24:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:24:18 INFO - Running post-action listener: _resource_record_post_action 18:24:18 INFO - ##### 18:24:18 INFO - ##### Running run-tests step. 18:24:18 INFO - ##### 18:24:18 INFO - Running pre-action listener: _resource_record_pre_action 18:24:18 INFO - Running main action method: run_tests 18:24:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:18 INFO - 2016-01-28 18:24:18.815 screenresolution[1667:8734] starting screenresolution argv=screenresolution get 18:24:18 INFO - 2016-01-28 18:24:18.817 screenresolution[1667:8734] Display 0: 1600x1200x32@60 18:24:18 INFO - 2016-01-28 18:24:18.822 screenresolution[1668:8736] starting screenresolution argv=screenresolution list 18:24:18 INFO - Available Modes on Display 0 18:24:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:19 INFO - Intel Iris: 18:24:19 INFO - Chipset Model: Intel Iris 18:24:19 INFO - Type: GPU 18:24:19 INFO - Bus: Built-In 18:24:19 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:19 INFO - Vendor: Intel (0x8086) 18:24:19 INFO - Device ID: 0x0a2e 18:24:19 INFO - Revision ID: 0x0009 18:24:19 INFO - Displays: 18:24:19 INFO - Display: 18:24:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:19 INFO - Display Serial Number: 1600x1200 60 18:24:19 INFO - Main Display: Yes 18:24:19 INFO - Mirror: Off 18:24:19 INFO - Online: Yes 18:24:19 INFO - Rotation: Supported 18:24:19 INFO - Return code: 0 18:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:24:19 INFO - Python 2.7.3 18:24:19 INFO - Return code: 0 18:24:19 INFO - grabbing minidump binary from tooltool 18:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:19 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 0x10c715d30>, '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 0x10c578db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c70bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:24:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:24:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:24:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:24:19 INFO - Return code: 0 18:24:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:24:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:24:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:24:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:24:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:24:20 INFO - Return code: 0 18:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0126 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2RDjjLiT2N/Render', 18:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:20 INFO - 'HOME': '/Users/cltbld', 18:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:20 INFO - 'LOGNAME': 'cltbld', 18:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:20 INFO - 'MOZ_NO_REMOTE': '1', 18:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:24:20 INFO - 'NO_EM_RESTART': '1', 18:24:20 INFO - 'PAGER': '/bin/cat', 18:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:20 INFO - 'PWD': '/builds/slave/test', 18:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:20 INFO - 'SHELL': '/bin/bash', 18:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JSpIVSxi3o/Listeners', 18:24:20 INFO - 'TMPDIR': '/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/', 18:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:20 INFO - 'USER': 'cltbld', 18:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:20 INFO - 'XPC_FLAGS': '0x0', 18:24:20 INFO - 'XPC_SERVICE_NAME': '0', 18:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0126', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:24:20 INFO - mozversion application_buildid: 20160128163036 18:24:20 INFO - mozversion application_changeset: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac 18:24:20 INFO - mozversion application_display_name: Nightly 18:24:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:24:20 INFO - mozversion application_name: Firefox 18:24:20 INFO - mozversion application_remotingname: firefox 18:24:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:24:20 INFO - mozversion application_vendor: Mozilla 18:24:20 INFO - mozversion application_version: 47.0a1 18:24:20 INFO - mozversion platform_buildid: 20160128163036 18:24:20 INFO - mozversion platform_changeset: a152a1cbdcf0b2221e03f1d65ee23e6a01e50bac 18:24:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:24:20 INFO - mozversion platform_version: 47.0a1 18:24:20 INFO - using testdate: 1454034260 18:24:20 INFO - actual date: 1454034260 18:24:21 INFO - starting webserver on 'localhost:49277' 18:24:21 INFO - SUITE-START | Running 2 tests 18:24:21 INFO - TEST-START | dromaeo_css 18:24:21 INFO - operating with platform_type : mac_ 18:24:21 INFO - Initialising browser for dromaeo_css test... 18:24:21 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp_K49KD/profile http://localhost:49277/getInfo.html) 18:24:24 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 18:24:24 INFO - PROCESS | 1686 | colorDepth:24 18:24:24 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 18:24:24 INFO - PROCESS | 1686 | __metrics 18:24:24 INFO - PROCESS | 1686 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:24:24 INFO - TEST-INFO | 1686: exit 0 18:24:24 INFO - Browser initialized. 18:24:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:24:24 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmp_K49KD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:37 INFO - PROCESS | 1691 | RSS: Main: 255934464 18:24:37 INFO - PROCESS | 1691 | 18:25:26 INFO - PROCESS | 1691 | 1454034326844 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] 18:27:36 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 18:27:38 INFO - PROCESS | 1691 | RSS: Main: 270286848 18:27:38 INFO - PROCESS | 1691 | 18:30:41 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 18:30:41 INFO - PROCESS | 1691 | RSS: Main: 281796608 18:30:41 INFO - PROCESS | 1691 | 18:33:43 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 18:33:43 INFO - PROCESS | 1691 | RSS: Main: 284258304 18:33:43 INFO - PROCESS | 1691 | 18:36:45 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 18:36:46 INFO - PROCESS | 1691 | RSS: Main: 285638656 18:36:46 INFO - PROCESS | 1691 | 18:39:48 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 18:39:49 INFO - PROCESS | 1691 | RSS: Main: 289013760 18:39:49 INFO - PROCESS | 1691 | 18:42:51 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 18:42:52 INFO - PROCESS | 1691 | RSS: Main: 290697216 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | __start_tp_report 18:42:52 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 18:42:52 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 18:42:52 INFO - PROCESS | 1691 | |i|pagename|runs| 18:42:52 INFO - PROCESS | 1691 | |0;dojo.html;3477.009052420059;3503.667151620596;3516.3846326892785;3549.3078849624335;3560.1277686966696;4844.20070688336;5078.669886457377;5541.722913854302;5574.665520068798;5581.9720901395485;5470.097433923408;5593.496585307322;5599.492408611067;5622.297212848394;5661.547076233902;5094.6688465249645;5108.259302401149;5139.820106296262;5190.766415511311;5207.270982062514;5141.562967147797;5190.098400373343;5220.3996540397775;5221.817236396727;5261.736913154327;4520.638348932078;5040.042391945555;5044.319016932704;5140.151874940649;5165.070287348276;5153.2270159476;5154.278401023859;5167.224916262553;5167.6641018333685;5177.559907407875;5102.795888164469;5106.514881086291;5106.514881086291;5152.227165925141;5172.6379153459275;5240.161574148156;5366.892662146735;5429.104197807357;5521.889562208733;5539.279893613845;6138.60099093562;6139.447449729546;6146.78486252979;6147.2930612979635;6186.412290832409;5078.695278283315;5805.693718913253;5922.822315330547;6209.720562574695;6216.595921265149;5537.58468114889;5620.718964051781;5635.1828984797385;5650.0959846424785;5724.255846739898;5115.667481613683;6215.595986260879;6253.1245625612455;6302.275238347557;6306.180196574416;4833.32333473314;6033.5173186145885;6038.245219347582;6043.063325184604;6064;6096.359882212392;6106.877862442726;6138.480361557146;6149;6164.8767024659255;6034.1853849730605;6066.090086486974;6108.1143234230785;6108.816735497942;6155.630662160284;5974.492168165754;6014.669193194329;6102.481289090477;6108.786192483241;6140.6929653517145;4678.415198100238;4785.784639691222;4789.592884604778;4793.592544633745;4824.228123500223;4247.469066366704;4257.808398622069;4303.268444364466;4303.720258183208;4312.37470566766;5590.161475778666;5665.3201615806365;5676;5704.857378565569;5733.483986441241;6121.361519882508;6192.659403732748;6218.19163508741;6242.968785156136;6270.968645156836;5742.28221472316;5757.222774925415;5759.395263497357;5777.653340799566;5790.652560846278;4464.241079016575;4482.125985432809;5179.430262671103;5266.236395722599;5304.38999515053;6276.246850377893;6296.842578935563;6299.338569450233;6302.936970630235;6303.369663033844;5066.265391518283;6174.104754810617;6224.035274532454;6232.376762323732;6259.280182778856;6142.805741014558;6238.157848690369;6293.433590976834;6312.842178945563;6320.5575609706875;5483.232347471437;5707.714614269353;6039.943009973325;6054.727537260922;6091.8781624366375;5134.9486505135965;6085.543584231289;6166.599171053867;6188.2883468399905;6209.316975132822;5890.1164825276555;5940.960331941979;5949.018411962151;5951.940480595139;5964.075568286922;5728.971355143198;5958.702064896651;5965.105234214902;5967.164596956342;5970.044792833126;5586.6871285247125;5778.797742079175;5819.447152520504;5835.241418615553;5838.912416313674;5914.645121292736;5917.260342457193;5920.555958303058;5947.286325640951;5950.19672344228;5785.537157027512;5814.186013958134;5817.243758311392;5822;5841.474267315962 18:42:52 INFO - PROCESS | 1691 | |1;ext.html;498.55877548369705;512.7335481361039;524.0331588219733;590.7459792289317;596.3857227056134;38266.80866595667;38515;38657.80671096644;38797.030074248156;38853.22293554127;38674.41988370177;39157.60842391575;39172.21655566887;39265.80367098167;39304.213915721666;9376.249900008;9513.667021654244;9562.139407453327;9592;9613.086756758097;9424.293178011641;9657.95171024144;9661.95169024154;9671.903280967206;9704.70885873425;9679.128878400943;9679.5644196011;9684.225261979025;9702.61189552417;9731.416115033086;9594.28042896782;9649.083337082966;9658.75853103671;9679.612815487371;9691.660791872251;9578.281628877792;9679.661211857621;9723.319367644268;9733.124018838267;9738.561764720534;38857;38935.41596876049;39185.60814391848;39289.60710392888;39340;3223.854926528312;3350.0954742219465;3482.9651703482896;3685.262947410529;3718.572364178127;23920;28859.134225973256;29108.215931928924;29360;29376.41247175066;2327.3134425344565;2761.406297646016;2763.06055940979;2838.914832555027;2977.478941185284;478193.6090319561;479417;480312;480991.5950420225;483659;45004;58477.70761146252;67567.32432675708;67634;67693.32306676969;69377;69682.30317696859;70811.64594177098;70843.16627334848;70957;16039.117848518443;16196;16208.75686864698;16210.918945405198;16234.350625974828;11947.522099115939;12034;12069.75860482803;12142;12154.513819447124;20699.379018629465;20949.68575471369;21112.049957751937;21349.93250337477;21373.78626213718;7528;8354.830323754679;8690.04409514953;8863.911360886437;8869.379143460024;820.6512232301249;917.2203626917201;941.924646028316;1066.8559744434558;1084.1760262200626;31167.220819479695;32288.677113229038;32330;32570.674293257238;32753.378378378093;998.4209158687944;1047.8428235764543;1077.5582011375297;1090.1605763562013;1117.5920788911988;15117.622059448382;15531.45639902598;15577.454789082327;15646.982946108466;15860.286287117107;526620;543170;552988;556137;557295;56655.43344566502;57274.42725572691;57312;57447.138292925636;57655;1385.2727318157847;1395.1489591349268;1412.8516505766952;1417.6668482906302;1529.45704274983;30584;30694.539581905843;30748.385032299677;31201.8439907799;31355.843220784664;52123.739381302854;52232.73883630557;52452;52519.73740131275;52531;513756;514087;517113;517257.413712929;518234;28289.57565636476;28761.856190718914;28906.855465722536;30395;32732.672673273915;34925.47611785775;42526.57473425226;43027.139457211306;43945.34081988837;44897.55102448934;34845;36147.819260903525;37766.866993990225;39283.82148535434;39996.000099997735;36491.438570178725;36523;36536.26927461383;36599.81700091482;37031.62968370282;36245;36431.45352819763;36623.63376366202;36786.448203277505;36798.44802328021;31728;32562.02313930491;32577.185570359983;33011;33075.66924330726;24537.509249815263;25364.239072827844;25605.871970640026;25634.487310254062;26123.477530449665 18:42:52 INFO - PROCESS | 1691 | |2;jquery.html;358.6861496190833;362.62106099126413;365.5996683631424;369.123332086295;370.8498058286393;15200.847991520082;18113.003784791832;18882.811171888276;19509.219631214753;20260.189592416304;11309.038731707795;12293.815592766116;18355.990420526865;18419.907900460512;18430.631387372243;3934.5081864766903;4987.526185012427;5259;5269.473052694738;5272.8154514592;4001.399790031504;5655.3779084300695;5922.703864806764;5938.4358485943985;5948.048312270038;5388.622796404254;5454.563634909197;5800.941990580103;5806.44838740319;5864.149698293745;5193.246979188016;6260.843478913018;6271.905921411182;6289.276733175652;6318.968405157968;5639.943600563983;5652.378238393773;5655.0386434306265;5667.1782591524;5669.546436285087;13308.467661293536;13338.666533336647;22010.459267851096;23757.88121059401;24349.513009739705;2080.199123337526;2089.341857314956;2090.153487837428;2154.536774593454;2210.723659542557;9782;9858.654947076819;10144;11758.764824703543;14584.854151458456;1652.1573997261362;1748.3356324596698;1772.5391398236552;1822.2073398071882;1877.2491003598534;96815;98241;98677.50661246647;99129.50435247777;100029;10929.836052459219;11127.276727012719;11178.441077946232;11200.383978881076;11242.269252498561;13319.067665263532;13411.597652070453;13427.060105792696;13435.12671676338;13449.798253026212;7776.611169441619;8126.715564955198;8233.094359620436;8265.586720663943;8301.418900676894;7830;8305.95847020761;8340.165983401612;8360.707375241838;8398.538080405515;4014.1369605534364;4180.205760905479;4187.371894215831;4315.719478233905;4475.440569928759;1841.843443307307;1893.3941138835442;1909.2458478900755;1921.5196200949763;1927.681932481125;832.9730078973366;843.0473564871778;876.82901834143;907.2832462354797;1007.6171054999201;7965.721199757981;17549.94700317985;18994.71507927382;19096.80903190978;19378.70931936022;420.287612496815;444.2802659691321;451.97740112994217;452.89357001104713;467.33638233707535;5452.863678407992;5781.335146458211;5852.4440178183;6061.54538409621;6138.877222455615;415843;418560;418567;419421;427598;68439.31560684429;108646.91353086368;113972;116801.41599291949;117537;492.2591499792789;504.67700671570225;510.3263691926621;511.86947328431756;516.318459633288;9936.105750482202;10870.510827012646;10872.347659140476;10873.619423320146;10879.401632910265;38038.42942355812;46498.535014649424;47911;50497.747511263675;50510;64089.67955160381;68628.31371686219;68687;69159;69327;7431.331180193809;7622.352100071556;7641.923580764344;7655.57894315818;7705.460617756703;8304.045034821072;8307.127751585997;8509.234168924826;8529;9406.623735050522;3357.3453176630323;7413.147488038944;7461.470398568389;7512.849743005;7564.810879727831;7210.170830354366;7231.8553628928175;7576.166621671722;7647.388208943383;7666.310032097138;7780.961095194488;7784.2215778421705;7824.92175078242;7826;7920.366370690215;10992;11027.61403350879;11099.05658019045;11212.103031757602;11281.830772538582;10854.728631784268;10879.401632909949;10899.618513351994;11055.944720276348;11121.221514493907 18:42:52 INFO - PROCESS | 1691 | |3;mootools.html;1511.8714909232715;1514.409380341667;1759.4281858396025;1896.7060105683624;1898.6487499812536;7848.607569621525;7964.00449943757;8573.485590864544;8749.387542871993;8761.737147885566;8359.247667709906;8408.03307619624;8513.361497887669;8513.744587662364;8526.232639062484;2466.6300054991807;2496.6379874918125;2498.900043998238;2502.874856257189;2503.2740505253455;2487.5273697997413;2530.278870521902;2536.708278547963;2540.6697129373156;2548.3374322676145;2450.583400821856;2461.2985299189736;2497.213377786001;2503.3866702657874;2503.4993001399703;2148.3554933520036;2455.8649274289905;2474.7277799442045;2514.208024472285;2518.2193520008764;2508.134693530729;2538.5938249879932;2544.4529426173463;2546.5161619292276;2556.6804149481313;8608.913910860874;8666.56667166639;8671.653133874637;8718.084601116854;8718.389712720113;5333.2000199969925;5469.671819690831;5470.480304371078;5483.972580137113;5497.285352904137;3632.9273414531826;3669.724770642186;3709.962900370989;3747.025773298962;3761.0597350662333;884.4383816276711;891.7324802559207;1076.2304951959386;1087.7389426537652;1090.5637744902024;11482.368469734161;11659.883401165964;11665.066794656406;11679.416029198592;11690.707732306675;4901.240307752304;4932.950670493321;4964.205727083649;4968.950310496849;4987.675801072919;8541.572921353907;8656.874606301266;9505.287103467268;9999.100080992746;10013.749656258651;5423.918641220384;5424.728763561806;5441.918371224435;5442.619016668875;5462.535684466785;4433.556644335606;4545.863624091283;4799;4862.756862156878;4947.851564453073;3946.4869566956113;3981.7013723970817;3992.960070399317;4027.617376349242;4031.8387264509092;1312.4422120598708;1325.284346452924;1325.8143859859626;1332.460353556811;1338.5783478204335;1327.0776810116877;1327.323065236717;1331.4341404902877;1361.8774310311921;1372.5058978767636;7837.1379148293645;7865.410094242955;7919.445638805229;7986.880196797053;8003.279704826477;508.1767536590747;513.6507175120954;517.7566543724444;517.9769954340223;518.3365292425701;6130.816075517741;6132.938670613326;6151.292601350902;6182.350853160443;6202.069689546604;8528.53093079874;10092.646757363456;10229.641962531276;10370.740731481774;10381.636642717469;8414.36892233085;10126.468382904273;10137.391756494633;10224;10318.948405257926;7889.487183333065;8236.711715090063;8243.2581067703;8257.8348433031;8304.501729896225;7230.204677485578;7243.130824301117;7748.496347737379;8014.799630009064;8034.799130021563;9033.728988130366;9317.11487408695;9341.953290233505;9403.294752893697;9455.716328510156;9222.492762898106;9494.762630934281;9515.476648784383;9522.761930951781;9596.616135354509;6817;6985.5808651481075;7256.2018178001435;7363.595002274927;7486.850262994819;8066.717664881701;8070.677172913018;8110.229528194812;8119.83760324802;8163.795905102183;7419.962900185465;7550.584717840571;7606.04924384452;7688.038995125609;7707.884381734167;7359.484836061424;7384.852302954018;7397.149327827368;7513.2862378074;7527.1343795462035;7519.661615227437;7576.848463030598;7600.429967752551;7652.158262591;7657.042869641295;6833.794986150423;6961.8955715665315;6976.441884649317;6993.230744617987;6993.510454268152;7035.437165026683;7078.858422831618;7102.325279098477;7109.82225444368;7110.85778284421 18:42:52 INFO - PROCESS | 1691 | |4;prototype.html;331.29930197632007;332.2358575276864;335.50177985691226;341.67370161495774;344.9582261570057;6481.157449531566;6574.474042076635;6620.073189753432;6631.436327912121;6683.832904177392;6368.840778980528;6512.772052978146;6513.869722605545;6518.967405162979;6580.736770529173;4892.266160075981;4908.901821963558;4918.926216106761;4923.55687988081;4937.802487900498;4898.8040478381;4912.70523768575;4913.287573301887;4914;4922.8523144305545;4259.361095835634;4289.806958686851;4634.860954171363;4802.735849528274;4847.030593881238;4774.880627984294;4781.593564547;4809.206480930642;4830.2271636538335;4836.613070954315;3652.3425783358985;3970.8610198643196;3982.0443093657314;4089.815958281855;4091.6112969267874;5266.8683282917855;6158.076288556707;6173.104899789505;6205.875882482325;6251.812445626639;5515.586331025149;5562;5567.638103523258;5573.721313934287;5604.99110160171;6722.260551339349;6820.420264277543;6898.413634841045;6920.688569014406;6945.166580010431;4531.207038768202;4548.658850586219;4549.818007279705;4550.68145229834;4551.135284295973;5555.833275012253;6689.531732778707;7025.227225005246;7248.057752492142;7356.742514012038;4613.354130421743;4626.699264547794;4627.838025669153;4642.883927901829;4646.117237724821;4571.634269258451;4697.647676424282;4705.270683044065;4708.717476951394;4719.457262414866;5566;5578.944210557924;5584.162375643686;5591.133374326986;5596.468335508121;6946.235914049451;6962.895556566656;6974.407175390149;6982.441404687613;6991.685374158175;1614.8465895739887;1636.1328495897194;1637.7379619260862;1641.7127002774705;1643.7370020796616;1020.739711373595;1063.967951087444;1069;1073.935563866155;1073.983890241647;6667.099941507931;6669.333066693389;6685.331466853276;6691.76578819739;6714.429273511806;7252.601106939169;7266.781996540007;7280.708771649181;7305.050343455317;7372.557646541118;6461.127747754087;6658.9001164982565;6661.333866613397;6700.698468568926;6776.15298087739;3643.307771523455;3824.7322687411615;3851.1527463957887;3854.8650797221962;3858.594847541024;7515.286047825448;7587.355074818703;7675.731349402856;7688.846223075507;7710;7469.626518674045;7472.925270747223;7558.735444259424;7559;7603.505772124794;7561.09266887966;7771.611419429006;7778.277602838961;7833.138354780969;7853.528788272722;7362.079740032496;7372.299631534996;7389.224131466333;7390.889136662847;7404.740834070782;7222.09723784527;7228.7469938554;7232.89150662751;7235.529690570096;7256.346928776436;7528.661210245443;7790.961045194737;7809.3362064225175;7832.569208693349;7857.2928436441;4663.108872499072;4690.554397332248;4691.5308469152815;4704.176769065469;4708.952910470988;7069.893951590833;7288.161861385796;7309.707611695472;7310.013148224922;7320.597367144858;4853.733044682576;5943.346231914399;6782.796516104525;7065.046218760402;7079.823004424725;7028.718851246097;7040.823979400556;7060.188078371053;7062.435005199469;7063.470239732143;5627.240322556566;6689.163854518185;6887.483438742014;6917.827054323682;6929.930700692928;5670.603057785916;5679.574031947538;5683.60214784961;7031.929680703128;7069.681864316015;5438.483344082306;6750.5274630775375;6910;6939.132608423947;6939.167299924042 18:42:52 INFO - PROCESS | 1691 | |5;yui.html;640.9006603976384;655.4592461219494;681.4173881331465;690.0442886602058;727.1528669100495;14509.564713058598;14552.272386380691;14826.703465930688;14910.627234319147;14983.250837458138;13758.793618095737;13852.445902163927;13897.583072507816;13929.233892135928;13946.302684865766;693.9201991770935;708.6669265445232;849.8045449546609;852.4927668037508;866.2420382165606;865.7402779166256;872.4329186029069;874.1564390363299;874.9168828961239;876.7808047988003;900.0684291758032;902.6479672927563;905.4612505559214;905.7463910105181;907.768519027647;889.4618755652866;892.2193081054078;893.2184338703635;897.9236764874994;900.5992333411634;646.7510008646658;661.1405173274771;666.4468491152332;669.2303850571833;670.9832254193635;14361.71276574473;14498.492552760603;14576.344064517121;14592.05151665149;14647.63380915475;12437.937810310981;12473.251604903735;12523.686907827287;12561.371931403393;12620.684482888002;9986.650467233612;10006.399616023062;10350.792984140275;10371.170306375472;10749.247552671317;3349.866005359783;3510.157562185057;3558.288342331544;3571.910702232465;3700.389435743099;74684.25315746828;74812.99999999946;74954.62522687351;78788;79311.60344198241;8719.779230907678;9271.721848344561;9343.532823358804;9560.760980975392;9649.951750241204;19057.237710491427;20800.959952002642;20848.270310539363;20858.791412085684;20871.791282086986;7405.740799072007;7420.888686669704;7463.8507229855095;7571.924280757122;7728.4590078693955;3989.84040638377;4075;4076.5311989121633;4088.34586466164;4099.159672267178;3516.1033936346066;3555.6444355564236;3567.857285708543;3569.839357228931;3571.39286321326;633.499535367064;647.799182253503;648.2383199740286;669.4677731203705;673.2190658835727;485.5969545277411;568.903286441306;570.5492660798006;590.8375196820908;611.9418655227746;8067.628503154478;8492.384519350811;8612.526311052952;8708.433951793113;8849.070847561043;440.41864738544814;570.2216474512344;626.9123071470995;633.3508154141949;637.7480895046431;3791.3933770596573;3970.7419017763755;4133.297339452301;4167.666586673059;4178.603032711888;77624;79164;79272.60363698144;79276.6036169827;86479.13520864837;70081;72123.6393818038;77758;77780.444391113;78963.60518197372;48316.7584162077;51799.22301165561;62649.68675156595;63348.04977925335;66925.66537167283;8012.22508539604;8119.79700507492;8346.582670866312;8693.565321733762;8887.911120888966;38203.85388438351;47698.91938889579;48944;49367.506324936294;50359.74820125876;68821.65589172022;69195.65402172957;69403;69984.65007674928;70506;9110.180083792491;10694.62568810088;10912.236143469881;11047.337159770439;11822.290662560274;10726.946365268124;11899.583514576949;12022.398880056136;12024.098192635762;12560.183588066746;11716.765664686829;11750.177487575787;11858.229215100991;11933.761324773282;11967.880321196677;11673;11696.649100526998;11727.179097463095;11886.34625095628;11951.282923024299;11283.943580282046;11332.263402878787;11414.94292528532;11479.8278025828;11730.002949749367;7876.414056706451;8431.29951078989;9187.540622968958;9437.103475169848;9511.143997040299;9904.950475247577;9942.30403871722;10030.191546367028;10067.53831069623;10117.291789574954 18:42:52 INFO - PROCESS | 1691 | __end_tp_report 18:42:52 INFO - PROCESS | 1691 | __start_cc_report 18:42:52 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,374 18:42:52 INFO - PROCESS | 1691 | __end_cc_report 18:42:52 INFO - PROCESS | 1691 | __startTimestamp1454035372248__endTimestamp 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | ------- Summary: start ------- 18:42:52 INFO - PROCESS | 1691 | Number of tests: 6 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#0] dojo.html Cycles:165 Average:5595.58 Median:5777.65 stddev:636.38 (11.0%) stddev-sans-first:616.25 18:42:52 INFO - PROCESS | 1691 | Values: 3477.0 3503.7 3516.4 3549.3 3560.1 4844.2 5078.7 5541.7 5574.7 5582.0 5470.1 5593.5 5599.5 5622.3 5661.5 5094.7 5108.3 5139.8 5190.8 5207.3 5141.6 5190.1 5220.4 5221.8 5261.7 4520.6 5040.0 5044.3 5140.2 5165.1 5153.2 5154.3 5167.2 5167.7 5177.6 5102.8 5106.5 5106.5 5152.2 5172.6 5240.2 5366.9 5429.1 5521.9 5539.3 6138.6 6139.4 6146.8 6147.3 6186.4 5078.7 5805.7 5922.8 6209.7 6216.6 5537.6 5620.7 5635.2 5650.1 5724.3 5115.7 6215.6 6253.1 6302.3 6306.2 4833.3 6033.5 6038.2 6043.1 6064.0 6096.4 6106.9 6138.5 6149.0 6164.9 6034.2 6066.1 6108.1 6108.8 6155.6 5974.5 6014.7 6102.5 6108.8 6140.7 4678.4 4785.8 4789.6 4793.6 4824.2 4247.5 4257.8 4303.3 4303.7 4312.4 5590.2 5665.3 5676.0 5704.9 5733.5 6121.4 6192.7 6218.2 6243.0 6271.0 5742.3 5757.2 5759.4 5777.7 5790.7 4464.2 4482.1 5179.4 5266.2 5304.4 6276.2 6296.8 6299.3 6302.9 6303.4 5066.3 6174.1 6224.0 6232.4 6259.3 6142.8 6238.2 6293.4 6312.8 6320.6 5483.2 5707.7 6039.9 6054.7 6091.9 5134.9 6085.5 6166.6 6188.3 6209.3 5890.1 5941.0 5949.0 5951.9 5964.1 5729.0 5958.7 5965.1 5967.2 5970.0 5586.7 5778.8 5819.4 5835.2 5838.9 5914.6 5917.3 5920.6 5947.3 5950.2 5785.5 5814.2 5817.2 5822.0 5841.5 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#1] ext.html Cycles:180 Average:65709.46 Median:38855.11 stddev:137178.45 (353.1%) stddev-sans-first:137475.89 18:42:52 INFO - PROCESS | 1691 | Values: 498.6 512.7 524.0 590.7 596.4 38266.8 38515.0 38657.8 38797.0 38853.2 38674.4 39157.6 39172.2 39265.8 39304.2 9376.2 9513.7 9562.1 9592.0 9613.1 9424.3 9658.0 9662.0 9671.9 9704.7 9679.1 9679.6 9684.2 9702.6 9731.4 9594.3 9649.1 9658.8 9679.6 9691.7 9578.3 9679.7 9723.3 9733.1 9738.6 38857.0 38935.4 39185.6 39289.6 39340.0 3223.9 3350.1 3483.0 3685.3 3718.6 23920.0 28859.1 29108.2 29360.0 29376.4 2327.3 2761.4 2763.1 2838.9 2977.5 478193.6 479417.0 480312.0 480991.6 483659.0 45004.0 58477.7 67567.3 67634.0 67693.3 69377.0 69682.3 70811.6 70843.2 70957.0 16039.1 16196.0 16208.8 16210.9 16234.4 11947.5 12034.0 12069.8 12142.0 12154.5 20699.4 20949.7 21112.0 21349.9 21373.8 7528.0 8354.8 8690.0 8863.9 8869.4 820.7 917.2 941.9 1066.9 1084.2 31167.2 32288.7 32330.0 32570.7 32753.4 998.4 1047.8 1077.6 1090.2 1117.6 15117.6 15531.5 15577.5 15647.0 15860.3 526620.0 543170.0 552988.0 556137.0 557295.0 56655.4 57274.4 57312.0 57447.1 57655.0 1385.3 1395.1 1412.9 1417.7 1529.5 30584.0 30694.5 30748.4 31201.8 31355.8 52123.7 52232.7 52452.0 52519.7 52531.0 513756.0 514087.0 517113.0 517257.4 518234.0 28289.6 28761.9 28906.9 30395.0 32732.7 34925.5 42526.6 43027.1 43945.3 44897.6 34845.0 36147.8 37766.9 39283.8 39996.0 36491.4 36523.0 36536.3 36599.8 37031.6 36245.0 36431.5 36623.6 36786.4 36798.4 31728.0 32562.0 32577.2 33011.0 33075.7 24537.5 25364.2 25605.9 25634.5 26123.5 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#2] jquery.html Cycles:180 Average:27151.81 Median:23482.94 stddev:71014.99 (302.4%) stddev-sans-first:71185.71 18:42:52 INFO - PROCESS | 1691 | Values: 358.7 362.6 365.6 369.1 370.8 15200.8 18113.0 18882.8 19509.2 20260.2 11309.0 12293.8 18356.0 18419.9 18430.6 3934.5 4987.5 5259.0 5269.5 5272.8 4001.4 5655.4 5922.7 5938.4 5948.0 5388.6 5454.6 5800.9 5806.4 5864.1 5193.2 6260.8 6271.9 6289.3 6319.0 5639.9 5652.4 5655.0 5667.2 5669.5 13308.5 13338.7 22010.5 23757.9 24349.5 2080.2 2089.3 2090.2 2154.5 2210.7 9782.0 9858.7 10144.0 11758.8 14584.9 1652.2 1748.3 1772.5 1822.2 1877.2 96815.0 98241.0 98677.5 99129.5 100029.0 10929.8 11127.3 11178.4 11200.4 11242.3 13319.1 13411.6 13427.1 13435.1 13449.8 7776.6 8126.7 8233.1 8265.6 8301.4 7830.0 8306.0 8340.2 8360.7 8398.5 4014.1 4180.2 4187.4 4315.7 4475.4 1841.8 1893.4 1909.2 1921.5 1927.7 833.0 843.0 876.8 907.3 1007.6 7965.7 17549.9 18994.7 19096.8 19378.7 420.3 444.3 452.0 452.9 467.3 5452.9 5781.3 5852.4 6061.5 6138.9 415843.0 418560.0 418567.0 419421.0 427598.0 68439.3 108646.9 113972.0 116801.4 117537.0 492.3 504.7 510.3 511.9 516.3 9936.1 10870.5 10872.3 10873.6 10879.4 38038.4 46498.5 47911.0 50497.7 50510.0 64089.7 68628.3 68687.0 69159.0 69327.0 7431.3 7622.4 7641.9 7655.6 7705.5 8304.0 8307.1 8509.2 8529.0 9406.6 3357.3 7413.1 7461.5 7512.8 7564.8 7210.2 7231.9 7576.2 7647.4 7666.3 7781.0 7784.2 7824.9 7826.0 7920.4 10992.0 11027.6 11099.1 11212.1 11281.8 10854.7 10879.4 10899.6 11055.9 11121.2 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#3] mootools.html Cycles:180 Average:5932.26 Median:5490.63 stddev:3055.10 (55.6%) stddev-sans-first:3045.60 18:42:52 INFO - PROCESS | 1691 | Values: 1511.9 1514.4 1759.4 1896.7 1898.6 7848.6 7964.0 8573.5 8749.4 8761.7 8359.2 8408.0 8513.4 8513.7 8526.2 2466.6 2496.6 2498.9 2502.9 2503.3 2487.5 2530.3 2536.7 2540.7 2548.3 2450.6 2461.3 2497.2 2503.4 2503.5 2148.4 2455.9 2474.7 2514.2 2518.2 2508.1 2538.6 2544.5 2546.5 2556.7 8608.9 8666.6 8671.7 8718.1 8718.4 5333.2 5469.7 5470.5 5484.0 5497.3 3632.9 3669.7 3710.0 3747.0 3761.1 884.4 891.7 1076.2 1087.7 1090.6 11482.4 11659.9 11665.1 11679.4 11690.7 4901.2 4933.0 4964.2 4969.0 4987.7 8541.6 8656.9 9505.3 9999.1 10013.7 5423.9 5424.7 5441.9 5442.6 5462.5 4433.6 4545.9 4799.0 4862.8 4947.9 3946.5 3981.7 3993.0 4027.6 4031.8 1312.4 1325.3 1325.8 1332.5 1338.6 1327.1 1327.3 1331.4 1361.9 1372.5 7837.1 7865.4 7919.4 7986.9 8003.3 508.2 513.7 517.8 518.0 518.3 6130.8 6132.9 6151.3 6182.4 6202.1 8528.5 10092.6 10229.6 10370.7 10381.6 8414.4 10126.5 10137.4 10224.0 10318.9 7889.5 8236.7 8243.3 8257.8 8304.5 7230.2 7243.1 7748.5 8014.8 8034.8 9033.7 9317.1 9342.0 9403.3 9455.7 9222.5 9494.8 9515.5 9522.8 9596.6 6817.0 6985.6 7256.2 7363.6 7486.9 8066.7 8070.7 8110.2 8119.8 8163.8 7420.0 7550.6 7606.0 7688.0 7707.9 7359.5 7384.9 7397.1 7513.3 7527.1 7519.7 7576.8 7600.4 7652.2 7657.0 6833.8 6961.9 6976.4 6993.2 6993.5 7035.4 7078.9 7102.3 7109.8 7110.9 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#4] prototype.html Cycles:180 Average:5706.79 Median:6496.96 stddev:1840.59 (28.3%) stddev-sans-first:1800.99 18:42:52 INFO - PROCESS | 1691 | Values: 331.3 332.2 335.5 341.7 345.0 6481.2 6574.5 6620.1 6631.4 6683.8 6368.8 6512.8 6513.9 6519.0 6580.7 4892.3 4908.9 4918.9 4923.6 4937.8 4898.8 4912.7 4913.3 4914.0 4922.9 4259.4 4289.8 4634.9 4802.7 4847.0 4774.9 4781.6 4809.2 4830.2 4836.6 3652.3 3970.9 3982.0 4089.8 4091.6 5266.9 6158.1 6173.1 6205.9 6251.8 5515.6 5562.0 5567.6 5573.7 5605.0 6722.3 6820.4 6898.4 6920.7 6945.2 4531.2 4548.7 4549.8 4550.7 4551.1 5555.8 6689.5 7025.2 7248.1 7356.7 4613.4 4626.7 4627.8 4642.9 4646.1 4571.6 4697.6 4705.3 4708.7 4719.5 5566.0 5578.9 5584.2 5591.1 5596.5 6946.2 6962.9 6974.4 6982.4 6991.7 1614.8 1636.1 1637.7 1641.7 1643.7 1020.7 1064.0 1069.0 1073.9 1074.0 6667.1 6669.3 6685.3 6691.8 6714.4 7252.6 7266.8 7280.7 7305.1 7372.6 6461.1 6658.9 6661.3 6700.7 6776.2 3643.3 3824.7 3851.2 3854.9 3858.6 7515.3 7587.4 7675.7 7688.8 7710.0 7469.6 7472.9 7558.7 7559.0 7603.5 7561.1 7771.6 7778.3 7833.1 7853.5 7362.1 7372.3 7389.2 7390.9 7404.7 7222.1 7228.7 7232.9 7235.5 7256.3 7528.7 7791.0 7809.3 7832.6 7857.3 4663.1 4690.6 4691.5 4704.2 4709.0 7069.9 7288.2 7309.7 7310.0 7320.6 4853.7 5943.3 6782.8 7065.0 7079.8 7028.7 7040.8 7060.2 7062.4 7063.5 5627.2 6689.2 6887.5 6917.8 6929.9 5670.6 5679.6 5683.6 7031.9 7069.7 5438.5 6750.5 6910.0 6939.1 6939.2 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - PROCESS | 1691 | [#5] yui.html Cycles:180 Average:17387.25 Median:31638.30 stddev:23743.79 (75.0%) stddev-sans-first:23777.10 18:42:52 INFO - PROCESS | 1691 | Values: 640.9 655.5 681.4 690.0 727.2 14509.6 14552.3 14826.7 14910.6 14983.3 13758.8 13852.4 13897.6 13929.2 13946.3 693.9 708.7 849.8 852.5 866.2 865.7 872.4 874.2 874.9 876.8 900.1 902.6 905.5 905.7 907.8 889.5 892.2 893.2 897.9 900.6 646.8 661.1 666.4 669.2 671.0 14361.7 14498.5 14576.3 14592.1 14647.6 12437.9 12473.3 12523.7 12561.4 12620.7 9986.7 10006.4 10350.8 10371.2 10749.2 3349.9 3510.2 3558.3 3571.9 3700.4 74684.3 74813.0 74954.6 78788.0 79311.6 8719.8 9271.7 9343.5 9560.8 9650.0 19057.2 20801.0 20848.3 20858.8 20871.8 7405.7 7420.9 7463.9 7571.9 7728.5 3989.8 4075.0 4076.5 4088.3 4099.2 3516.1 3555.6 3567.9 3569.8 3571.4 633.5 647.8 648.2 669.5 673.2 485.6 568.9 570.5 590.8 611.9 8067.6 8492.4 8612.5 8708.4 8849.1 440.4 570.2 626.9 633.4 637.7 3791.4 3970.7 4133.3 4167.7 4178.6 77624.0 79164.0 79272.6 79276.6 86479.1 70081.0 72123.6 77758.0 77780.4 78963.6 48316.8 51799.2 62649.7 63348.0 66925.7 8012.2 8119.8 8346.6 8693.6 8887.9 38203.9 47698.9 48944.0 49367.5 50359.7 68821.7 69195.7 69403.0 69984.7 70506.0 9110.2 10694.6 10912.2 11047.3 11822.3 10726.9 11899.6 12022.4 12024.1 12560.2 11716.8 11750.2 11858.2 11933.8 11967.9 11673.0 11696.6 11727.2 11886.3 11951.3 11283.9 11332.3 11414.9 11479.8 11730.0 7876.4 8431.3 9187.5 9437.1 9511.1 9905.0 9942.3 10030.2 10067.5 10117.3 18:42:52 INFO - PROCESS | 1691 | -------- Summary: end -------- 18:42:52 INFO - PROCESS | 1691 | 18:42:52 INFO - TEST-INFO | 1691: exit 0 18:42:52 INFO - TEST-OK | dromaeo_css | took 1111712ms 18:42:52 INFO - TEST-START | kraken 18:42:52 INFO - operating with platform_type : mac_ 18:42:52 INFO - Initialising browser for kraken test... 18:42:52 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpx79SwQ/profile http://localhost:49277/getInfo.html) 18:42:55 INFO - PROCESS | 1700 | __metrics Screen width/height:1600/1200 18:42:55 INFO - PROCESS | 1700 | colorDepth:24 18:42:55 INFO - PROCESS | 1700 | Browser inner width/height: 1024/689 18:42:55 INFO - PROCESS | 1700 | __metrics 18:42:55 INFO - PROCESS | 1700 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:42:56 INFO - TEST-INFO | 1700: exit 0 18:42:56 INFO - Browser initialized. 18:42:56 INFO - Running cycle 1/1 for kraken test... 18:42:56 INFO - TEST-INFO | started process 1703 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/tmpx79SwQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:08 INFO - PROCESS | 1703 | RSS: Main: 256364544 18:43:08 INFO - PROCESS | 1703 | 18:43:10 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:11 INFO - PROCESS | 1703 | RSS: Main: 269221888 18:43:11 INFO - PROCESS | 1703 | 18:43:14 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 18:43:14 INFO - PROCESS | 1703 | RSS: Main: 278962176 18:43:14 INFO - PROCESS | 1703 | 18:43:18 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 18:43:18 INFO - PROCESS | 1703 | RSS: Main: 281497600 18:43:18 INFO - PROCESS | 1703 | 18:43:20 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 18:43:21 INFO - PROCESS | 1703 | RSS: Main: 282873856 18:43:21 INFO - PROCESS | 1703 | 18:43:23 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:23 INFO - PROCESS | 1703 | RSS: Main: 283258880 18:43:23 INFO - PROCESS | 1703 | 18:43:27 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:27 INFO - PROCESS | 1703 | RSS: Main: 282415104 18:43:27 INFO - PROCESS | 1703 | 18:43:30 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:31 INFO - PROCESS | 1703 | RSS: Main: 282324992 18:43:31 INFO - PROCESS | 1703 | 18:43:33 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 18:43:34 INFO - PROCESS | 1703 | RSS: Main: 282771456 18:43:34 INFO - PROCESS | 1703 | 18:43:36 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:36 INFO - PROCESS | 1703 | RSS: Main: 283684864 18:43:36 INFO - PROCESS | 1703 | 18:43:38 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:39 INFO - PROCESS | 1703 | RSS: Main: 284717056 18:43:39 INFO - PROCESS | 1703 | 18:43:41 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:41 INFO - PROCESS | 1703 | RSS: Main: 284532736 18:43:41 INFO - PROCESS | 1703 | 18:43:44 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:45 INFO - PROCESS | 1703 | RSS: Main: 284332032 18:43:45 INFO - PROCESS | 1703 | 18:43:47 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:43:48 INFO - PROCESS | 1703 | RSS: Main: 284807168 18:43:48 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 18:43:50 INFO - PROCESS | 1703 | RSS: Main: 285216768 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | __start_tp_report 18:43:50 INFO - PROCESS | 1703 | _x_x_mozilla_page_load 18:43:50 INFO - PROCESS | 1703 | _x_x_mozilla_page_load_details 18:43:50 INFO - PROCESS | 1703 | |i|pagename|runs| 18:43:50 INFO - PROCESS | 1703 | |0;ai-astar;116;111;112;116;114;124;114;112;118;113 18:43:50 INFO - PROCESS | 1703 | |1;audio-beat-detection;154;123;146;156;126;143;140;122;167;154 18:43:50 INFO - PROCESS | 1703 | |2;audio-dft;195;201;197;200;208;234;196;200;205;201 18:43:50 INFO - PROCESS | 1703 | |3;audio-fft;63;118;106;57;114;53;75;86;87;142 18:43:50 INFO - PROCESS | 1703 | |4;audio-oscillator;83;82;116;79;83;84;118;81;83;113 18:43:50 INFO - PROCESS | 1703 | |5;imaging-gaussian-blur;86;91;93;141;85;115;133;89;133;142 18:43:50 INFO - PROCESS | 1703 | |6;imaging-darkroom;95;96;96;101;96;95;95;95;95;96 18:43:50 INFO - PROCESS | 1703 | |7;imaging-desaturate;91;82;151;152;92;95;94;92;90;93 18:43:50 INFO - PROCESS | 1703 | |8;json-parse-financial;48;66;87;79;57;50;48;97;45;42 18:43:50 INFO - PROCESS | 1703 | |9;json-stringify-tinderbox;64;67;69;70;64;67;66;66;67;66 18:43:50 INFO - PROCESS | 1703 | |10;stanford-crypto-aes;88;73;104;110;113;113;115;85;88;85 18:43:50 INFO - PROCESS | 1703 | |11;stanford-crypto-ccm;119;127;128;131;125;139;137;115;131;130 18:43:50 INFO - PROCESS | 1703 | |12;stanford-crypto-pbkdf2;145;182;162;146;141;181;162;141;143;160 18:43:50 INFO - PROCESS | 1703 | |13;stanford-crypto-sha256-iterative;68;69;64;67;70;65;66;67;69;66 18:43:50 INFO - PROCESS | 1703 | __end_tp_report 18:43:50 INFO - PROCESS | 1703 | __start_cc_report 18:43:50 INFO - PROCESS | 1703 | _x_x_mozilla_cycle_collect,902 18:43:50 INFO - PROCESS | 1703 | __end_cc_report 18:43:50 INFO - PROCESS | 1703 | __startTimestamp1454035430305__endTimestamp 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | ------- Summary: start ------- 18:43:50 INFO - PROCESS | 1703 | Number of tests: 14 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:3.83 (3.3%) stddev-sans-first:4.04 18:43:50 INFO - PROCESS | 1703 | Values: 116.0 111.0 112.0 116.0 114.0 124.0 114.0 112.0 118.0 113.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.00 stddev:15.40 (10.3%) stddev-sans-first:15.82 18:43:50 INFO - PROCESS | 1703 | Values: 154.0 123.0 146.0 156.0 126.0 143.0 140.0 122.0 167.0 154.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#2] audio-dft Cycles:10 Average:203.70 Median:201.00 stddev:11.35 (5.6%) stddev-sans-first:11.60 18:43:50 INFO - PROCESS | 1703 | Values: 195.0 201.0 197.0 200.0 208.0 234.0 196.0 200.0 205.0 201.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#3] audio-fft Cycles:10 Average:90.10 Median:60.00 stddev:29.36 (48.9%) stddev-sans-first:29.46 18:43:50 INFO - PROCESS | 1703 | Values: 63.0 118.0 106.0 57.0 114.0 53.0 75.0 86.0 87.0 142.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:16.29 (19.8%) stddev-sans-first:16.94 18:43:50 INFO - PROCESS | 1703 | Values: 83.0 82.0 116.0 79.0 83.0 84.0 118.0 81.0 83.0 113.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:85.50 stddev:24.39 (28.5%) stddev-sans-first:24.16 18:43:50 INFO - PROCESS | 1703 | Values: 86.0 91.0 93.0 141.0 85.0 115.0 133.0 89.0 133.0 142.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:95.50 stddev:1.83 (1.9%) stddev-sans-first:1.90 18:43:50 INFO - PROCESS | 1703 | Values: 95.0 96.0 96.0 101.0 96.0 95.0 95.0 95.0 95.0 96.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:92.00 stddev:25.70 (27.9%) stddev-sans-first:26.88 18:43:50 INFO - PROCESS | 1703 | Values: 91.0 82.0 151.0 152.0 92.0 95.0 94.0 92.0 90.0 93.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.50 stddev:19.45 (31.6%) stddev-sans-first:19.97 18:43:50 INFO - PROCESS | 1703 | Values: 48.0 66.0 87.0 79.0 57.0 50.0 48.0 97.0 45.0 42.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:1.90 (2.8%) stddev-sans-first:1.76 18:43:50 INFO - PROCESS | 1703 | Values: 64.0 67.0 69.0 70.0 64.0 67.0 66.0 66.0 67.0 66.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#10] stanford-crypto-aes Cycles:10 Average:97.40 Median:79.00 stddev:15.20 (19.2%) stddev-sans-first:15.73 18:43:50 INFO - PROCESS | 1703 | Values: 88.0 73.0 104.0 110.0 113.0 113.0 115.0 85.0 88.0 85.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:130.50 stddev:7.33 (5.6%) stddev-sans-first:6.98 18:43:50 INFO - PROCESS | 1703 | Values: 119.0 127.0 128.0 131.0 125.0 139.0 137.0 115.0 131.0 130.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:161.00 stddev:15.73 (9.8%) stddev-sans-first:16.15 18:43:50 INFO - PROCESS | 1703 | Values: 145.0 182.0 162.0 146.0 141.0 181.0 162.0 141.0 143.0 160.0 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - PROCESS | 1703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.91 (2.8%) stddev-sans-first:2.00 18:43:50 INFO - PROCESS | 1703 | Values: 68.0 69.0 64.0 67.0 70.0 65.0 66.0 67.0 69.0 66.0 18:43:50 INFO - PROCESS | 1703 | -------- Summary: end -------- 18:43:50 INFO - PROCESS | 1703 | 18:43:50 INFO - TEST-INFO | 1703: exit 0 18:43:51 INFO - TEST-OK | kraken | took 58253ms 18:43:51 INFO - SUITE-END | took 1169s 18:43:51 INFO - Completed test suite (00:19:30) 18:43:51 INFO - Working with test: dromaeo_css 18:43:51 INFO - Generating results file: dromaeo_css 18:43:51 INFO - Working with test: kraken 18:43:51 INFO - Generating results file: kraken 18:43:51 INFO - javascript benchmark 18:43:51 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:43:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 18:43:51 INFO - process_Request line: dromaeo_css 7257.59 graph.html#tests=[[72,1,61]] 18:43:51 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:43:51 INFO - process_Request line: kraken 1531.60 graph.html#tests=[[232,1,61]] 18:43:51 INFO - RETURN: dromaeo_css: 7257.59 18:43:51 INFO - RETURN: kraken: 1531.60 18:43:51 INFO - javascript benchmark 18:43:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3477.009052420059, 3503.667151620596, 3516.3846326892785, 3549.3078849624335, 3560.1277686966696, 4844.20070688336, 5078.669886457377, 5541.722913854302, 5574.665520068798, 5581.9720901395485, 5470.097433923408, 5593.496585307322, 5599.492408611067, 5622.297212848394, 5661.547076233902, 5094.6688465249645, 5108.259302401149, 5139.820106296262, 5190.766415511311, 5207.270982062514, 5141.562967147797, 5190.098400373343, 5220.3996540397775, 5221.817236396727, 5261.736913154327, 4520.638348932078, 5040.042391945555, 5044.319016932704, 5140.151874940649, 5165.070287348276, 5153.2270159476, 5154.278401023859, 5167.224916262553, 5167.6641018333685, 5177.559907407875, 5102.795888164469, 5106.514881086291, 5106.514881086291, 5152.227165925141, 5172.6379153459275, 5240.161574148156, 5366.892662146735, 5429.104197807357, 5521.889562208733, 5539.279893613845, 6138.60099093562, 6139.447449729546, 6146.78486252979, 6147.2930612979635, 6186.412290832409, 5078.695278283315, 5805.693718913253, 5922.822315330547, 6209.720562574695, 6216.595921265149, 5537.58468114889, 5620.718964051781, 5635.1828984797385, 5650.0959846424785, 5724.255846739898, 5115.667481613683, 6215.595986260879, 6253.1245625612455, 6302.275238347557, 6306.180196574416, 4833.32333473314, 6033.5173186145885, 6038.245219347582, 6043.063325184604, 6064.0, 6096.359882212392, 6106.877862442726, 6138.480361557146, 6149.0, 6164.8767024659255, 6034.1853849730605, 6066.090086486974, 6108.1143234230785, 6108.816735497942, 6155.630662160284, 5974.492168165754, 6014.669193194329, 6102.481289090477, 6108.786192483241, 6140.6929653517145, 4678.415198100238, 4785.784639691222, 4789.592884604778, 4793.592544633745, 4824.228123500223, 4247.469066366704, 4257.808398622069, 4303.268444364466, 4303.720258183208, 4312.37470566766, 5590.161475778666, 5665.3201615806365, 5676.0, 5704.857378565569, 5733.483986441241, 6121.361519882508, 6192.659403732748, 6218.19163508741, 6242.968785156136, 6270.968645156836, 5742.28221472316, 5757.222774925415, 5759.395263497357, 5777.653340799566, 5790.652560846278, 4464.241079016575, 4482.125985432809, 5179.430262671103, 5266.236395722599, 5304.38999515053, 6276.246850377893, 6296.842578935563, 6299.338569450233, 6302.936970630235, 6303.369663033844, 5066.265391518283, 6174.104754810617, 6224.035274532454, 6232.376762323732, 6259.280182778856, 6142.805741014558, 6238.157848690369, 6293.433590976834, 6312.842178945563, 6320.5575609706875, 5483.232347471437, 5707.714614269353, 6039.943009973325, 6054.727537260922, 6091.8781624366375, 5134.9486505135965, 6085.543584231289, 6166.599171053867, 6188.2883468399905, 6209.316975132822, 5890.1164825276555, 5940.960331941979, 5949.018411962151, 5951.940480595139, 5964.075568286922, 5728.971355143198, 5958.702064896651, 5965.105234214902, 5967.164596956342, 5970.044792833126, 5586.6871285247125, 5778.797742079175, 5819.447152520504, 5835.241418615553, 5838.912416313674, 5914.645121292736, 5917.260342457193, 5920.555958303058, 5947.286325640951, 5950.19672344228, 5785.537157027512, 5814.186013958134, 5817.243758311392, 5822.0, 5841.474267315962], "unit": "score", "name": "dojo.html", "value": 5558.721865135351}, {"lowerIsBetter": false, "replicates": [498.55877548369705, 512.7335481361039, 524.0331588219733, 590.7459792289317, 596.3857227056134, 38266.80866595667, 38515.0, 38657.80671096644, 38797.030074248156, 38853.22293554127, 38674.41988370177, 39157.60842391575, 39172.21655566887, 39265.80367098167, 39304.213915721666, 9376.249900008, 9513.667021654244, 9562.139407453327, 9592.0, 9613.086756758097, 9424.293178011641, 9657.95171024144, 9661.95169024154, 9671.903280967206, 9704.70885873425, 9679.128878400943, 9679.5644196011, 9684.225261979025, 9702.61189552417, 9731.416115033086, 9594.28042896782, 9649.083337082966, 9658.75853103671, 9679.612815487371, 9691.660791872251, 9578.281628877792, 9679.661211857621, 9723.319367644268, 9733.124018838267, 9738.561764720534, 38857.0, 38935.41596876049, 39185.60814391848, 39289.60710392888, 39340.0, 3223.854926528312, 3350.0954742219465, 3482.9651703482896, 3685.262947410529, 3718.572364178127, 23920.0, 28859.134225973256, 29108.215931928924, 29360.0, 29376.41247175066, 2327.3134425344565, 2761.406297646016, 2763.06055940979, 2838.914832555027, 2977.478941185284, 478193.6090319561, 479417.0, 480312.0, 480991.5950420225, 483659.0, 45004.0, 58477.70761146252, 67567.32432675708, 67634.0, 67693.32306676969, 69377.0, 69682.30317696859, 70811.64594177098, 70843.16627334848, 70957.0, 16039.117848518443, 16196.0, 16208.75686864698, 16210.918945405198, 16234.350625974828, 11947.522099115939, 12034.0, 12069.75860482803, 12142.0, 12154.513819447124, 20699.379018629465, 20949.68575471369, 21112.049957751937, 21349.93250337477, 21373.78626213718, 7528.0, 8354.830323754679, 8690.04409514953, 8863.911360886437, 8869.379143460024, 820.6512232301249, 917.2203626917201, 941.924646028316, 1066.8559744434558, 1084.1760262200626, 31167.220819479695, 32288.677113229038, 32330.0, 32570.674293257238, 32753.378378378093, 998.4209158687944, 1047.8428235764543, 1077.5582011375297, 1090.1605763562013, 1117.5920788911988, 15117.622059448382, 15531.45639902598, 15577.454789082327, 15646.982946108466, 15860.286287117107, 526620.0, 543170.0, 552988.0, 556137.0, 557295.0, 56655.43344566502, 57274.42725572691, 57312.0, 57447.138292925636, 57655.0, 1385.2727318157847, 1395.1489591349268, 1412.8516505766952, 1417.6668482906302, 1529.45704274983, 30584.0, 30694.539581905843, 30748.385032299677, 31201.8439907799, 31355.843220784664, 52123.739381302854, 52232.73883630557, 52452.0, 52519.73740131275, 52531.0, 513756.0, 514087.0, 517113.0, 517257.413712929, 518234.0, 28289.57565636476, 28761.856190718914, 28906.855465722536, 30395.0, 32732.672673273915, 34925.47611785775, 42526.57473425226, 43027.139457211306, 43945.34081988837, 44897.55102448934, 34845.0, 36147.819260903525, 37766.866993990225, 39283.82148535434, 39996.000099997735, 36491.438570178725, 36523.0, 36536.26927461383, 36599.81700091482, 37031.62968370282, 36245.0, 36431.45352819763, 36623.63376366202, 36786.448203277505, 36798.44802328021, 31728.0, 32562.02313930491, 32577.185570359983, 33011.0, 33075.66924330726, 24537.509249815263, 25364.239072827844, 25605.871970640026, 25634.487310254062, 26123.477530449665], "unit": "score", "name": "ext.html", "value": 19851.098782764613}, {"lowerIsBetter": false, "replicates": [358.6861496190833, 362.62106099126413, 365.5996683631424, 369.123332086295, 370.8498058286393, 15200.847991520082, 18113.003784791832, 18882.811171888276, 19509.219631214753, 20260.189592416304, 11309.038731707795, 12293.815592766116, 18355.990420526865, 18419.907900460512, 18430.631387372243, 3934.5081864766903, 4987.526185012427, 5259.0, 5269.473052694738, 5272.8154514592, 4001.399790031504, 5655.3779084300695, 5922.703864806764, 5938.4358485943985, 5948.048312270038, 5388.622796404254, 5454.563634909197, 5800.941990580103, 5806.44838740319, 5864.149698293745, 5193.246979188016, 6260.843478913018, 6271.905921411182, 6289.276733175652, 6318.968405157968, 5639.943600563983, 5652.378238393773, 5655.0386434306265, 5667.1782591524, 5669.546436285087, 13308.467661293536, 13338.666533336647, 22010.459267851096, 23757.88121059401, 24349.513009739705, 2080.199123337526, 2089.341857314956, 2090.153487837428, 2154.536774593454, 2210.723659542557, 9782.0, 9858.654947076819, 10144.0, 11758.764824703543, 14584.854151458456, 1652.1573997261362, 1748.3356324596698, 1772.5391398236552, 1822.2073398071882, 1877.2491003598534, 96815.0, 98241.0, 98677.50661246647, 99129.50435247777, 100029.0, 10929.836052459219, 11127.276727012719, 11178.441077946232, 11200.383978881076, 11242.269252498561, 13319.067665263532, 13411.597652070453, 13427.060105792696, 13435.12671676338, 13449.798253026212, 7776.611169441619, 8126.715564955198, 8233.094359620436, 8265.586720663943, 8301.418900676894, 7830.0, 8305.95847020761, 8340.165983401612, 8360.707375241838, 8398.538080405515, 4014.1369605534364, 4180.205760905479, 4187.371894215831, 4315.719478233905, 4475.440569928759, 1841.843443307307, 1893.3941138835442, 1909.2458478900755, 1921.5196200949763, 1927.681932481125, 832.9730078973366, 843.0473564871778, 876.82901834143, 907.2832462354797, 1007.6171054999201, 7965.721199757981, 17549.94700317985, 18994.71507927382, 19096.80903190978, 19378.70931936022, 420.287612496815, 444.2802659691321, 451.97740112994217, 452.89357001104713, 467.33638233707535, 5452.863678407992, 5781.335146458211, 5852.4440178183, 6061.54538409621, 6138.877222455615, 415843.0, 418560.0, 418567.0, 419421.0, 427598.0, 68439.31560684429, 108646.91353086368, 113972.0, 116801.41599291949, 117537.0, 492.2591499792789, 504.67700671570225, 510.3263691926621, 511.86947328431756, 516.318459633288, 9936.105750482202, 10870.510827012646, 10872.347659140476, 10873.619423320146, 10879.401632910265, 38038.42942355812, 46498.535014649424, 47911.0, 50497.747511263675, 50510.0, 64089.67955160381, 68628.31371686219, 68687.0, 69159.0, 69327.0, 7431.331180193809, 7622.352100071556, 7641.923580764344, 7655.57894315818, 7705.460617756703, 8304.045034821072, 8307.127751585997, 8509.234168924826, 8529.0, 9406.623735050522, 3357.3453176630323, 7413.147488038944, 7461.470398568389, 7512.849743005, 7564.810879727831, 7210.170830354366, 7231.8553628928175, 7576.166621671722, 7647.388208943383, 7666.310032097138, 7780.961095194488, 7784.2215778421705, 7824.92175078242, 7826.0, 7920.366370690215, 10992.0, 11027.61403350879, 11099.05658019045, 11212.103031757602, 11281.830772538582, 10854.728631784268, 10879.401632909949, 10899.618513351994, 11055.944720276348, 11121.221514493907], "unit": "score", "name": "jquery.html", "value": 8008.238676820221}, {"lowerIsBetter": false, "replicates": [1511.8714909232715, 1514.409380341667, 1759.4281858396025, 1896.7060105683624, 1898.6487499812536, 7848.607569621525, 7964.00449943757, 8573.485590864544, 8749.387542871993, 8761.737147885566, 8359.247667709906, 8408.03307619624, 8513.361497887669, 8513.744587662364, 8526.232639062484, 2466.6300054991807, 2496.6379874918125, 2498.900043998238, 2502.874856257189, 2503.2740505253455, 2487.5273697997413, 2530.278870521902, 2536.708278547963, 2540.6697129373156, 2548.3374322676145, 2450.583400821856, 2461.2985299189736, 2497.213377786001, 2503.3866702657874, 2503.4993001399703, 2148.3554933520036, 2455.8649274289905, 2474.7277799442045, 2514.208024472285, 2518.2193520008764, 2508.134693530729, 2538.5938249879932, 2544.4529426173463, 2546.5161619292276, 2556.6804149481313, 8608.913910860874, 8666.56667166639, 8671.653133874637, 8718.084601116854, 8718.389712720113, 5333.2000199969925, 5469.671819690831, 5470.480304371078, 5483.972580137113, 5497.285352904137, 3632.9273414531826, 3669.724770642186, 3709.962900370989, 3747.025773298962, 3761.0597350662333, 884.4383816276711, 891.7324802559207, 1076.2304951959386, 1087.7389426537652, 1090.5637744902024, 11482.368469734161, 11659.883401165964, 11665.066794656406, 11679.416029198592, 11690.707732306675, 4901.240307752304, 4932.950670493321, 4964.205727083649, 4968.950310496849, 4987.675801072919, 8541.572921353907, 8656.874606301266, 9505.287103467268, 9999.100080992746, 10013.749656258651, 5423.918641220384, 5424.728763561806, 5441.918371224435, 5442.619016668875, 5462.535684466785, 4433.556644335606, 4545.863624091283, 4799.0, 4862.756862156878, 4947.851564453073, 3946.4869566956113, 3981.7013723970817, 3992.960070399317, 4027.617376349242, 4031.8387264509092, 1312.4422120598708, 1325.284346452924, 1325.8143859859626, 1332.460353556811, 1338.5783478204335, 1327.0776810116877, 1327.323065236717, 1331.4341404902877, 1361.8774310311921, 1372.5058978767636, 7837.1379148293645, 7865.410094242955, 7919.445638805229, 7986.880196797053, 8003.279704826477, 508.1767536590747, 513.6507175120954, 517.7566543724444, 517.9769954340223, 518.3365292425701, 6130.816075517741, 6132.938670613326, 6151.292601350902, 6182.350853160443, 6202.069689546604, 8528.53093079874, 10092.646757363456, 10229.641962531276, 10370.740731481774, 10381.636642717469, 8414.36892233085, 10126.468382904273, 10137.391756494633, 10224.0, 10318.948405257926, 7889.487183333065, 8236.711715090063, 8243.2581067703, 8257.8348433031, 8304.501729896225, 7230.204677485578, 7243.130824301117, 7748.496347737379, 8014.799630009064, 8034.799130021563, 9033.728988130366, 9317.11487408695, 9341.953290233505, 9403.294752893697, 9455.716328510156, 9222.492762898106, 9494.762630934281, 9515.476648784383, 9522.761930951781, 9596.616135354509, 6817.0, 6985.5808651481075, 7256.2018178001435, 7363.595002274927, 7486.850262994819, 8066.717664881701, 8070.677172913018, 8110.229528194812, 8119.83760324802, 8163.795905102183, 7419.962900185465, 7550.584717840571, 7606.04924384452, 7688.038995125609, 7707.884381734167, 7359.484836061424, 7384.852302954018, 7397.149327827368, 7513.2862378074, 7527.1343795462035, 7519.661615227437, 7576.848463030598, 7600.429967752551, 7652.158262591, 7657.042869641295, 6833.794986150423, 6961.8955715665315, 6976.441884649317, 6993.230744617987, 6993.510454268152, 7035.437165026683, 7078.858422831618, 7102.325279098477, 7109.82225444368, 7110.85778284421], "unit": "score", "name": "mootools.html", "value": 4802.4148459668595}, {"lowerIsBetter": false, "replicates": [331.29930197632007, 332.2358575276864, 335.50177985691226, 341.67370161495774, 344.9582261570057, 6481.157449531566, 6574.474042076635, 6620.073189753432, 6631.436327912121, 6683.832904177392, 6368.840778980528, 6512.772052978146, 6513.869722605545, 6518.967405162979, 6580.736770529173, 4892.266160075981, 4908.901821963558, 4918.926216106761, 4923.55687988081, 4937.802487900498, 4898.8040478381, 4912.70523768575, 4913.287573301887, 4914.0, 4922.8523144305545, 4259.361095835634, 4289.806958686851, 4634.860954171363, 4802.735849528274, 4847.030593881238, 4774.880627984294, 4781.593564547, 4809.206480930642, 4830.2271636538335, 4836.613070954315, 3652.3425783358985, 3970.8610198643196, 3982.0443093657314, 4089.815958281855, 4091.6112969267874, 5266.8683282917855, 6158.076288556707, 6173.104899789505, 6205.875882482325, 6251.812445626639, 5515.586331025149, 5562.0, 5567.638103523258, 5573.721313934287, 5604.99110160171, 6722.260551339349, 6820.420264277543, 6898.413634841045, 6920.688569014406, 6945.166580010431, 4531.207038768202, 4548.658850586219, 4549.818007279705, 4550.68145229834, 4551.135284295973, 5555.833275012253, 6689.531732778707, 7025.227225005246, 7248.057752492142, 7356.742514012038, 4613.354130421743, 4626.699264547794, 4627.838025669153, 4642.883927901829, 4646.117237724821, 4571.634269258451, 4697.647676424282, 4705.270683044065, 4708.717476951394, 4719.457262414866, 5566.0, 5578.944210557924, 5584.162375643686, 5591.133374326986, 5596.468335508121, 6946.235914049451, 6962.895556566656, 6974.407175390149, 6982.441404687613, 6991.685374158175, 1614.8465895739887, 1636.1328495897194, 1637.7379619260862, 1641.7127002774705, 1643.7370020796616, 1020.739711373595, 1063.967951087444, 1069.0, 1073.935563866155, 1073.983890241647, 6667.099941507931, 6669.333066693389, 6685.331466853276, 6691.76578819739, 6714.429273511806, 7252.601106939169, 7266.781996540007, 7280.708771649181, 7305.050343455317, 7372.557646541118, 6461.127747754087, 6658.9001164982565, 6661.333866613397, 6700.698468568926, 6776.15298087739, 3643.307771523455, 3824.7322687411615, 3851.1527463957887, 3854.8650797221962, 3858.594847541024, 7515.286047825448, 7587.355074818703, 7675.731349402856, 7688.846223075507, 7710.0, 7469.626518674045, 7472.925270747223, 7558.735444259424, 7559.0, 7603.505772124794, 7561.09266887966, 7771.611419429006, 7778.277602838961, 7833.138354780969, 7853.528788272722, 7362.079740032496, 7372.299631534996, 7389.224131466333, 7390.889136662847, 7404.740834070782, 7222.09723784527, 7228.7469938554, 7232.89150662751, 7235.529690570096, 7256.346928776436, 7528.661210245443, 7790.961045194737, 7809.3362064225175, 7832.569208693349, 7857.2928436441, 4663.108872499072, 4690.554397332248, 4691.5308469152815, 4704.176769065469, 4708.952910470988, 7069.893951590833, 7288.161861385796, 7309.707611695472, 7310.013148224922, 7320.597367144858, 4853.733044682576, 5943.346231914399, 6782.796516104525, 7065.046218760402, 7079.823004424725, 7028.718851246097, 7040.823979400556, 7060.188078371053, 7062.435005199469, 7063.470239732143, 5627.240322556566, 6689.163854518185, 6887.483438742014, 6917.827054323682, 6929.930700692928, 5670.603057785916, 5679.574031947538, 5683.60214784961, 7031.929680703128, 7069.681864316015, 5438.483344082306, 6750.5274630775375, 6910.0, 6939.132608423947, 6939.167299924042], "unit": "score", "name": "prototype.html", "value": 5100.30816131238}, {"lowerIsBetter": false, "replicates": [640.9006603976384, 655.4592461219494, 681.4173881331465, 690.0442886602058, 727.1528669100495, 14509.564713058598, 14552.272386380691, 14826.703465930688, 14910.627234319147, 14983.250837458138, 13758.793618095737, 13852.445902163927, 13897.583072507816, 13929.233892135928, 13946.302684865766, 693.9201991770935, 708.6669265445232, 849.8045449546609, 852.4927668037508, 866.2420382165606, 865.7402779166256, 872.4329186029069, 874.1564390363299, 874.9168828961239, 876.7808047988003, 900.0684291758032, 902.6479672927563, 905.4612505559214, 905.7463910105181, 907.768519027647, 889.4618755652866, 892.2193081054078, 893.2184338703635, 897.9236764874994, 900.5992333411634, 646.7510008646658, 661.1405173274771, 666.4468491152332, 669.2303850571833, 670.9832254193635, 14361.71276574473, 14498.492552760603, 14576.344064517121, 14592.05151665149, 14647.63380915475, 12437.937810310981, 12473.251604903735, 12523.686907827287, 12561.371931403393, 12620.684482888002, 9986.650467233612, 10006.399616023062, 10350.792984140275, 10371.170306375472, 10749.247552671317, 3349.866005359783, 3510.157562185057, 3558.288342331544, 3571.910702232465, 3700.389435743099, 74684.25315746828, 74812.99999999946, 74954.62522687351, 78788.0, 79311.60344198241, 8719.779230907678, 9271.721848344561, 9343.532823358804, 9560.760980975392, 9649.951750241204, 19057.237710491427, 20800.959952002642, 20848.270310539363, 20858.791412085684, 20871.791282086986, 7405.740799072007, 7420.888686669704, 7463.8507229855095, 7571.924280757122, 7728.4590078693955, 3989.84040638377, 4075.0, 4076.5311989121633, 4088.34586466164, 4099.159672267178, 3516.1033936346066, 3555.6444355564236, 3567.857285708543, 3569.839357228931, 3571.39286321326, 633.499535367064, 647.799182253503, 648.2383199740286, 669.4677731203705, 673.2190658835727, 485.5969545277411, 568.903286441306, 570.5492660798006, 590.8375196820908, 611.9418655227746, 8067.628503154478, 8492.384519350811, 8612.526311052952, 8708.433951793113, 8849.070847561043, 440.41864738544814, 570.2216474512344, 626.9123071470995, 633.3508154141949, 637.7480895046431, 3791.3933770596573, 3970.7419017763755, 4133.297339452301, 4167.666586673059, 4178.603032711888, 77624.0, 79164.0, 79272.60363698144, 79276.6036169827, 86479.13520864837, 70081.0, 72123.6393818038, 77758.0, 77780.444391113, 78963.60518197372, 48316.7584162077, 51799.22301165561, 62649.68675156595, 63348.04977925335, 66925.66537167283, 8012.22508539604, 8119.79700507492, 8346.582670866312, 8693.565321733762, 8887.911120888966, 38203.85388438351, 47698.91938889579, 48944.0, 49367.506324936294, 50359.74820125876, 68821.65589172022, 69195.65402172957, 69403.0, 69984.65007674928, 70506.0, 9110.180083792491, 10694.62568810088, 10912.236143469881, 11047.337159770439, 11822.290662560274, 10726.946365268124, 11899.583514576949, 12022.398880056136, 12024.098192635762, 12560.183588066746, 11716.765664686829, 11750.177487575787, 11858.229215100991, 11933.761324773282, 11967.880321196677, 11673.0, 11696.649100526998, 11727.179097463095, 11886.34625095628, 11951.282923024299, 11283.943580282046, 11332.263402878787, 11414.94292528532, 11479.8278025828, 11730.002949749367, 7876.414056706451, 8431.29951078989, 9187.540622968958, 9437.103475169848, 9511.143997040299, 9904.950475247577, 9942.30403871722, 10030.191546367028, 10067.53831069623, 10117.291789574954], "unit": "score", "name": "yui.html", "value": 6750.987329606269}], "name": "dromaeo_css", "value": 7257.591133349039}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 112.0, 116.0, 114.0, 124.0, 114.0, 112.0, 118.0, 113.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 146.0, 156.0, 126.0, 143.0, 140.0, 122.0, 167.0, 154.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [195.0, 201.0, 197.0, 200.0, 208.0, 234.0, 196.0, 200.0, 205.0, 201.0], "unit": "score", "name": "audio-dft", "value": 203.7}, {"lowerIsBetter": true, "replicates": [63.0, 118.0, 106.0, 57.0, 114.0, 53.0, 75.0, 86.0, 87.0, 142.0], "unit": "score", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 116.0, 79.0, 83.0, 84.0, 118.0, 81.0, 83.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 93.0, 141.0, 85.0, 115.0, 133.0, 89.0, 133.0, 142.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 101.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 96.0}, {"lowerIsBetter": true, "replicates": [91.0, 82.0, 151.0, 152.0, 92.0, 95.0, 94.0, 92.0, 90.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 103.2}, {"lowerIsBetter": true, "replicates": [48.0, 66.0, 87.0, 79.0, 57.0, 50.0, 48.0, 97.0, 45.0, 42.0], "unit": "score", "name": "json-parse-financial", "value": 61.9}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 69.0, 70.0, 64.0, 67.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [88.0, 73.0, 104.0, 110.0, 113.0, 113.0, 115.0, 85.0, 88.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 97.4}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 128.0, 131.0, 125.0, 139.0, 137.0, 115.0, 131.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [145.0, 182.0, 162.0, 146.0, 141.0, 181.0, 162.0, 141.0, 143.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 156.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 64.0, 67.0, 70.0, 65.0, 66.0, 67.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1531.6}]} 18:43:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1531.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7257.59"}}} 18:43:52 INFO - Return code: 0 18:43:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:43:52 INFO - # TBPL SUCCESS # 18:43:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:43:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:43:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:43:52 INFO - 2016-01-28 18:43:52.092 screenresolution[1708:11345] starting screenresolution argv=screenresolution get 18:43:52 INFO - 2016-01-28 18:43:52.095 screenresolution[1708:11345] Display 0: 1600x1200x32@60 18:43:52 INFO - 2016-01-28 18:43:52.101 screenresolution[1709:11348] starting screenresolution argv=screenresolution list 18:43:52 INFO - Available Modes on Display 0 18:43:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:43:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:43:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:43:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:43:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:43:52 INFO - Intel Iris: 18:43:52 INFO - Chipset Model: Intel Iris 18:43:52 INFO - Type: GPU 18:43:52 INFO - Bus: Built-In 18:43:52 INFO - VRAM (Dynamic, Max): 1536 MB 18:43:52 INFO - Vendor: Intel (0x8086) 18:43:52 INFO - Device ID: 0x0a2e 18:43:52 INFO - Revision ID: 0x0009 18:43:52 INFO - Displays: 18:43:52 INFO - Display: 18:43:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:43:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:43:52 INFO - Display Serial Number: 1600x1200 60 18:43:52 INFO - Main Display: Yes 18:43:52 INFO - Mirror: Off 18:43:52 INFO - Online: Yes 18:43:52 INFO - Rotation: Supported 18:43:52 INFO - Return code: 0 18:43:52 INFO - Running post-action listener: _resource_record_post_action 18:43:52 INFO - Running post-run listener: _resource_record_post_run 18:43:53 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33975808; Write bytes: 712187392; Read time: 361; Write time: 1928 18:43:53 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397386240; Write bytes: 392160768; Read time: 29915; Write time: 692 18:43:53 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32148992; Write bytes: 304568320; Read time: 342; Write time: 1197 18:43:53 INFO - Running post-run listener: _upload_blobber_files 18:43:53 INFO - Blob upload gear active. 18:43:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:43:53 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 18:43:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:43:53 INFO - (blobuploader) - INFO - Open directory for files ... 18:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:43:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:54 INFO - (blobuploader) - INFO - Done attempting. 18:43:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:43:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:43:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:43:55 INFO - (blobuploader) - INFO - Done attempting. 18:43:55 INFO - (blobuploader) - INFO - Iteration through files over. 18:43:55 INFO - Return code: 0 18:43:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:43:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:43:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26649ce3341598301a91c270f21d0965c1934d350d492627e2af7e474e6b1b9885747a8743a1f09e3007afa3c2e614abed18ec8c7bd4ffdd301be6f1b78de9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5440fe3385e3336e9e7e6885b6ed7c55a95f4e29e287100916562d02259c49160db18921dfd5ed0d6a00c9c797a4e8d12a475285232cb1f3faefeb56ee9e7cb3"} 18:43:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:43:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:43:55 INFO - Contents: 18:43:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26649ce3341598301a91c270f21d0965c1934d350d492627e2af7e474e6b1b9885747a8743a1f09e3007afa3c2e614abed18ec8c7bd4ffdd301be6f1b78de9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5440fe3385e3336e9e7e6885b6ed7c55a95f4e29e287100916562d02259c49160db18921dfd5ed0d6a00c9c797a4e8d12a475285232cb1f3faefeb56ee9e7cb3"} 18:43:55 INFO - Running post-run listener: copy_logs_to_upload_dir 18:43:55 INFO - Copying logs to upload dir... 18:43:55 INFO - mkdir: /builds/slave/test/build/upload/logs 18:43:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.007080 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-01-28 18:43:55.821527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 18:43:55.824871) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26649ce3341598301a91c270f21d0965c1934d350d492627e2af7e474e6b1b9885747a8743a1f09e3007afa3c2e614abed18ec8c7bd4ffdd301be6f1b78de9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5440fe3385e3336e9e7e6885b6ed7c55a95f4e29e287100916562d02259c49160db18921dfd5ed0d6a00c9c797a4e8d12a475285232cb1f3faefeb56ee9e7cb3"} build_url:https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010781 build_url: 'https://queue.taskcluster.net/v1/task/MkIG08FdToGjvl42_DduVA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f26649ce3341598301a91c270f21d0965c1934d350d492627e2af7e474e6b1b9885747a8743a1f09e3007afa3c2e614abed18ec8c7bd4ffdd301be6f1b78de9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5440fe3385e3336e9e7e6885b6ed7c55a95f4e29e287100916562d02259c49160db18921dfd5ed0d6a00c9c797a4e8d12a475285232cb1f3faefeb56ee9e7cb3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 18:43:55.853495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:43:55.854080) ========= 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.2RDjjLiT2N/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.JSpIVSxi3o/Listeners TMPDIR=/var/folders/_w/5sv6_fds1bq91k_r0pg26gd800000w/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.005324 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 18:43:55.904243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 18:43:55.904583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 18:43:55.904999) ========= ========= Total master_lag: 0.35 =========