builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0189 starttime: 1456025743.02 results: success (0) buildid: 20160220174513 builduid: 775c49871212478383543668ea5297b9 revision: af6356a3e8c56036b74ba097395356d9c6e6c5a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:43.022485) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:43.025297) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:43.025618) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005944 basedir: '/builds/slave/test' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:43.201199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:43.201508) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:45.582917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:45.583223) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005928 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:45.658148) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:45.658406) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:45.658751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:45.659041) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-20 19:35:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.4M=0.001s 2016-02-20 19:35:46 (16.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.666372 ========= master_lag: 1.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:47.769155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:47.769425) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.025523 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:47.902145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:47.902448) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev af6356a3e8c56036b74ba097395356d9c6e6c5a3 --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 af6356a3e8c56036b74ba097395356d9c6e6c5a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-20 19:35:47,983 truncating revision to first 12 chars 2016-02-20 19:35:47,983 Setting DEBUG logging. 2016-02-20 19:35:47,983 attempt 1/10 2016-02-20 19:35:47,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/af6356a3e8c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-20 19:35:49,183 unpacking tar archive at: mozilla-central-af6356a3e8c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452891 ========= master_lag: 0.71 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-20 19:35:50.063233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:50.063573) ========= echo af6356a3e8c56036b74ba097395356d9c6e6c5a3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af6356a3e8c56036b74ba097395356d9c6e6c5a3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 af6356a3e8c56036b74ba097395356d9c6e6c5a3 program finished with exit code 0 elapsedTime=0.006171 script_repo_revision: 'af6356a3e8c56036b74ba097395356d9c6e6c5a3' ========= master_lag: 0.20 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:50.268264) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:50.268583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-20 19:35:50.690956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-20 19:35:50.691290) ========= /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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:35:50 INFO - MultiFileLogger online at 20160220 19:35:50 in /builds/slave/test 19:35:50 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 19:35:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:35:50 INFO - {'append_to_log': False, 19:35:50 INFO - 'base_work_dir': '/builds/slave/test', 19:35:50 INFO - 'blob_upload_branch': 'Firefox', 19:35:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:35:50 INFO - 'branch': 'Firefox', 19:35:50 INFO - 'buildbot_json_path': 'buildprops.json', 19:35:50 INFO - 'config_files': ('talos/mac_config.py',), 19:35:50 INFO - 'default_actions': ('clobber', 19:35:50 INFO - 'read-buildbot-config', 19:35:50 INFO - 'download-and-extract', 19:35:50 INFO - 'populate-webroot', 19:35:50 INFO - 'create-virtualenv', 19:35:50 INFO - 'install', 19:35:50 INFO - 'run-tests'), 19:35:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:35:50 INFO - 'download_minidump_stackwalk': True, 19:35:50 INFO - 'download_symbols': 'ondemand', 19:35:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:35:50 INFO - 'tooltool.py': '/tools/tooltool.py', 19:35:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:35:50 INFO - '/tools/misc-python/virtualenv.py')}, 19:35:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:35:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:35:50 INFO - 'installer_path': 'installer.exe', 19:35:50 INFO - 'log_level': 'info', 19:35:50 INFO - 'log_name': 'talos', 19:35:50 INFO - 'log_to_console': True, 19:35:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:35:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:35:50 INFO - 'opt_config_files': (), 19:35:50 INFO - 'pip_index': False, 19:35:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:50 INFO - 'cmd': ('bash', 19:35:50 INFO - '-c', 19:35:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:50 INFO - 'enabled': True, 19:35:50 INFO - 'halt_on_failure': False, 19:35:50 INFO - 'name': 'check_screen_resolution'},), 19:35:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:35:50 INFO - 'cmd': ('bash', 19:35:50 INFO - '-c', 19:35:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:35:50 INFO - 'enabled': True, 19:35:50 INFO - 'halt_on_failure': False, 19:35:50 INFO - 'name': 'check_screen_resolution'},), 19:35:50 INFO - 'run_cmd_checks_enabled': True, 19:35:50 INFO - 'sps_profile': False, 19:35:50 INFO - 'sps_profile_interval': 0, 19:35:50 INFO - 'suite': 'dromaeojs-e10s', 19:35:50 INFO - 'system_bits': '32', 19:35:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:35:50 INFO - 'title': 't-yosemite-r7-0189', 19:35:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:35:50 INFO - 'use_talos_json': True, 19:35:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:35:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:35:50 INFO - 'work_dir': 'build'} 19:35:50 INFO - ##### 19:35:50 INFO - ##### Running clobber step. 19:35:50 INFO - ##### 19:35:50 INFO - Running pre-action listener: _resource_record_pre_action 19:35:50 INFO - Running main action method: clobber 19:35:50 INFO - rmtree: /builds/slave/test/build 19:35:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:35:52 INFO - Running post-action listener: _resource_record_post_action 19:35:52 INFO - ##### 19:35:52 INFO - ##### Running read-buildbot-config step. 19:35:52 INFO - ##### 19:35:52 INFO - Running pre-action listener: _resource_record_pre_action 19:35:52 INFO - Running main action method: read_buildbot_config 19:35:52 INFO - Using buildbot properties: 19:35:52 INFO - { 19:35:52 INFO - "project": "", 19:35:52 INFO - "product": "firefox", 19:35:52 INFO - "script_repo_revision": "production", 19:35:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:35:52 INFO - "repository": "", 19:35:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:35:52 INFO - "buildid": "20160220174513", 19:35:52 INFO - "pgo_build": "False", 19:35:52 INFO - "basedir": "/builds/slave/test", 19:35:52 INFO - "buildnumber": 176, 19:35:52 INFO - "slavename": "t-yosemite-r7-0189", 19:35:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:35:52 INFO - "platform": "yosemite_r7", 19:35:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:35:52 INFO - "branch": "mozilla-central", 19:35:52 INFO - "repo_path": "mozilla-central", 19:35:52 INFO - "revision": "af6356a3e8c56036b74ba097395356d9c6e6c5a3", 19:35:52 INFO - "stage_platform": "macosx64", 19:35:52 INFO - "builduid": "775c49871212478383543668ea5297b9", 19:35:52 INFO - "slavebuilddir": "test" 19:35:52 INFO - } 19:35:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:35:52 INFO - Running post-action listener: _resource_record_post_action 19:35:52 INFO - ##### 19:35:52 INFO - ##### Running download-and-extract step. 19:35:52 INFO - ##### 19:35:52 INFO - Running pre-action listener: _resource_record_pre_action 19:35:52 INFO - Running main action method: download_and_extract 19:35:52 INFO - mkdir: /builds/slave/test/build/tests 19:35:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:35:52 INFO - https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:35:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/test_packages.json 19:35:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/test_packages.json 19:35:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:35:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:36:16 INFO - Downloaded 1277 bytes. 19:36:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:36:16 INFO - Using the following test package requirements: 19:36:16 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:36:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:36:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'jsshell-mac.zip'], 19:36:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:36:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:36:16 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:36:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:36:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:16 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:36:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:16 INFO - https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:19 INFO - Downloaded 17825227 bytes. 19:36:19 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'] 19:36:19 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 19:36:22 INFO - Return code: 0 19:36:22 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 19:36: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')]} 19:36:22 INFO - https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:25 INFO - Downloaded 17825227 bytes. 19:36:25 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'] 19:36:25 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 19:36:29 INFO - Return code: 0 19:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:29 INFO - https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:36:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:36:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:36:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:29 INFO - Downloaded 10707015 bytes. 19:36:29 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'] 19:36:29 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 19:36:30 INFO - Return code: 0 19:36:30 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')]} 19:36:30 INFO - https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:36:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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 19:36:39 INFO - Downloaded 111299992 bytes. 19:36:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:39 INFO - mkdir: /builds/slave/test/properties 19:36:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:39 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:39 INFO - Contents: 19:36:39 INFO - build_url:https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:40 INFO - Running post-action listener: _resource_record_post_action 19:36:40 INFO - Running post-action listener: set_extra_try_arguments 19:36:40 INFO - ##### 19:36:40 INFO - ##### Running populate-webroot step. 19:36:40 INFO - ##### 19:36:40 INFO - Running pre-action listener: _resource_record_pre_action 19:36:40 INFO - Running main action method: populate_webroot 19:36:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:40 INFO - '--tppagecycles', 19:36:40 INFO - '7'], 19:36:40 INFO - 'tests': ['tsvgm']}}, 19:36:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:36:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'tests': ['damp', 'tps']}, 19:36:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['damp', 'tps']}, 19:36:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:40 INFO - 'other': {'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'other_l64': {'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:40 INFO - 'ts_paint', 19:36:40 INFO - 'tpaint', 19:36:40 INFO - 'sessionrestore', 19:36:40 INFO - 'sessionrestore_no_auto_restore']}, 19:36:40 INFO - 'svgr': {'tests': ['tsvgx', 19:36:40 INFO - 'tsvgr_opacity', 19:36:40 INFO - 'tart', 19:36:40 INFO - 'tscrollx', 19:36:40 INFO - 'cart']}, 19:36:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['tsvgx', 19:36:40 INFO - 'tsvgr_opacity', 19:36:40 INFO - 'tart', 19:36:40 INFO - 'tscrollx', 19:36:40 INFO - 'cart']}, 19:36:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'tests': ['tp5o']}, 19:36:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'talos_options': ['--e10s'], 19:36:40 INFO - 'tests': ['tp5o']}, 19:36:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'talos_options': ['--xperf_path', 19:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:40 INFO - 'tests': ['tp5n']}, 19:36:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:40 INFO - 'talos_options': ['--e10s', 19:36:40 INFO - '--xperf_path', 19:36:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:40 INFO - 'tests': ['tp5n']}}, 19:36:40 INFO - 'talos.zip': {'path': '', 19:36:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:40 INFO - Running post-action listener: _resource_record_post_action 19:36:40 INFO - ##### 19:36:40 INFO - ##### Running create-virtualenv step. 19:36:40 INFO - ##### 19:36:40 INFO - Running pre-action listener: _resource_record_pre_action 19:36:40 INFO - Running main action method: create_virtualenv 19:36:40 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:40 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 19:36:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:40 INFO - Using real prefix '/tools/python27' 19:36:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:41 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:44 INFO - Installing pip.................done. 19:36:44 INFO - Return code: 0 19:36:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:44 INFO - 'HOME': '/Users/cltbld', 19:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PAGER': '/bin/cat', 19:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test', 19:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:36:44 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - 'XPC_FLAGS': '0x0', 19:36:44 INFO - 'XPC_SERVICE_NAME': '0', 19:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 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 19:36:44 INFO - Cleaning up... 19:36:44 INFO - Return code: 0 19:36:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:44 INFO - 'HOME': '/Users/cltbld', 19:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PAGER': '/bin/cat', 19:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test', 19:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:36:44 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - 'XPC_FLAGS': '0x0', 19:36:44 INFO - 'XPC_SERVICE_NAME': '0', 19:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Downloading/unpacking psutil>=0.7.1 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:47 INFO - Installing collected packages: psutil 19:36:47 INFO - Running setup.py install for psutil 19:36:47 INFO - building 'psutil._psutil_osx' extension 19:36:47 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 19:36:48 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 19:36:48 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 19:36:48 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 19:36:48 INFO - building 'psutil._psutil_posix' extension 19:36:48 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 19:36:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:36:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:36:48 INFO - ^ 19:36:48 INFO - 1 warning generated. 19:36:48 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 19:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:48 INFO - Successfully installed psutil 19:36:48 INFO - Cleaning up... 19:36:48 INFO - Return code: 0 19:36:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:48 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:36:48 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 19:36:48 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 19:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:49 INFO - 'HOME': '/Users/cltbld', 19:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:49 INFO - 'LOGNAME': 'cltbld', 19:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:49 INFO - 'MOZ_NO_REMOTE': '1', 19:36:49 INFO - 'NO_EM_RESTART': '1', 19:36:49 INFO - 'PAGER': '/bin/cat', 19:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:49 INFO - 'PWD': '/builds/slave/test', 19:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:49 INFO - 'SHELL': '/bin/bash', 19:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:36:49 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:49 INFO - 'USER': 'cltbld', 19:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:49 INFO - 'XPC_FLAGS': '0x0', 19:36:49 INFO - 'XPC_SERVICE_NAME': '0', 19:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:36:49 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 19:36:49 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 19:36:49 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 19:36:49 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 19:36:49 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 19:36:49 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 19:36:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:36:51 INFO - Installing collected packages: mozsystemmonitor 19:36:51 INFO - Running setup.py install for mozsystemmonitor 19:36:51 INFO - Successfully installed mozsystemmonitor 19:36:51 INFO - Cleaning up... 19:36:51 INFO - Return code: 0 19:36:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36:51 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')]} 19:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:51 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')]} 19:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:51 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:36:51 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 19:36:51 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 19:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:51 INFO - 'HOME': '/Users/cltbld', 19:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:51 INFO - 'LOGNAME': 'cltbld', 19:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:51 INFO - 'MOZ_NO_REMOTE': '1', 19:36:51 INFO - 'NO_EM_RESTART': '1', 19:36:51 INFO - 'PAGER': '/bin/cat', 19:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:51 INFO - 'PWD': '/builds/slave/test', 19:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:51 INFO - 'SHELL': '/bin/bash', 19:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:36:51 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:51 INFO - 'USER': 'cltbld', 19:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:51 INFO - 'XPC_FLAGS': '0x0', 19:36:51 INFO - 'XPC_SERVICE_NAME': '0', 19:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:36:52 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 19:36:52 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 19:36:52 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 19:36:52 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 19:36:52 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 19:36:52 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 19:36:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36:55 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 19:36:55 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 19:36:55 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 19:36:55 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 19:36:55 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 19:36:55 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 19:36:55 INFO - Downloading docopt-0.6.1.tar.gz 19:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:56 INFO - Running setup.py install for blobuploader 19:36:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:56 INFO - Running setup.py install for requests 19:36:56 INFO - Running setup.py install for docopt 19:36:56 INFO - Successfully installed blobuploader requests docopt 19:36:56 INFO - Cleaning up... 19:36:56 INFO - Return code: 0 19:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:57 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:36:57 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 19:36:57 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 19:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:57 INFO - 'HOME': '/Users/cltbld', 19:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:57 INFO - 'LOGNAME': 'cltbld', 19:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:57 INFO - 'MOZ_NO_REMOTE': '1', 19:36:57 INFO - 'NO_EM_RESTART': '1', 19:36:57 INFO - 'PAGER': '/bin/cat', 19:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:57 INFO - 'PWD': '/builds/slave/test', 19:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:57 INFO - 'SHELL': '/bin/bash', 19:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:36:57 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:57 INFO - 'USER': 'cltbld', 19:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:57 INFO - 'XPC_FLAGS': '0x0', 19:36:57 INFO - 'XPC_SERVICE_NAME': '0', 19:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:57 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-x6D_xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:57 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-fe_8Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:57 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-z9CWOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:57 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-r1qFUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:57 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-pjqVmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-ACMtoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-4iqORW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-WRJkIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-E3BNKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-bmWwPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-_Nw5hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-g_3yN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-rnoXoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:58 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-J9zTKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:59 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-2CVDU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:59 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-evG2zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:59 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-suMDwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:59 INFO - Running setup.py install for manifestparser 19:36:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:59 INFO - Running setup.py install for mozcrash 19:36:59 INFO - Running setup.py install for mozdebug 19:36:59 INFO - Running setup.py install for mozdevice 19:36:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:59 INFO - Running setup.py install for mozfile 19:37:00 INFO - Running setup.py install for mozhttpd 19:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Running setup.py install for mozinfo 19:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Running setup.py install for mozInstall 19:37:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Running setup.py install for mozleak 19:37:00 INFO - Running setup.py install for mozlog 19:37:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Running setup.py install for moznetwork 19:37:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:37:00 INFO - Running setup.py install for mozprocess 19:37:01 INFO - Running setup.py install for mozprofile 19:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:37:01 INFO - Running setup.py install for mozrunner 19:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:37:01 INFO - Running setup.py install for mozscreenshot 19:37:01 INFO - Running setup.py install for moztest 19:37:01 INFO - Running setup.py install for mozversion 19:37:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:37:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:37:01 INFO - Cleaning up... 19:37:01 INFO - Return code: 0 19:37:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:01 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:37:01 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 19:37:01 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 19:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:01 INFO - 'HOME': '/Users/cltbld', 19:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:01 INFO - 'LOGNAME': 'cltbld', 19:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:01 INFO - 'MOZ_NO_REMOTE': '1', 19:37:01 INFO - 'NO_EM_RESTART': '1', 19:37:01 INFO - 'PAGER': '/bin/cat', 19:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:01 INFO - 'PWD': '/builds/slave/test', 19:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:01 INFO - 'SHELL': '/bin/bash', 19:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:37:01 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:01 INFO - 'USER': 'cltbld', 19:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:01 INFO - 'XPC_FLAGS': '0x0', 19:37:01 INFO - 'XPC_SERVICE_NAME': '0', 19:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-NXvoGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-4VCinH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-bQvpTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-6EcdbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-uCcUVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-DkE5Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-RE9aqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:02 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)) 19:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:02 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-TmhRsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-tBUc8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-BZhOP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-YX91JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-6tgpjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-rqz4PH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-vK6g14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-I1CvUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-EzoOge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:03 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)) 19:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:03 INFO - Running setup.py (path:/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/pip-H8cYbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:03 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)) 19:37:03 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)) 19:37:03 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)) 19:37:03 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)) 19:37:03 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)) 19:37:03 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)) 19:37:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:37:03 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 19:37:03 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 19:37:03 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 19:37:03 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 19:37:03 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 19:37:03 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 19:37:06 INFO - Downloading blessings-1.6.tar.gz 19:37:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:37:06 INFO - Installing collected packages: blessings 19:37:06 INFO - Running setup.py install for blessings 19:37:06 INFO - Successfully installed blessings 19:37:06 INFO - Cleaning up... 19:37:06 INFO - Return code: 0 19:37:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:06 INFO - Reading from file tmpfile_stdout 19:37:06 INFO - Current package versions: 19:37:06 INFO - blessings == 1.6 19:37:06 INFO - blobuploader == 1.2.4 19:37:06 INFO - docopt == 0.6.1 19:37:06 INFO - manifestparser == 1.1 19:37:06 INFO - mozInstall == 1.12 19:37:06 INFO - mozcrash == 0.16 19:37:06 INFO - mozdebug == 0.1 19:37:06 INFO - mozdevice == 0.48 19:37:06 INFO - mozfile == 1.2 19:37:06 INFO - mozhttpd == 0.7 19:37:06 INFO - mozinfo == 0.9 19:37:06 INFO - mozleak == 0.1 19:37:06 INFO - mozlog == 3.1 19:37:06 INFO - moznetwork == 0.27 19:37:06 INFO - mozprocess == 0.22 19:37:06 INFO - mozprofile == 0.28 19:37:06 INFO - mozrunner == 6.11 19:37:06 INFO - mozscreenshot == 0.1 19:37:06 INFO - mozsystemmonitor == 0.0 19:37:06 INFO - moztest == 0.7 19:37:06 INFO - mozversion == 1.4 19:37:06 INFO - psutil == 3.1.1 19:37:06 INFO - requests == 1.2.3 19:37:06 INFO - wsgiref == 0.1.2 19:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:06 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:37:06 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 19:37:06 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 19:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:06 INFO - 'HOME': '/Users/cltbld', 19:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:06 INFO - 'LOGNAME': 'cltbld', 19:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:06 INFO - 'MOZ_NO_REMOTE': '1', 19:37:06 INFO - 'NO_EM_RESTART': '1', 19:37:06 INFO - 'PAGER': '/bin/cat', 19:37:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:06 INFO - 'PWD': '/builds/slave/test', 19:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:06 INFO - 'SHELL': '/bin/bash', 19:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:37:06 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:06 INFO - 'USER': 'cltbld', 19:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:06 INFO - 'XPC_FLAGS': '0x0', 19:37:06 INFO - 'XPC_SERVICE_NAME': '0', 19:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 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)) 19:37:07 INFO - Cleaning up... 19:37:07 INFO - Return code: 0 19:37:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:37: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')]} 19:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37: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')]} 19:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:07 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 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:37:07 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 19:37:07 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 19:37:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:37:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:07 INFO - 'HOME': '/Users/cltbld', 19:37:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:07 INFO - 'LOGNAME': 'cltbld', 19:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:07 INFO - 'MOZ_NO_REMOTE': '1', 19:37:07 INFO - 'NO_EM_RESTART': '1', 19:37:07 INFO - 'PAGER': '/bin/cat', 19:37:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:07 INFO - 'PWD': '/builds/slave/test', 19:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:07 INFO - 'SHELL': '/bin/bash', 19:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:37:07 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:07 INFO - 'USER': 'cltbld', 19:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:07 INFO - 'XPC_FLAGS': '0x0', 19:37:07 INFO - 'XPC_SERVICE_NAME': '0', 19:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:07 INFO - Downloading/unpacking jsonschema 19:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:37:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:37:09 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 19:37:09 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 19:37:09 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 19:37:09 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 19:37:09 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 19:37:09 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 19:37:10 INFO - Downloading functools32-3.2.3-2.tar.gz 19:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:37:10 INFO - warning: no files found matching '*.txt' 19:37:10 INFO - no previously-included directories found matching 'build' 19:37:10 INFO - no previously-included directories found matching 'dist' 19:37:10 INFO - no previously-included directories found matching '.git*' 19:37:10 INFO - Installing collected packages: jsonschema, functools32 19:37:10 INFO - Running setup.py install for functools32 19:37:10 INFO - warning: no files found matching '*.txt' 19:37:10 INFO - no previously-included directories found matching 'build' 19:37:10 INFO - no previously-included directories found matching 'dist' 19:37:10 INFO - no previously-included directories found matching '.git*' 19:37:10 INFO - Successfully installed jsonschema functools32 19:37:10 INFO - Cleaning up... 19:37:10 INFO - Return code: 0 19:37:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1041bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041c44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864b47d1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, '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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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 19:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:10 INFO - 'HOME': '/Users/cltbld', 19:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:10 INFO - 'LOGNAME': 'cltbld', 19:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:10 INFO - 'MOZ_NO_REMOTE': '1', 19:37:10 INFO - 'NO_EM_RESTART': '1', 19:37:10 INFO - 'PAGER': '/bin/cat', 19:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:10 INFO - 'PWD': '/builds/slave/test', 19:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:10 INFO - 'SHELL': '/bin/bash', 19:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:37:10 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:10 INFO - 'USER': 'cltbld', 19:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:10 INFO - 'XPC_FLAGS': '0x0', 19:37:10 INFO - 'XPC_SERVICE_NAME': '0', 19:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:10 INFO - Downloading/unpacking flake8 19:37:10 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 19:37:10 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 19:37:10 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 19:37:10 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 19:37:10 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 19:37:10 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 19:37:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:37:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:37:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:37:14 INFO - no previously-included directories found matching 'docs/_build' 19:37:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:37:14 INFO - Running setup.py install for pep8 19:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:37:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:37:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:37:14 INFO - no previously-included directories found matching 'docs/_build' 19:37:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:37:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:37:14 INFO - Cleaning up... 19:37:14 INFO - Return code: 0 19:37:14 INFO - Running post-action listener: _resource_record_post_action 19:37:14 INFO - Running post-action listener: _start_resource_monitoring 19:37:14 INFO - Starting resource monitoring. 19:37:14 INFO - ##### 19:37:14 INFO - ##### Running install step. 19:37:14 INFO - ##### 19:37:14 INFO - Running pre-action listener: _resource_record_pre_action 19:37:14 INFO - Running main action method: install 19:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:37:14 INFO - Reading from file tmpfile_stdout 19:37:14 INFO - Detecting whether we're running mozinstall >=1.0... 19:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:37:15 INFO - Reading from file tmpfile_stdout 19:37:15 INFO - Output received: 19:37:15 INFO - Usage: mozinstall [options] installer 19:37:15 INFO - Options: 19:37:15 INFO - -h, --help show this help message and exit 19:37:15 INFO - -d DEST, --destination=DEST 19:37:15 INFO - Directory to install application into. [default: 19:37:15 INFO - "/builds/slave/test"] 19:37:15 INFO - --app=APP Application being installed. [default: firefox] 19:37:15 INFO - mkdir: /builds/slave/test/build/application 19:37:15 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'] 19:37:15 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 19:37:48 INFO - Reading from file tmpfile_stdout 19:37:48 INFO - Output received: 19:37:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:37:48 INFO - Running post-action listener: _resource_record_post_action 19:37:48 INFO - ##### 19:37:48 INFO - ##### Running run-tests step. 19:37:48 INFO - ##### 19:37:48 INFO - Running pre-action listener: _resource_record_pre_action 19:37:48 INFO - Running main action method: run_tests 19:37:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:48 INFO - 2016-02-20 19:37:48.972 screenresolution[1672:16826] starting screenresolution argv=screenresolution get 19:37:48 INFO - 2016-02-20 19:37:48.975 screenresolution[1672:16826] Display 0: 1600x1200x32@60 19:37:48 INFO - 2016-02-20 19:37:48.981 screenresolution[1673:16828] starting screenresolution argv=screenresolution list 19:37:48 INFO - Available Modes on Display 0 19:37:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:49 INFO - Intel Iris: 19:37:49 INFO - Chipset Model: Intel Iris 19:37:49 INFO - Type: GPU 19:37:49 INFO - Bus: Built-In 19:37:49 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:49 INFO - Vendor: Intel (0x8086) 19:37:49 INFO - Device ID: 0x0a2e 19:37:49 INFO - Revision ID: 0x0009 19:37:49 INFO - Displays: 19:37:49 INFO - Display: 19:37:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:49 INFO - Display Serial Number: 1600x1200 60 19:37:49 INFO - Main Display: Yes 19:37:49 INFO - Mirror: Off 19:37:49 INFO - Online: Yes 19:37:49 INFO - Rotation: Supported 19:37:49 INFO - Return code: 0 19:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:49 INFO - Python 2.7.3 19:37:49 INFO - Return code: 0 19:37:49 INFO - grabbing minidump binary from tooltool 19:37:49 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')]} 19:37:49 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 0x104061d30>, '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 0x103e85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104058b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:49 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 19:37:49 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 19:37:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:49 INFO - Return code: 0 19:37:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:37:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:37:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:37:50 INFO - Return code: 0 19:37:50 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/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 19:37:50 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/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --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 19:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b90OHcXDXT/Render', 19:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:50 INFO - 'HOME': '/Users/cltbld', 19:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:50 INFO - 'LOGNAME': 'cltbld', 19:37:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:50 INFO - 'MOZ_NO_REMOTE': '1', 19:37:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:50 INFO - 'NO_EM_RESTART': '1', 19:37:50 INFO - 'PAGER': '/bin/cat', 19:37:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:50 INFO - 'PWD': '/builds/slave/test', 19:37:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:50 INFO - 'SHELL': '/bin/bash', 19:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4ZIVBeRZgs/Listeners', 19:37:50 INFO - 'TMPDIR': '/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/', 19:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:50 INFO - 'USER': 'cltbld', 19:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:50 INFO - 'XPC_FLAGS': '0x0', 19:37:50 INFO - 'XPC_SERVICE_NAME': '0', 19:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:50 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/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 19:37:50 INFO - mozversion application_buildid: 20160220174513 19:37:50 INFO - mozversion application_changeset: af6356a3e8c56036b74ba097395356d9c6e6c5a3 19:37:50 INFO - mozversion application_display_name: Nightly 19:37:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:50 INFO - mozversion application_name: Firefox 19:37:50 INFO - mozversion application_remotingname: firefox 19:37:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:37:50 INFO - mozversion application_vendor: Mozilla 19:37:50 INFO - mozversion application_version: 47.0a1 19:37:50 INFO - mozversion platform_buildid: 20160220174513 19:37:50 INFO - mozversion platform_changeset: af6356a3e8c56036b74ba097395356d9c6e6c5a3 19:37:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:37:50 INFO - mozversion platform_version: 47.0a1 19:37:50 INFO - using testdate: 1456025870 19:37:50 INFO - actual date: 1456025870 19:37:51 INFO - starting webserver on 'localhost:49291' 19:37:51 INFO - SUITE-START | Running 2 tests 19:37:51 INFO - TEST-START | dromaeo_css 19:37:51 INFO - operating with platform_type : mac_ 19:37:51 INFO - Initialising browser for dromaeo_css test... 19:37:51 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmphlbuAd/profile http://localhost:49291/getInfo.html) 19:37:54 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 19:37:54 INFO - PROCESS | 1691 | colorDepth:24 19:37:54 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 19:37:54 INFO - PROCESS | 1691 | __metrics 19:37:54 ERROR - PROCESS | 1691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 19:37:54 INFO - TEST-INFO | 1691: exit 0 19:37:54 INFO - Browser initialized. 19:37:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:54 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmphlbuAd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:06 INFO - PROCESS | 1696 | RSS: Main: 255565824 19:38:06 INFO - PROCESS | 1696 | 19:38:56 INFO - PROCESS | 1696 | 1456025936269 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:41:07 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49291/tests/dromaeo/cssquery-ext.html) 19:41:09 INFO - PROCESS | 1696 | RSS: Main: 269180928 19:41:09 INFO - PROCESS | 1696 | 19:44:11 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-ext.html (next: http://localhost:49291/tests/dromaeo/cssquery-jquery.html) 19:44:11 INFO - PROCESS | 1696 | RSS: Main: 281264128 19:44:11 INFO - PROCESS | 1696 | 19:47:13 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49291/tests/dromaeo/cssquery-mootools.html) 19:47:14 INFO - PROCESS | 1696 | RSS: Main: 281956352 19:47:14 INFO - PROCESS | 1696 | 19:50:15 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49291/tests/dromaeo/cssquery-prototype.html) 19:50:16 INFO - PROCESS | 1696 | RSS: Main: 283602944 19:50:16 INFO - PROCESS | 1696 | 19:53:19 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49291/tests/dromaeo/cssquery-yui.html) 19:53:19 INFO - PROCESS | 1696 | RSS: Main: 286138368 19:53:19 INFO - PROCESS | 1696 | 19:56:21 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49291/tests/dromaeo/cssquery-yui.html (next: http://localhost:49291/tests/dromaeo/cssquery-dojo.html) 19:56:22 INFO - PROCESS | 1696 | RSS: Main: 289120256 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | __start_tp_report 19:56:22 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 19:56:22 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 19:56:22 INFO - PROCESS | 1696 | |i|pagename|runs| 19:56:22 INFO - PROCESS | 1696 | |0;dojo.html;3529.382358087336;3535.7878527288362;3588.4079126944025;3588.4617307403887;3594.5506811648543;5645.350784659765;5779.04645733454;5781.682007489587;5828.650280983144;5855.063189889618;5804.912926306109;5879.0593505039205;5918.822435326936;5941.16823644689;5955.434233747797;5239.397469291023;5300.178472336775;5375.489328513785;5442.619016668835;5512.310961129859;5251.107311756991;5368.731563421833;5372.973135134319;5409.540189083913;5440.265564148829;5046.419661738911;5222.660527065728;5268.9736551317;5292.285541451894;5361.892762144736;5311.548518375943;5327;5339.599530035224;5377.085895397791;5444.210589464506;4452.1763473757455;4531.773411329454;4973.154563724175;5236.685798852043;5386.78452861885;5657.8019769307875;5747.339056008529;5783.62406443584;5788.421157884178;5806.970965145189;6229.719662615148;6242.781502647385;6243.2508099027955;6262.780802671885;6303.621782693007;6125.846853828645;6202.534809889276;6254.8123556293385;6288.182536270301;6344.206974128234;5069.569086627641;5910.911336329958;5921.940780592225;5950.166976623276;5960.463558279732;5829.7376618052285;6250.1874756282305;6364.459020983176;6406.167198264196;6409.327020662857;6202.038684003986;6213.937860621426;6225.00399936008;6231.688415579203;6239.906401403982;6156.860980718492;6201.627902325875;6254.186955695731;6278.4035516625845;6286.49708023357;5559.305086864142;6108.75564977396;6217.626942383471;6239.719212635442;6274.341194174637;6197.1324014637985;6250.843728906813;6259.843503912439;6269.059641053787;6270.623762574261;4973.403191616957;5011.57401620859;5012.398512178489;5023.372078490189;5034.546890779848;4377.430933978626;4407.6914615976575;4441.022974945507;4443.666724995638;4507.301368287921;5952.315483719428;5969.04495280753;5993.430624090704;6048.879022419527;6056.242969628796;6177.351378105324;6235.812925612239;6286.748530058838;6300.30696623371;6321.715522801485;5929.881402372014;5959.910601340984;5966.463018328372;5989.670568118708;6012.458878700938;5470.7264636768;5496.1755736639825;5499.945000550023;5503.3395992481155;5512.2558454608115;6299.559030867796;6459.741610335628;6508.837279067871;6546.672666366568;6566.573172743756;6270.12218289449;6294.653794041188;6295.244570651551;6309.905351419824;6314.652694101685;6299.181106456132;6568.14614100183;6576.177977752781;6581.14445122131;6596.142501474969;6162.568620196723;6230.15892854477;6233.065040244;6243.282022567463;6263.311035786151;6147.754089836357;6176.536759742948;6244.375562443719;6278.6546739929745;6314.747410103544;6076.848078797889;6190.2571691397325;6201.10084037803;6227.532935029801;6239.688015599293;5576.609637325349;5791.015527360443;5818.7090645466715;6112.2299296386045;6194.256689197326;5014.7994080236385;5272.971770504868;5966.850828729316;5982.4017598239825;6134.601250918676;6076.51387888959;6133.233345831771;6188.44304012641;6240.032794916795;6272.466840318624;6092;6109.5831607108885;6124;6134.068502592042;6144.910730351523 19:56:22 INFO - PROCESS | 1696 | |1;ext.html;419.7083027296031;468.5712572995709;501.7842327799046;565.0507147991374;600.9003523551895;27533;37791.622083779155;37803.81098094513;37848.99999999996;37883.62116378835;30324.54513182304;38978.22043559134;39209.60790392095;39309.41035884457;39850.00374990627;9301.162895339417;9440.952795236015;9520.619175232983;9530.475823829687;9534.952325238364;9350.485723285217;9623.23014158869;9624.80750384992;9643;9669.226461883032;9552.474613896233;9654.227661787076;9668.75828104296;9706.805863882719;9709.902900971007;9544.33189676723;9626.037396260353;9633.277504187214;9646.131848133666;9664.371815831948;8322.375821813388;9491.525423728786;9493.38293010959;9493.810123797555;9497.382670126488;38191.427128593095;38250.043748906224;38297.234055319015;38583;38775.61224387777;2820.3513191965963;3285.4086264472385;3310.619278782947;3410.4372778491766;3536;26852.73147268522;27551.862240688868;27637;27703;27740.30649233785;2697.136916186821;2762.3646561291016;2808.2277373722186;2955.6305461817274;2967.7774166937565;504527;513235.4338228285;516535;516556;517678;45402.772986134856;45591.54408455939;45950.5404945953;68034;68785.31214687889;41465.58534414678;44283.33574996378;45146.77426612846;45164.322535162;45179.87050323703;15277.38890444392;15311.846881531264;15539.30073146711;15548.455804046804;15698.450554230547;12308.076894232789;12398;12448.81326780099;12494.187877788096;12516.81224781629;14639.26803659834;14772.335244914004;14796.334164962387;14895;15016.624584385478;6316.021016742412;6362.236531616236;6408.295087540367;6447.580907241015;6461.095446637474;989.475577943691;1061.75048863517;1089.8964598363143;1146.1003112556602;1180.6044974933322;29988.400231995238;30081.849590751906;30250.78996840146;30590.694093059228;30630.69369306323;1057.0909018244304;1077.3966578715945;1116.1963386361806;1130.5251794246435;1152.3777160333493;12649.747005059848;15054.29022775889;15065.09609423438;15100.848991509944;15145.93978421522;586389;658952;660474;667553;667846;59019.40980590225;59904.10143847846;60274.69862650747;60682.69658651679;60991.08513372303;1424.294973987862;1457.176695167227;1478.039274471602;1484.5397926642775;1496.7576911163708;23311.650325245475;31611;31692.366152677278;31844.840775795972;32380;53024.73487632537;53083;53333.200002000776;53710;53736.193957091455;420826;422932;423708;423853;424362;41842.58157418509;42263.15473690571;44457.77771111124;44689.10621787611;44926.55073449224;46067.76966115148;46169.30746038745;46426.535734642224;46797.766011169726;47647;38045.42931855969;38648.42027369648;38904.416433754086;39021.6097839018;39307.2138557233;37713.245735084594;37915.43126853044;38652.22695546017;39398;39645.80177099096;32040.67959320377;35425;35929.28141437209;36302;38231.235375291784;29170.416591668472;31383;33890.830545847115;34489;34609.48085778665;21235.893820530797;24496.26420793305;24721.011159553418;24919.87540062288;25005.74994250034 19:56:22 INFO - PROCESS | 1696 | |2;jquery.html;361.5859840482646;364.96897763690083;367.2581385601085;372.74094504319476;373.94951681523;15759.763603545956;18852.34016809412;19058.142383592738;19375.224991000345;20457.795422045794;19589.706154407697;19662.213511459526;19988.50028749282;19994.700079498783;19996.400107996782;5092.84721458355;5167.638265321429;5326.067938110835;5327.600429967749;5332.626716129873;5275.182346736262;5295.841124766263;5334.839954801343;5343.358796944352;5343.519083282504;3835.9232815343676;5271.182966640158;5330.38700549436;5336.119540275849;5705.172749951254;5859.6777177255235;5880.206172166767;5925.229720136398;5929.8814023719715;5941.55438342126;5526.530244929186;5543.944560554423;5637.689927054052;5651.7456714447535;5676.3755986841825;13024.54414095502;13258.53595124166;13329.133606315558;13347.19916804985;15624.76562851558;2185.2351676913113;2217.401301648546;2268.194790849258;2461.2739241923678;2657.2028391482477;9932.00679932001;9981.251406144569;9982.301238913278;10174.44040577768;10291.279610427273;1706.3260012295198;1721.3889069380316;1740.6866763982478;1743.111013383171;1744.659791340689;106155;107717;108867;112033.43983280113;112398;11462.083033357312;11492.54029838797;11599;11599.246049006788;11623.12826538013;13783.241921694202;13841;13853.861461385257;13896.51362202318;13934.86065139356;8503.787405314917;8535.53054582004;8594.183552562497;8620.698275560326;8645.9624845019;7274.199838017814;7957.283844454027;8167.693169093035;8667.869981950276;8755.299576033902;4474.105178964221;4476.7912663580655;4493.370928070073;4508.639308855284;4533.954660453419;1550.8061492313461;1694.5509439998411;1875.831175194239;1902.8287454129195;1915.5689969756693;357.3442732585734;402.4365887757105;885.4510203673764;980.8577756225308;982.3221976835961;11101.111911047097;11815.822762658567;11826.408679565988;11844.170908036354;11993.820092698617;449.6537665997229;450.34249995007656;465.0350522665483;907.3331101640289;1020.4387586827215;10342.482875856178;10665.933406659273;10726.98093681099;10773.78452430947;11104.111671066295;534412;536600;536977;548597;549250;75051;120276.39861800635;121702;122254;125646;462.4335189392967;481.33575665581975;482.82859584847574;1016.6797458800454;1059.8781140168978;11250.66248012561;11334.489947952197;11396.715082123013;11471.94264028708;11848.111391645489;50950;53069.469305308;55523.444765553446;57588.71205644112;58516.82966340735;72335.63832180806;73649;73829.6308518454;76004.85992710224;77483.61258193673;8068.1528439513;8092.635831387719;8156.6541520648425;8291.668333266602;8336.583170841555;11671.533138674358;12649.13853201865;13441.596752097452;13630.04589678713;13925.721485570435;11331.603393881174;11634.825477617673;11646.650600481998;11667.824982625438;11700;11131.833022504507;11396.658100257006;11452.14108941816;11469.082473402275;11654.53381864716;11425.2002359834;11777.823332650189;11787.882121178678;11875.940620296844;11906.880931190577;7946.443748937751;8107.716229931924;8184.508929464251;8286.917130828615;8325.83348333042;8461.280791132822;11306.095512358826;11713.531458741554;11734.589289374831;11738.70653233676 19:56:22 INFO - PROCESS | 1696 | |3;mootools.html;1402.6353148181472;1527.4195805593872;1752.7633769441122;1917.8849269043849;1928.758905136858;8049.154838741935;8654.74035778926;8829.29365650748;9044.23124034457;9079.63681452742;8674.522901240429;8746.650133994648;8770.166834150745;8810.911890881089;8839.381243312955;2486.0925762096886;2495.3262619092925;2508.686414198225;2520.483300923306;2521.596544552872;2418.2382549496942;2507.059852555292;2512.6482292478977;2513.1832154549843;2518.3955850595817;2208.86746795192;2430.9027638894513;2485.5774518331928;2504.799616030722;2540.7586279303528;2468.0991438125134;2485.850848949051;2510.1214574898822;2513.2209015205344;2518.25711415133;2489.265666628349;2497.9500409991697;2506.085278873198;2506.260653107338;2523.8485690858606;7719.3052625264;7827.843443131105;8218.917810821875;9019.7294081177;9024.142706442943;4654.743989080599;5374.220737993008;5499.7250137493365;5515.393306736256;5523.530499907512;3644.6355364463607;3656.597774244831;3757.0982964088694;3772.6415990481137;3791.7345785795005;912.8174365126935;1080.9243352965295;1104.8066588347087;1111.2776695148218;1112.065864673678;11934.224275422157;12034.759304813855;12037.518499260019;12050;12050.939745301304;4296.2696341621995;4915.65590408668;4954.578860796801;4954.77703503336;4991.351124353883;10109.545070471846;10192.490375481197;10195.541200645988;10227.07956283938;10249.94875025635;5423.403425623178;5481.616286859961;5488.286522752017;5497.285352904097;5510.531604813636;5009.298698182258;5018.723970181675;5027.069992051483;5027.673201241908;5075.0357432087785;3987.541432735273;4029.194161167778;4042.8787136385954;4078.7960601969785;4089.2639324921206;1334.873187047229;1342.9597112086458;1351.8850897673808;1369.7260547890462;1370.4586688258082;844.7254642241173;1116.6147679050714;1140.492480846032;1225.4301749686438;1317.9077464577388;7976.05484599552;8033.55815430157;8039.316658084012;8088.595570221465;8143.633536490872;1188.9108316876268;1193.1051711216587;1210.5883999440232;1217.2453079090844;1225.6751960730414;6164.938350616526;6189.226346706661;6200.689965501707;6261.499080073583;6289.119523266746;9344.392614480037;10558.472076396303;10594.417307048187;10665.36007839532;10706.678799636024;10370.429626370471;10412.895871041193;10502.68491945243;10512.369257844553;10513.789724205473;8246.505209687439;8257.876131858027;8371.995360556772;8386.538740369217;8395.53824539644;8034.317083048007;8153.3477321812925;8155.388345873965;8242.093369729444;8383.371247156365;9674.903250967682;9835.409875407213;9896.208303335572;9897.901020989986;9934.552945117632;10062.547185376528;10177.898221017695;10237.23220758461;10322;10359.94820025895;7602.923970760443;7617.885731713918;7735.574543400167;7739.7678069658;7762.7671169865;8219.260266576037;8322.875156872531;8354.164583541597;8395.496270223806;8425.115362886809;7489.625518724151;7646.044244469442;7683.148274938169;7718.343940765098;7718.807029824299;5620;6501.902471462838;7335.193128755725;7336.559806411632;7352.70589176427;7653.923460765321;7737.92262077372;7772.378209743094;7786.4938778979185;7804.804879878048;6036.3058248302;6967.2684368142645;7085.468589855678;7097.077379940574;7129.500934934505;7154.105736782903;7179.246179151114;7194.856102878018;7231.746888858865;7234.493585448968 19:56:22 INFO - PROCESS | 1696 | |4;prototype.html;282.23373540836633;324.6753246753247;327.5610681686541;334.5400074897017;335.85390355195506;6317.715702793374;6379.712912918918;6925.757598484048;6976.267491913352;7052.259512751164;5554.2779438673015;5860.560457965659;5873.324567674718;6636.938089905604;7085;4472.060867217888;4475.664325175609;4786.736729479877;5145.408278048017;5184.326037615105;5063.6202284828605;5182.041322355376;5192.454792246816;5193.376794784631;5200.92198617021;5095.261187127864;5114.284000239951;5116.283720279164;5119.539241468267;5125.820596279131;4547.86303424144;4802.327674125625;4889.193283108283;4973.15456372414;5088.389393272794;4158.209940111369;4202.033532287561;4207.389928460356;4209.915801683949;4214.7681877496725;6593.20881494219;6682.799516014527;6687.665616719145;6703.363180497845;6717.193936727575;5714.485696287313;5849.444302791228;5880.794172203995;5917.644941303535;5930.110483427477;7151.927210918352;7417.666205020787;7458.440616953751;7467.141278752959;7475;4189.7695626740515;4246.639035681971;4373.234683930331;4714.717116972958;4735.715857048588;7948.682052717884;7996.24035716606;7996.600169991535;8006.839863202703;8014.198580141998;3654.8903532894055;4517.119161763425;4793.904121917542;4863.270509423614;4953.851384458472;5043.3609077050105;5051.494850514919;5055.898882022412;5058.54473097423;5073.518015788494;5952.613080149777;5994.760209591567;6023.518118550505;6023.6385816851125;6042.456178943916;7522.962385188039;7531.435142364235;7531.849363012709;7545.245475452411;7546.471746977769;1744.9302027918995;1774.5918438759159;1776.1829558403022;1777.0759205213217;1778.5642517583017;1096.88666004006;1151.8329842172839;1158.1892675127444;1170.5668902506127;1170.9238899471507;6947.617881016491;6976.651167441608;7000.859982800315;7008.299170083053;7038.824029399306;7721.7683469496005;7732.149463559004;7750.651220695082;7753.534787912743;7761.4566980311965;6977.686004129826;6998.860022799618;7004.089468369079;7016.0528328676;7036.50744447894;3976.3637817949566;4087.529934057562;4108.548059713489;4124.381342798604;4135.875923722293;6901.033855260268;8144.063432705197;8149.79625509367;8232.053313868983;8247.711330103537;8090;8107.270345668918;8109.986251718535;8130.308923741548;8137.186281371815;6897.689603967833;8171.387145964077;8185.590720464072;8253.95873020631;8256.876146857801;6666.166729158856;7242.927570724225;7849.215078492105;7877.133515313197;7889.487183333065;6450.225972883284;7629.961850190713;7705.691772329044;7710.383169346326;7721.9227807723455;6996.195437524546;8213.178682131738;8215.507069575844;8247.546384948886;8254.628541715758;4065.6137666921595;4258.6380157686945;4587.42657167854;4814.783334750015;4819.95180048209;7431.516951398142;7462.44031697614;7545.849083018418;7765.22347765219;7834.373250139861;7402;7452.515586486861;7462.552246865205;7475.738349157753;7485.962570187115;7098.183708873546;7414.184439711519;7430.554166750012;7434.59109748969;7454.515456495311;6976.930230697831;7239.420846332176;7240.927590724236;7250.746223882139;7287.817804554928;5637.802676906289;7375.967364569072;7442.181360050282;7458.664360103917;7470.3276705096805;7293.161286452126;7294.96352518234;7297.744578939712;7304.488685791944;7320.853582928418 19:56:22 INFO - PROCESS | 1696 | |5;yui.html;664.4385494257351;674.4402146218638;675.4123912196388;722.2272168779408;729.3326606155365;14827.406903723851;15219.619509512268;15219.923900380496;17286.827131728678;17439.476815695518;15694.293756780944;15968.680626387466;15980.520584382488;16071.678566428664;16151.838481615181;709.4608097845648;866.1598249697784;877.1535468273099;885.5660726244126;902.1204325782376;872.4852337121097;881.7398867334152;883.5228976352762;888.5868071346822;890.3722875372847;900.1988230474883;928.2759447630825;942.180303136269;943.2406912435487;944.2540393089452;843.2242337049929;899.3344924755667;921.3642586615281;925.2366797392144;934.4626839567208;663.2008429842028;671.6238906212487;690.5097380859596;694.5381321421249;696.8014115976973;13294.86705132946;15180.468683596022;15351.155686437241;15371.769423458658;15393.923030384889;12717.872821271761;12776.361181940958;12780.680482987907;13082.280474573894;13231.272280024596;9959.352642078242;10095;10145.289829711923;10408.01123893229;10823.621173258976;3138.10563989262;3465.844037018315;3518.595361533405;3527.682508574215;3580.427131658922;86636.56681716614;87539.99999999936;87611;87662.56168719116;87740;8437.409381343246;9214.539273036322;9229;9302.25581953442;9620.278479114095;20318.18727250923;20405.795942040688;20515.794842051688;20524.281650142173;20598.691019634716;7089.751858684921;7134.678939447737;7241.2396698346965;7336.596487193149;7539.434542409341;3922.2351641429645;3928.194720082376;3978.522577290744;4002.239574480839;4013.658838998718;3602.585702644177;3608.1520842601967;3617.5839778425293;3633.6729694327637;3650.1604630935035;662.3641304347784;662.5925056090566;679.6262055869253;681.2029924987776;683.702589373624;570.395380896243;580.901246788047;589.7464090441066;597.1772499196661;619.3713380918372;8202;8481.618327175293;8582.313414926792;8646.135386461303;8832.337574681924;523.7041071794424;582.860507707431;607.8723468071754;613.8189234175928;623.1929651101743;3865.4974853268895;3885.0287428142965;3909.9413508797393;4059.6752259819145;4137.731047481904;94483.05516944743;97620;97695.02304977001;97988.51005744925;98335;80565.59717201376;82241.58879205566;82935.17064829274;83032;83404;54743.72628136834;69383;69878.3012169882;77193.6140319306;77204.2279577197;8746.387752857494;8789.956050219964;8801.735947921572;8866.024737279024;9206;51358.48641513687;51927;51949.22076168936;52699;53344;69197.30802691908;72351.63824181056;72771.63614181895;74336.62831685807;75773;10903.400312982545;11147.331160130418;11222.214444988773;11542.711432213926;11591.304521728724;12067.879321206676;12119.272843629411;12131.757364852478;12736.936315318364;13068.215907045607;9673.78407494379;11852.585159519376;11952.880471195176;12059.336736479578;12060.939695301468;11489.253198542068;11512.30926144434;11515.596954106566;11781.587644432746;12538.561150359694;11070.335779853234;11203.495842686936;11262.662120136409;11278.379689117177;11749.941250293694;8509.91490085116;9556.713298601053;9581.041895810364;9986.850197246902;10377.377357358582;8467.872981905153;8980.506072166094;9912.553935073083;9920.40477571348;9959.800803983735 19:56:22 INFO - PROCESS | 1696 | __end_tp_report 19:56:22 INFO - PROCESS | 1696 | __start_cc_report 19:56:22 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,354 19:56:22 INFO - PROCESS | 1696 | __end_cc_report 19:56:22 INFO - PROCESS | 1696 | __startTimestamp1456026982096__endTimestamp 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | ------- Summary: start ------- 19:56:22 INFO - PROCESS | 1696 | Number of tests: 6 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#0] dojo.html Cycles:165 Average:5804.94 Median:6048.88 stddev:641.94 (10.6%) stddev-sans-first:618.59 19:56:22 INFO - PROCESS | 1696 | Values: 3529.4 3535.8 3588.4 3588.5 3594.6 5645.4 5779.0 5781.7 5828.7 5855.1 5804.9 5879.1 5918.8 5941.2 5955.4 5239.4 5300.2 5375.5 5442.6 5512.3 5251.1 5368.7 5373.0 5409.5 5440.3 5046.4 5222.7 5269.0 5292.3 5361.9 5311.5 5327.0 5339.6 5377.1 5444.2 4452.2 4531.8 4973.2 5236.7 5386.8 5657.8 5747.3 5783.6 5788.4 5807.0 6229.7 6242.8 6243.3 6262.8 6303.6 6125.8 6202.5 6254.8 6288.2 6344.2 5069.6 5910.9 5921.9 5950.2 5960.5 5829.7 6250.2 6364.5 6406.2 6409.3 6202.0 6213.9 6225.0 6231.7 6239.9 6156.9 6201.6 6254.2 6278.4 6286.5 5559.3 6108.8 6217.6 6239.7 6274.3 6197.1 6250.8 6259.8 6269.1 6270.6 4973.4 5011.6 5012.4 5023.4 5034.5 4377.4 4407.7 4441.0 4443.7 4507.3 5952.3 5969.0 5993.4 6048.9 6056.2 6177.4 6235.8 6286.7 6300.3 6321.7 5929.9 5959.9 5966.5 5989.7 6012.5 5470.7 5496.2 5499.9 5503.3 5512.3 6299.6 6459.7 6508.8 6546.7 6566.6 6270.1 6294.7 6295.2 6309.9 6314.7 6299.2 6568.1 6576.2 6581.1 6596.1 6162.6 6230.2 6233.1 6243.3 6263.3 6147.8 6176.5 6244.4 6278.7 6314.7 6076.8 6190.3 6201.1 6227.5 6239.7 5576.6 5791.0 5818.7 6112.2 6194.3 5014.8 5273.0 5966.9 5982.4 6134.6 6076.5 6133.2 6188.4 6240.0 6272.5 6092.0 6109.6 6124.0 6134.1 6144.9 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#1] ext.html Cycles:180 Average:66084.13 Median:38941.32 stddev:143444.44 (368.4%) stddev-sans-first:143762.12 19:56:22 INFO - PROCESS | 1696 | Values: 419.7 468.6 501.8 565.1 600.9 27533.0 37791.6 37803.8 37849.0 37883.6 30324.5 38978.2 39209.6 39309.4 39850.0 9301.2 9441.0 9520.6 9530.5 9535.0 9350.5 9623.2 9624.8 9643.0 9669.2 9552.5 9654.2 9668.8 9706.8 9709.9 9544.3 9626.0 9633.3 9646.1 9664.4 8322.4 9491.5 9493.4 9493.8 9497.4 38191.4 38250.0 38297.2 38583.0 38775.6 2820.4 3285.4 3310.6 3410.4 3536.0 26852.7 27551.9 27637.0 27703.0 27740.3 2697.1 2762.4 2808.2 2955.6 2967.8 504527.0 513235.4 516535.0 516556.0 517678.0 45402.8 45591.5 45950.5 68034.0 68785.3 41465.6 44283.3 45146.8 45164.3 45179.9 15277.4 15311.8 15539.3 15548.5 15698.5 12308.1 12398.0 12448.8 12494.2 12516.8 14639.3 14772.3 14796.3 14895.0 15016.6 6316.0 6362.2 6408.3 6447.6 6461.1 989.5 1061.8 1089.9 1146.1 1180.6 29988.4 30081.8 30250.8 30590.7 30630.7 1057.1 1077.4 1116.2 1130.5 1152.4 12649.7 15054.3 15065.1 15100.8 15145.9 586389.0 658952.0 660474.0 667553.0 667846.0 59019.4 59904.1 60274.7 60682.7 60991.1 1424.3 1457.2 1478.0 1484.5 1496.8 23311.7 31611.0 31692.4 31844.8 32380.0 53024.7 53083.0 53333.2 53710.0 53736.2 420826.0 422932.0 423708.0 423853.0 424362.0 41842.6 42263.2 44457.8 44689.1 44926.6 46067.8 46169.3 46426.5 46797.8 47647.0 38045.4 38648.4 38904.4 39021.6 39307.2 37713.2 37915.4 38652.2 39398.0 39645.8 32040.7 35425.0 35929.3 36302.0 38231.2 29170.4 31383.0 33890.8 34489.0 34609.5 21235.9 24496.3 24721.0 24919.9 25005.7 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#2] jquery.html Cycles:180 Average:31860.04 Median:2364.73 stddev:90466.76 (3825.7%) stddev-sans-first:90689.63 19:56:22 INFO - PROCESS | 1696 | Values: 361.6 365.0 367.3 372.7 373.9 15759.8 18852.3 19058.1 19375.2 20457.8 19589.7 19662.2 19988.5 19994.7 19996.4 5092.8 5167.6 5326.1 5327.6 5332.6 5275.2 5295.8 5334.8 5343.4 5343.5 3835.9 5271.2 5330.4 5336.1 5705.2 5859.7 5880.2 5925.2 5929.9 5941.6 5526.5 5543.9 5637.7 5651.7 5676.4 13024.5 13258.5 13329.1 13347.2 15624.8 2185.2 2217.4 2268.2 2461.3 2657.2 9932.0 9981.3 9982.3 10174.4 10291.3 1706.3 1721.4 1740.7 1743.1 1744.7 106155.0 107717.0 108867.0 112033.4 112398.0 11462.1 11492.5 11599.0 11599.2 11623.1 13783.2 13841.0 13853.9 13896.5 13934.9 8503.8 8535.5 8594.2 8620.7 8646.0 7274.2 7957.3 8167.7 8667.9 8755.3 4474.1 4476.8 4493.4 4508.6 4534.0 1550.8 1694.6 1875.8 1902.8 1915.6 357.3 402.4 885.5 980.9 982.3 11101.1 11815.8 11826.4 11844.2 11993.8 449.7 450.3 465.0 907.3 1020.4 10342.5 10665.9 10727.0 10773.8 11104.1 534412.0 536600.0 536977.0 548597.0 549250.0 75051.0 120276.4 121702.0 122254.0 125646.0 462.4 481.3 482.8 1016.7 1059.9 11250.7 11334.5 11396.7 11471.9 11848.1 50950.0 53069.5 55523.4 57588.7 58516.8 72335.6 73649.0 73829.6 76004.9 77483.6 8068.2 8092.6 8156.7 8291.7 8336.6 11671.5 12649.1 13441.6 13630.0 13925.7 11331.6 11634.8 11646.7 11667.8 11700.0 11131.8 11396.7 11452.1 11469.1 11654.5 11425.2 11777.8 11787.9 11875.9 11906.9 7946.4 8107.7 8184.5 8286.9 8325.8 8461.3 11306.1 11713.5 11734.6 11738.7 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#3] mootools.html Cycles:180 Average:6095.62 Median:5027.37 stddev:3189.06 (63.4%) stddev-sans-first:3178.49 19:56:22 INFO - PROCESS | 1696 | Values: 1402.6 1527.4 1752.8 1917.9 1928.8 8049.2 8654.7 8829.3 9044.2 9079.6 8674.5 8746.7 8770.2 8810.9 8839.4 2486.1 2495.3 2508.7 2520.5 2521.6 2418.2 2507.1 2512.6 2513.2 2518.4 2208.9 2430.9 2485.6 2504.8 2540.8 2468.1 2485.9 2510.1 2513.2 2518.3 2489.3 2498.0 2506.1 2506.3 2523.8 7719.3 7827.8 8218.9 9019.7 9024.1 4654.7 5374.2 5499.7 5515.4 5523.5 3644.6 3656.6 3757.1 3772.6 3791.7 912.8 1080.9 1104.8 1111.3 1112.1 11934.2 12034.8 12037.5 12050.0 12050.9 4296.3 4915.7 4954.6 4954.8 4991.4 10109.5 10192.5 10195.5 10227.1 10249.9 5423.4 5481.6 5488.3 5497.3 5510.5 5009.3 5018.7 5027.1 5027.7 5075.0 3987.5 4029.2 4042.9 4078.8 4089.3 1334.9 1343.0 1351.9 1369.7 1370.5 844.7 1116.6 1140.5 1225.4 1317.9 7976.1 8033.6 8039.3 8088.6 8143.6 1188.9 1193.1 1210.6 1217.2 1225.7 6164.9 6189.2 6200.7 6261.5 6289.1 9344.4 10558.5 10594.4 10665.4 10706.7 10370.4 10412.9 10502.7 10512.4 10513.8 8246.5 8257.9 8372.0 8386.5 8395.5 8034.3 8153.3 8155.4 8242.1 8383.4 9674.9 9835.4 9896.2 9897.9 9934.6 10062.5 10177.9 10237.2 10322.0 10359.9 7602.9 7617.9 7735.6 7739.8 7762.8 8219.3 8322.9 8354.2 8395.5 8425.1 7489.6 7646.0 7683.1 7718.3 7718.8 5620.0 6501.9 7335.2 7336.6 7352.7 7653.9 7737.9 7772.4 7786.5 7804.8 6036.3 6967.3 7085.5 7097.1 7129.5 7154.1 7179.2 7194.9 7231.7 7234.5 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#4] prototype.html Cycles:180 Average:6031.72 Median:6913.40 stddev:1982.33 (28.7%) stddev-sans-first:1940.35 19:56:22 INFO - PROCESS | 1696 | Values: 282.2 324.7 327.6 334.5 335.9 6317.7 6379.7 6925.8 6976.3 7052.3 5554.3 5860.6 5873.3 6636.9 7085.0 4472.1 4475.7 4786.7 5145.4 5184.3 5063.6 5182.0 5192.5 5193.4 5200.9 5095.3 5114.3 5116.3 5119.5 5125.8 4547.9 4802.3 4889.2 4973.2 5088.4 4158.2 4202.0 4207.4 4209.9 4214.8 6593.2 6682.8 6687.7 6703.4 6717.2 5714.5 5849.4 5880.8 5917.6 5930.1 7151.9 7417.7 7458.4 7467.1 7475.0 4189.8 4246.6 4373.2 4714.7 4735.7 7948.7 7996.2 7996.6 8006.8 8014.2 3654.9 4517.1 4793.9 4863.3 4953.9 5043.4 5051.5 5055.9 5058.5 5073.5 5952.6 5994.8 6023.5 6023.6 6042.5 7523.0 7531.4 7531.8 7545.2 7546.5 1744.9 1774.6 1776.2 1777.1 1778.6 1096.9 1151.8 1158.2 1170.6 1170.9 6947.6 6976.7 7000.9 7008.3 7038.8 7721.8 7732.1 7750.7 7753.5 7761.5 6977.7 6998.9 7004.1 7016.1 7036.5 3976.4 4087.5 4108.5 4124.4 4135.9 6901.0 8144.1 8149.8 8232.1 8247.7 8090.0 8107.3 8110.0 8130.3 8137.2 6897.7 8171.4 8185.6 8254.0 8256.9 6666.2 7242.9 7849.2 7877.1 7889.5 6450.2 7630.0 7705.7 7710.4 7721.9 6996.2 8213.2 8215.5 8247.5 8254.6 4065.6 4258.6 4587.4 4814.8 4820.0 7431.5 7462.4 7545.8 7765.2 7834.4 7402.0 7452.5 7462.6 7475.7 7486.0 7098.2 7414.2 7430.6 7434.6 7454.5 6976.9 7239.4 7240.9 7250.7 7287.8 5637.8 7376.0 7442.2 7458.7 7470.3 7293.2 7295.0 7297.7 7304.5 7320.9 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - PROCESS | 1696 | [#5] yui.html Cycles:180 Average:19042.04 Median:662.48 stddev:27184.92 (4103.5%) stddev-sans-first:27226.16 19:56:22 INFO - PROCESS | 1696 | Values: 664.4 674.4 675.4 722.2 729.3 14827.4 15219.6 15219.9 17286.8 17439.5 15694.3 15968.7 15980.5 16071.7 16151.8 709.5 866.2 877.2 885.6 902.1 872.5 881.7 883.5 888.6 890.4 900.2 928.3 942.2 943.2 944.3 843.2 899.3 921.4 925.2 934.5 663.2 671.6 690.5 694.5 696.8 13294.9 15180.5 15351.2 15371.8 15393.9 12717.9 12776.4 12780.7 13082.3 13231.3 9959.4 10095.0 10145.3 10408.0 10823.6 3138.1 3465.8 3518.6 3527.7 3580.4 86636.6 87540.0 87611.0 87662.6 87740.0 8437.4 9214.5 9229.0 9302.3 9620.3 20318.2 20405.8 20515.8 20524.3 20598.7 7089.8 7134.7 7241.2 7336.6 7539.4 3922.2 3928.2 3978.5 4002.2 4013.7 3602.6 3608.2 3617.6 3633.7 3650.2 662.4 662.6 679.6 681.2 683.7 570.4 580.9 589.7 597.2 619.4 8202.0 8481.6 8582.3 8646.1 8832.3 523.7 582.9 607.9 613.8 623.2 3865.5 3885.0 3909.9 4059.7 4137.7 94483.1 97620.0 97695.0 97988.5 98335.0 80565.6 82241.6 82935.2 83032.0 83404.0 54743.7 69383.0 69878.3 77193.6 77204.2 8746.4 8790.0 8801.7 8866.0 9206.0 51358.5 51927.0 51949.2 52699.0 53344.0 69197.3 72351.6 72771.6 74336.6 75773.0 10903.4 11147.3 11222.2 11542.7 11591.3 12067.9 12119.3 12131.8 12736.9 13068.2 9673.8 11852.6 11952.9 12059.3 12060.9 11489.3 11512.3 11515.6 11781.6 12538.6 11070.3 11203.5 11262.7 11278.4 11749.9 8509.9 9556.7 9581.0 9986.9 10377.4 8467.9 8980.5 9912.6 9920.4 9959.8 19:56:22 INFO - PROCESS | 1696 | -------- Summary: end -------- 19:56:22 INFO - PROCESS | 1696 | 19:56:22 INFO - TEST-INFO | 1696: exit 0 19:56:22 INFO - TEST-OK | dromaeo_css | took 1111423ms 19:56:22 INFO - TEST-START | kraken 19:56:22 INFO - operating with platform_type : mac_ 19:56:22 INFO - Initialising browser for kraken test... 19:56:22 INFO - TEST-INFO | started process 1704 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmpZT02uA/profile http://localhost:49291/getInfo.html) 19:56:25 INFO - PROCESS | 1704 | __metrics Screen width/height:1600/1200 19:56:25 INFO - PROCESS | 1704 | colorDepth:24 19:56:25 INFO - PROCESS | 1704 | Browser inner width/height: 1024/689 19:56:25 INFO - PROCESS | 1704 | __metrics 19:56:25 ERROR - PROCESS | 1704 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 19:56:26 INFO - TEST-INFO | 1704: exit 0 19:56:26 INFO - Browser initialized. 19:56:26 INFO - Running cycle 1/1 for kraken test... 19:56:26 INFO - TEST-INFO | started process 1707 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/T/tmpZT02uA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:37 INFO - PROCESS | 1707 | RSS: Main: 256614400 19:56:37 INFO - PROCESS | 1707 | 19:56:40 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:41 INFO - PROCESS | 1707 | RSS: Main: 267476992 19:56:41 INFO - PROCESS | 1707 | 19:56:43 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-dft) 19:56:44 INFO - PROCESS | 1707 | RSS: Main: 277835776 19:56:44 INFO - PROCESS | 1707 | 19:56:47 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-fft) 19:56:48 INFO - PROCESS | 1707 | RSS: Main: 280936448 19:56:48 INFO - PROCESS | 1707 | 19:56:50 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator) 19:56:50 INFO - PROCESS | 1707 | RSS: Main: 282554368 19:56:50 INFO - PROCESS | 1707 | 19:56:53 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:53 INFO - PROCESS | 1707 | RSS: Main: 283222016 19:56:53 INFO - PROCESS | 1707 | 19:56:56 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:57 INFO - PROCESS | 1707 | RSS: Main: 283942912 19:56:57 INFO - PROCESS | 1707 | 19:57:00 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:00 INFO - PROCESS | 1707 | RSS: Main: 283648000 19:57:00 INFO - PROCESS | 1707 | 19:57:03 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial) 19:57:04 INFO - PROCESS | 1707 | RSS: Main: 283865088 19:57:04 INFO - PROCESS | 1707 | 19:57:05 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:06 INFO - PROCESS | 1707 | RSS: Main: 282783744 19:57:06 INFO - PROCESS | 1707 | 19:57:08 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:57:08 INFO - PROCESS | 1707 | RSS: Main: 283754496 19:57:08 INFO - PROCESS | 1707 | 19:57:11 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:57:11 INFO - PROCESS | 1707 | RSS: Main: 283820032 19:57:11 INFO - PROCESS | 1707 | 19:57:14 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:57:14 INFO - PROCESS | 1707 | RSS: Main: 283680768 19:57:14 INFO - PROCESS | 1707 | 19:57:17 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:57:17 INFO - PROCESS | 1707 | RSS: Main: 283389952 19:57:17 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | Cycle 1(1): loaded http://localhost:49291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49291/tests/kraken/driver.html?testName=ai-astar) 19:57:19 INFO - PROCESS | 1707 | RSS: Main: 284418048 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | __start_tp_report 19:57:19 INFO - PROCESS | 1707 | _x_x_mozilla_page_load 19:57:19 INFO - PROCESS | 1707 | _x_x_mozilla_page_load_details 19:57:19 INFO - PROCESS | 1707 | |i|pagename|runs| 19:57:19 INFO - PROCESS | 1707 | |0;ai-astar;115;109;117;114;117;126;115;114;114;114 19:57:19 INFO - PROCESS | 1707 | |1;audio-beat-detection;150;138;142;148;121;140;137;122;159;122 19:57:19 INFO - PROCESS | 1707 | |2;audio-dft;192;214;223;230;247;222;194;195;200;196 19:57:19 INFO - PROCESS | 1707 | |3;audio-fft;67;75;76;136;48;58;81;77;132;63 19:57:19 INFO - PROCESS | 1707 | |4;audio-oscillator;105;82;118;98;110;113;142;82;83;109 19:57:19 INFO - PROCESS | 1707 | |5;imaging-gaussian-blur;88;94;117;125;90;93;85;92;87;94 19:57:19 INFO - PROCESS | 1707 | |6;imaging-darkroom;103;98;96;98;98;97;115;130;138;141 19:57:19 INFO - PROCESS | 1707 | |7;imaging-desaturate;92;93;91;92;91;96;94;139;140;95 19:57:19 INFO - PROCESS | 1707 | |8;json-parse-financial;57;56;57;55;56;57;54;63;56;56 19:57:19 INFO - PROCESS | 1707 | |9;json-stringify-tinderbox;65;67;69;97;97;60;55;69;94;91 19:57:19 INFO - PROCESS | 1707 | |10;stanford-crypto-aes;75;81;92;109;101;87;86;85;87;85 19:57:19 INFO - PROCESS | 1707 | |11;stanford-crypto-ccm;129;127;154;142;134;124;135;137;124;121 19:57:19 INFO - PROCESS | 1707 | |12;stanford-crypto-pbkdf2;135;142;143;145;115;154;167;150;143;152 19:57:19 INFO - PROCESS | 1707 | |13;stanford-crypto-sha256-iterative;60;83;95;92;79;69;66;67;71;70 19:57:19 INFO - PROCESS | 1707 | __end_tp_report 19:57:19 INFO - PROCESS | 1707 | __start_cc_report 19:57:19 INFO - PROCESS | 1707 | _x_x_mozilla_cycle_collect,886 19:57:19 INFO - PROCESS | 1707 | __end_cc_report 19:57:19 INFO - PROCESS | 1707 | __startTimestamp1456027039974__endTimestamp 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | ------- Summary: start ------- 19:57:19 INFO - PROCESS | 1707 | Number of tests: 14 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.00 stddev:4.30 (3.7%) stddev-sans-first:4.56 19:57:19 INFO - PROCESS | 1707 | Values: 115.0 109.0 117.0 114.0 117.0 126.0 115.0 114.0 114.0 114.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:141.00 stddev:12.94 (9.2%) stddev-sans-first:12.96 19:57:19 INFO - PROCESS | 1707 | Values: 150.0 138.0 142.0 148.0 121.0 140.0 137.0 122.0 159.0 122.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#2] audio-dft Cycles:10 Average:211.30 Median:218.00 stddev:18.80 (8.6%) stddev-sans-first:18.60 19:57:19 INFO - PROCESS | 1707 | Values: 192.0 214.0 223.0 230.0 247.0 222.0 194.0 195.0 200.0 196.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#3] audio-fft Cycles:10 Average:81.30 Median:71.00 stddev:29.51 (41.6%) stddev-sans-first:30.85 19:57:19 INFO - PROCESS | 1707 | Values: 67.0 75.0 76.0 136.0 48.0 58.0 81.0 77.0 132.0 63.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:112.00 stddev:18.94 (16.9%) stddev-sans-first:20.08 19:57:19 INFO - PROCESS | 1707 | Values: 105.0 82.0 118.0 98.0 110.0 113.0 142.0 82.0 83.0 109.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:91.00 stddev:13.39 (14.7%) stddev-sans-first:13.85 19:57:19 INFO - PROCESS | 1707 | Values: 88.0 94.0 117.0 125.0 90.0 93.0 85.0 92.0 87.0 94.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:96.50 stddev:18.25 (18.9%) stddev-sans-first:19.10 19:57:19 INFO - PROCESS | 1707 | Values: 103.0 98.0 96.0 98.0 98.0 97.0 115.0 130.0 138.0 141.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#7] imaging-desaturate Cycles:10 Average:102.30 Median:92.50 stddev:19.68 (21.3%) stddev-sans-first:20.51 19:57:19 INFO - PROCESS | 1707 | Values: 92.0 93.0 91.0 92.0 91.0 96.0 94.0 139.0 140.0 95.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.41 (4.3%) stddev-sans-first:2.55 19:57:19 INFO - PROCESS | 1707 | Values: 57.0 56.0 57.0 55.0 56.0 57.0 54.0 63.0 56.0 56.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:80.00 stddev:16.42 (20.5%) stddev-sans-first:16.89 19:57:19 INFO - PROCESS | 1707 | Values: 65.0 67.0 69.0 97.0 97.0 60.0 55.0 69.0 94.0 91.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.50 stddev:9.78 (11.4%) stddev-sans-first:9.01 19:57:19 INFO - PROCESS | 1707 | Values: 75.0 81.0 92.0 109.0 101.0 87.0 86.0 85.0 87.0 85.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:134.50 stddev:10.00 (7.4%) stddev-sans-first:10.52 19:57:19 INFO - PROCESS | 1707 | Values: 129.0 127.0 154.0 142.0 134.0 124.0 135.0 137.0 124.0 121.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:147.50 stddev:13.56 (9.2%) stddev-sans-first:13.93 19:57:19 INFO - PROCESS | 1707 | Values: 135.0 142.0 143.0 145.0 115.0 154.0 167.0 150.0 143.0 152.0 19:57:19 INFO - PROCESS | 1707 | 19:57:19 INFO - PROCESS | 1707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.00 stddev:11.62 (15.5%) stddev-sans-first:10.95 19:57:19 INFO - PROCESS | 1707 | Values: 60.0 83.0 95.0 92.0 79.0 69.0 66.0 67.0 71.0 70.0 19:57:19 INFO - PROCESS | 1707 | -------- Summary: end -------- 19:57:19 INFO - PROCESS | 1707 | 19:57:20 INFO - TEST-INFO | 1707: exit 0 19:57:20 INFO - TEST-OK | kraken | took 58111ms 19:57:20 INFO - SUITE-END | took 1169s 19:57:21 INFO - Completed test suite (00:19:29) 19:57:21 INFO - Working with test: dromaeo_css 19:57:21 INFO - Generating results file: dromaeo_css 19:57:21 INFO - Working with test: kraken 19:57:21 INFO - Generating results file: kraken 19:57:21 INFO - javascript benchmark 19:57:21 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:57:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 19:57:21 INFO - process_Request line: dromaeo_css 7526.81 graph.html#tests=[[72,1,61]] 19:57:21 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:57:21 INFO - process_Request line: kraken 1534.80 graph.html#tests=[[232,1,61]] 19:57:21 INFO - RETURN: dromaeo_css: 7526.81 19:57:21 INFO - RETURN: kraken: 1534.80 19:57:21 INFO - javascript benchmark 19:57:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3529.382358087336, 3535.7878527288362, 3588.4079126944025, 3588.4617307403887, 3594.5506811648543, 5645.350784659765, 5779.04645733454, 5781.682007489587, 5828.650280983144, 5855.063189889618, 5804.912926306109, 5879.0593505039205, 5918.822435326936, 5941.16823644689, 5955.434233747797, 5239.397469291023, 5300.178472336775, 5375.489328513785, 5442.619016668835, 5512.310961129859, 5251.107311756991, 5368.731563421833, 5372.973135134319, 5409.540189083913, 5440.265564148829, 5046.419661738911, 5222.660527065728, 5268.9736551317, 5292.285541451894, 5361.892762144736, 5311.548518375943, 5327.0, 5339.599530035224, 5377.085895397791, 5444.210589464506, 4452.1763473757455, 4531.773411329454, 4973.154563724175, 5236.685798852043, 5386.78452861885, 5657.8019769307875, 5747.339056008529, 5783.62406443584, 5788.421157884178, 5806.970965145189, 6229.719662615148, 6242.781502647385, 6243.2508099027955, 6262.780802671885, 6303.621782693007, 6125.846853828645, 6202.534809889276, 6254.8123556293385, 6288.182536270301, 6344.206974128234, 5069.569086627641, 5910.911336329958, 5921.940780592225, 5950.166976623276, 5960.463558279732, 5829.7376618052285, 6250.1874756282305, 6364.459020983176, 6406.167198264196, 6409.327020662857, 6202.038684003986, 6213.937860621426, 6225.00399936008, 6231.688415579203, 6239.906401403982, 6156.860980718492, 6201.627902325875, 6254.186955695731, 6278.4035516625845, 6286.49708023357, 5559.305086864142, 6108.75564977396, 6217.626942383471, 6239.719212635442, 6274.341194174637, 6197.1324014637985, 6250.843728906813, 6259.843503912439, 6269.059641053787, 6270.623762574261, 4973.403191616957, 5011.57401620859, 5012.398512178489, 5023.372078490189, 5034.546890779848, 4377.430933978626, 4407.6914615976575, 4441.022974945507, 4443.666724995638, 4507.301368287921, 5952.315483719428, 5969.04495280753, 5993.430624090704, 6048.879022419527, 6056.242969628796, 6177.351378105324, 6235.812925612239, 6286.748530058838, 6300.30696623371, 6321.715522801485, 5929.881402372014, 5959.910601340984, 5966.463018328372, 5989.670568118708, 6012.458878700938, 5470.7264636768, 5496.1755736639825, 5499.945000550023, 5503.3395992481155, 5512.2558454608115, 6299.559030867796, 6459.741610335628, 6508.837279067871, 6546.672666366568, 6566.573172743756, 6270.12218289449, 6294.653794041188, 6295.244570651551, 6309.905351419824, 6314.652694101685, 6299.181106456132, 6568.14614100183, 6576.177977752781, 6581.14445122131, 6596.142501474969, 6162.568620196723, 6230.15892854477, 6233.065040244, 6243.282022567463, 6263.311035786151, 6147.754089836357, 6176.536759742948, 6244.375562443719, 6278.6546739929745, 6314.747410103544, 6076.848078797889, 6190.2571691397325, 6201.10084037803, 6227.532935029801, 6239.688015599293, 5576.609637325349, 5791.015527360443, 5818.7090645466715, 6112.2299296386045, 6194.256689197326, 5014.7994080236385, 5272.971770504868, 5966.850828729316, 5982.4017598239825, 6134.601250918676, 6076.51387888959, 6133.233345831771, 6188.44304012641, 6240.032794916795, 6272.466840318624, 6092.0, 6109.5831607108885, 6124.0, 6134.068502592042, 6144.910730351523], "unit": "score", "name": "dojo.html", "value": 5765.888573942019}, {"lowerIsBetter": false, "replicates": [419.7083027296031, 468.5712572995709, 501.7842327799046, 565.0507147991374, 600.9003523551895, 27533.0, 37791.622083779155, 37803.81098094513, 37848.99999999996, 37883.62116378835, 30324.54513182304, 38978.22043559134, 39209.60790392095, 39309.41035884457, 39850.00374990627, 9301.162895339417, 9440.952795236015, 9520.619175232983, 9530.475823829687, 9534.952325238364, 9350.485723285217, 9623.23014158869, 9624.80750384992, 9643.0, 9669.226461883032, 9552.474613896233, 9654.227661787076, 9668.75828104296, 9706.805863882719, 9709.902900971007, 9544.33189676723, 9626.037396260353, 9633.277504187214, 9646.131848133666, 9664.371815831948, 8322.375821813388, 9491.525423728786, 9493.38293010959, 9493.810123797555, 9497.382670126488, 38191.427128593095, 38250.043748906224, 38297.234055319015, 38583.0, 38775.61224387777, 2820.3513191965963, 3285.4086264472385, 3310.619278782947, 3410.4372778491766, 3536.0, 26852.73147268522, 27551.862240688868, 27637.0, 27703.0, 27740.30649233785, 2697.136916186821, 2762.3646561291016, 2808.2277373722186, 2955.6305461817274, 2967.7774166937565, 504527.0, 513235.4338228285, 516535.0, 516556.0, 517678.0, 45402.772986134856, 45591.54408455939, 45950.5404945953, 68034.0, 68785.31214687889, 41465.58534414678, 44283.33574996378, 45146.77426612846, 45164.322535162, 45179.87050323703, 15277.38890444392, 15311.846881531264, 15539.30073146711, 15548.455804046804, 15698.450554230547, 12308.076894232789, 12398.0, 12448.81326780099, 12494.187877788096, 12516.81224781629, 14639.26803659834, 14772.335244914004, 14796.334164962387, 14895.0, 15016.624584385478, 6316.021016742412, 6362.236531616236, 6408.295087540367, 6447.580907241015, 6461.095446637474, 989.475577943691, 1061.75048863517, 1089.8964598363143, 1146.1003112556602, 1180.6044974933322, 29988.400231995238, 30081.849590751906, 30250.78996840146, 30590.694093059228, 30630.69369306323, 1057.0909018244304, 1077.3966578715945, 1116.1963386361806, 1130.5251794246435, 1152.3777160333493, 12649.747005059848, 15054.29022775889, 15065.09609423438, 15100.848991509944, 15145.93978421522, 586389.0, 658952.0, 660474.0, 667553.0, 667846.0, 59019.40980590225, 59904.10143847846, 60274.69862650747, 60682.69658651679, 60991.08513372303, 1424.294973987862, 1457.176695167227, 1478.039274471602, 1484.5397926642775, 1496.7576911163708, 23311.650325245475, 31611.0, 31692.366152677278, 31844.840775795972, 32380.0, 53024.73487632537, 53083.0, 53333.200002000776, 53710.0, 53736.193957091455, 420826.0, 422932.0, 423708.0, 423853.0, 424362.0, 41842.58157418509, 42263.15473690571, 44457.77771111124, 44689.10621787611, 44926.55073449224, 46067.76966115148, 46169.30746038745, 46426.535734642224, 46797.766011169726, 47647.0, 38045.42931855969, 38648.42027369648, 38904.416433754086, 39021.6097839018, 39307.2138557233, 37713.245735084594, 37915.43126853044, 38652.22695546017, 39398.0, 39645.80177099096, 32040.67959320377, 35425.0, 35929.28141437209, 36302.0, 38231.235375291784, 29170.416591668472, 31383.0, 33890.830545847115, 34489.0, 34609.48085778665, 21235.893820530797, 24496.26420793305, 24721.011159553418, 24919.87540062288, 25005.74994250034], "unit": "score", "name": "ext.html", "value": 19363.266850891345}, {"lowerIsBetter": false, "replicates": [361.5859840482646, 364.96897763690083, 367.2581385601085, 372.74094504319476, 373.94951681523, 15759.763603545956, 18852.34016809412, 19058.142383592738, 19375.224991000345, 20457.795422045794, 19589.706154407697, 19662.213511459526, 19988.50028749282, 19994.700079498783, 19996.400107996782, 5092.84721458355, 5167.638265321429, 5326.067938110835, 5327.600429967749, 5332.626716129873, 5275.182346736262, 5295.841124766263, 5334.839954801343, 5343.358796944352, 5343.519083282504, 3835.9232815343676, 5271.182966640158, 5330.38700549436, 5336.119540275849, 5705.172749951254, 5859.6777177255235, 5880.206172166767, 5925.229720136398, 5929.8814023719715, 5941.55438342126, 5526.530244929186, 5543.944560554423, 5637.689927054052, 5651.7456714447535, 5676.3755986841825, 13024.54414095502, 13258.53595124166, 13329.133606315558, 13347.19916804985, 15624.76562851558, 2185.2351676913113, 2217.401301648546, 2268.194790849258, 2461.2739241923678, 2657.2028391482477, 9932.00679932001, 9981.251406144569, 9982.301238913278, 10174.44040577768, 10291.279610427273, 1706.3260012295198, 1721.3889069380316, 1740.6866763982478, 1743.111013383171, 1744.659791340689, 106155.0, 107717.0, 108867.0, 112033.43983280113, 112398.0, 11462.083033357312, 11492.54029838797, 11599.0, 11599.246049006788, 11623.12826538013, 13783.241921694202, 13841.0, 13853.861461385257, 13896.51362202318, 13934.86065139356, 8503.787405314917, 8535.53054582004, 8594.183552562497, 8620.698275560326, 8645.9624845019, 7274.199838017814, 7957.283844454027, 8167.693169093035, 8667.869981950276, 8755.299576033902, 4474.105178964221, 4476.7912663580655, 4493.370928070073, 4508.639308855284, 4533.954660453419, 1550.8061492313461, 1694.5509439998411, 1875.831175194239, 1902.8287454129195, 1915.5689969756693, 357.3442732585734, 402.4365887757105, 885.4510203673764, 980.8577756225308, 982.3221976835961, 11101.111911047097, 11815.822762658567, 11826.408679565988, 11844.170908036354, 11993.820092698617, 449.6537665997229, 450.34249995007656, 465.0350522665483, 907.3331101640289, 1020.4387586827215, 10342.482875856178, 10665.933406659273, 10726.98093681099, 10773.78452430947, 11104.111671066295, 534412.0, 536600.0, 536977.0, 548597.0, 549250.0, 75051.0, 120276.39861800635, 121702.0, 122254.0, 125646.0, 462.4335189392967, 481.33575665581975, 482.82859584847574, 1016.6797458800454, 1059.8781140168978, 11250.66248012561, 11334.489947952197, 11396.715082123013, 11471.94264028708, 11848.111391645489, 50950.0, 53069.469305308, 55523.444765553446, 57588.71205644112, 58516.82966340735, 72335.63832180806, 73649.0, 73829.6308518454, 76004.85992710224, 77483.61258193673, 8068.1528439513, 8092.635831387719, 8156.6541520648425, 8291.668333266602, 8336.583170841555, 11671.533138674358, 12649.13853201865, 13441.596752097452, 13630.04589678713, 13925.721485570435, 11331.603393881174, 11634.825477617673, 11646.650600481998, 11667.824982625438, 11700.0, 11131.833022504507, 11396.658100257006, 11452.14108941816, 11469.082473402275, 11654.53381864716, 11425.2002359834, 11777.823332650189, 11787.882121178678, 11875.940620296844, 11906.880931190577, 7946.443748937751, 8107.716229931924, 8184.508929464251, 8286.917130828615, 8325.83348333042, 8461.280791132822, 11306.095512358826, 11713.531458741554, 11734.589289374831, 11738.70653233676], "unit": "score", "name": "jquery.html", "value": 8695.15794478767}, {"lowerIsBetter": false, "replicates": [1402.6353148181472, 1527.4195805593872, 1752.7633769441122, 1917.8849269043849, 1928.758905136858, 8049.154838741935, 8654.74035778926, 8829.29365650748, 9044.23124034457, 9079.63681452742, 8674.522901240429, 8746.650133994648, 8770.166834150745, 8810.911890881089, 8839.381243312955, 2486.0925762096886, 2495.3262619092925, 2508.686414198225, 2520.483300923306, 2521.596544552872, 2418.2382549496942, 2507.059852555292, 2512.6482292478977, 2513.1832154549843, 2518.3955850595817, 2208.86746795192, 2430.9027638894513, 2485.5774518331928, 2504.799616030722, 2540.7586279303528, 2468.0991438125134, 2485.850848949051, 2510.1214574898822, 2513.2209015205344, 2518.25711415133, 2489.265666628349, 2497.9500409991697, 2506.085278873198, 2506.260653107338, 2523.8485690858606, 7719.3052625264, 7827.843443131105, 8218.917810821875, 9019.7294081177, 9024.142706442943, 4654.743989080599, 5374.220737993008, 5499.7250137493365, 5515.393306736256, 5523.530499907512, 3644.6355364463607, 3656.597774244831, 3757.0982964088694, 3772.6415990481137, 3791.7345785795005, 912.8174365126935, 1080.9243352965295, 1104.8066588347087, 1111.2776695148218, 1112.065864673678, 11934.224275422157, 12034.759304813855, 12037.518499260019, 12050.0, 12050.939745301304, 4296.2696341621995, 4915.65590408668, 4954.578860796801, 4954.77703503336, 4991.351124353883, 10109.545070471846, 10192.490375481197, 10195.541200645988, 10227.07956283938, 10249.94875025635, 5423.403425623178, 5481.616286859961, 5488.286522752017, 5497.285352904097, 5510.531604813636, 5009.298698182258, 5018.723970181675, 5027.069992051483, 5027.673201241908, 5075.0357432087785, 3987.541432735273, 4029.194161167778, 4042.8787136385954, 4078.7960601969785, 4089.2639324921206, 1334.873187047229, 1342.9597112086458, 1351.8850897673808, 1369.7260547890462, 1370.4586688258082, 844.7254642241173, 1116.6147679050714, 1140.492480846032, 1225.4301749686438, 1317.9077464577388, 7976.05484599552, 8033.55815430157, 8039.316658084012, 8088.595570221465, 8143.633536490872, 1188.9108316876268, 1193.1051711216587, 1210.5883999440232, 1217.2453079090844, 1225.6751960730414, 6164.938350616526, 6189.226346706661, 6200.689965501707, 6261.499080073583, 6289.119523266746, 9344.392614480037, 10558.472076396303, 10594.417307048187, 10665.36007839532, 10706.678799636024, 10370.429626370471, 10412.895871041193, 10502.68491945243, 10512.369257844553, 10513.789724205473, 8246.505209687439, 8257.876131858027, 8371.995360556772, 8386.538740369217, 8395.53824539644, 8034.317083048007, 8153.3477321812925, 8155.388345873965, 8242.093369729444, 8383.371247156365, 9674.903250967682, 9835.409875407213, 9896.208303335572, 9897.901020989986, 9934.552945117632, 10062.547185376528, 10177.898221017695, 10237.23220758461, 10322.0, 10359.94820025895, 7602.923970760443, 7617.885731713918, 7735.574543400167, 7739.7678069658, 7762.7671169865, 8219.260266576037, 8322.875156872531, 8354.164583541597, 8395.496270223806, 8425.115362886809, 7489.625518724151, 7646.044244469442, 7683.148274938169, 7718.343940765098, 7718.807029824299, 5620.0, 6501.902471462838, 7335.193128755725, 7336.559806411632, 7352.70589176427, 7653.923460765321, 7737.92262077372, 7772.378209743094, 7786.4938778979185, 7804.804879878048, 6036.3058248302, 6967.2684368142645, 7085.468589855678, 7097.077379940574, 7129.500934934505, 7154.105736782903, 7179.246179151114, 7194.856102878018, 7231.746888858865, 7234.493585448968], "unit": "score", "name": "mootools.html", "value": 4982.647533033468}, {"lowerIsBetter": false, "replicates": [282.23373540836633, 324.6753246753247, 327.5610681686541, 334.5400074897017, 335.85390355195506, 6317.715702793374, 6379.712912918918, 6925.757598484048, 6976.267491913352, 7052.259512751164, 5554.2779438673015, 5860.560457965659, 5873.324567674718, 6636.938089905604, 7085.0, 4472.060867217888, 4475.664325175609, 4786.736729479877, 5145.408278048017, 5184.326037615105, 5063.6202284828605, 5182.041322355376, 5192.454792246816, 5193.376794784631, 5200.92198617021, 5095.261187127864, 5114.284000239951, 5116.283720279164, 5119.539241468267, 5125.820596279131, 4547.86303424144, 4802.327674125625, 4889.193283108283, 4973.15456372414, 5088.389393272794, 4158.209940111369, 4202.033532287561, 4207.389928460356, 4209.915801683949, 4214.7681877496725, 6593.20881494219, 6682.799516014527, 6687.665616719145, 6703.363180497845, 6717.193936727575, 5714.485696287313, 5849.444302791228, 5880.794172203995, 5917.644941303535, 5930.110483427477, 7151.927210918352, 7417.666205020787, 7458.440616953751, 7467.141278752959, 7475.0, 4189.7695626740515, 4246.639035681971, 4373.234683930331, 4714.717116972958, 4735.715857048588, 7948.682052717884, 7996.24035716606, 7996.600169991535, 8006.839863202703, 8014.198580141998, 3654.8903532894055, 4517.119161763425, 4793.904121917542, 4863.270509423614, 4953.851384458472, 5043.3609077050105, 5051.494850514919, 5055.898882022412, 5058.54473097423, 5073.518015788494, 5952.613080149777, 5994.760209591567, 6023.518118550505, 6023.6385816851125, 6042.456178943916, 7522.962385188039, 7531.435142364235, 7531.849363012709, 7545.245475452411, 7546.471746977769, 1744.9302027918995, 1774.5918438759159, 1776.1829558403022, 1777.0759205213217, 1778.5642517583017, 1096.88666004006, 1151.8329842172839, 1158.1892675127444, 1170.5668902506127, 1170.9238899471507, 6947.617881016491, 6976.651167441608, 7000.859982800315, 7008.299170083053, 7038.824029399306, 7721.7683469496005, 7732.149463559004, 7750.651220695082, 7753.534787912743, 7761.4566980311965, 6977.686004129826, 6998.860022799618, 7004.089468369079, 7016.0528328676, 7036.50744447894, 3976.3637817949566, 4087.529934057562, 4108.548059713489, 4124.381342798604, 4135.875923722293, 6901.033855260268, 8144.063432705197, 8149.79625509367, 8232.053313868983, 8247.711330103537, 8090.0, 8107.270345668918, 8109.986251718535, 8130.308923741548, 8137.186281371815, 6897.689603967833, 8171.387145964077, 8185.590720464072, 8253.95873020631, 8256.876146857801, 6666.166729158856, 7242.927570724225, 7849.215078492105, 7877.133515313197, 7889.487183333065, 6450.225972883284, 7629.961850190713, 7705.691772329044, 7710.383169346326, 7721.9227807723455, 6996.195437524546, 8213.178682131738, 8215.507069575844, 8247.546384948886, 8254.628541715758, 4065.6137666921595, 4258.6380157686945, 4587.42657167854, 4814.783334750015, 4819.95180048209, 7431.516951398142, 7462.44031697614, 7545.849083018418, 7765.22347765219, 7834.373250139861, 7402.0, 7452.515586486861, 7462.552246865205, 7475.738349157753, 7485.962570187115, 7098.183708873546, 7414.184439711519, 7430.554166750012, 7434.59109748969, 7454.515456495311, 6976.930230697831, 7239.420846332176, 7240.927590724236, 7250.746223882139, 7287.817804554928, 5637.802676906289, 7375.967364569072, 7442.181360050282, 7458.664360103917, 7470.3276705096805, 7293.161286452126, 7294.96352518234, 7297.744578939712, 7304.488685791944, 7320.853582928418], "unit": "score", "name": "prototype.html", "value": 5369.294151826143}, {"lowerIsBetter": false, "replicates": [664.4385494257351, 674.4402146218638, 675.4123912196388, 722.2272168779408, 729.3326606155365, 14827.406903723851, 15219.619509512268, 15219.923900380496, 17286.827131728678, 17439.476815695518, 15694.293756780944, 15968.680626387466, 15980.520584382488, 16071.678566428664, 16151.838481615181, 709.4608097845648, 866.1598249697784, 877.1535468273099, 885.5660726244126, 902.1204325782376, 872.4852337121097, 881.7398867334152, 883.5228976352762, 888.5868071346822, 890.3722875372847, 900.1988230474883, 928.2759447630825, 942.180303136269, 943.2406912435487, 944.2540393089452, 843.2242337049929, 899.3344924755667, 921.3642586615281, 925.2366797392144, 934.4626839567208, 663.2008429842028, 671.6238906212487, 690.5097380859596, 694.5381321421249, 696.8014115976973, 13294.86705132946, 15180.468683596022, 15351.155686437241, 15371.769423458658, 15393.923030384889, 12717.872821271761, 12776.361181940958, 12780.680482987907, 13082.280474573894, 13231.272280024596, 9959.352642078242, 10095.0, 10145.289829711923, 10408.01123893229, 10823.621173258976, 3138.10563989262, 3465.844037018315, 3518.595361533405, 3527.682508574215, 3580.427131658922, 86636.56681716614, 87539.99999999936, 87611.0, 87662.56168719116, 87740.0, 8437.409381343246, 9214.539273036322, 9229.0, 9302.25581953442, 9620.278479114095, 20318.18727250923, 20405.795942040688, 20515.794842051688, 20524.281650142173, 20598.691019634716, 7089.751858684921, 7134.678939447737, 7241.2396698346965, 7336.596487193149, 7539.434542409341, 3922.2351641429645, 3928.194720082376, 3978.522577290744, 4002.239574480839, 4013.658838998718, 3602.585702644177, 3608.1520842601967, 3617.5839778425293, 3633.6729694327637, 3650.1604630935035, 662.3641304347784, 662.5925056090566, 679.6262055869253, 681.2029924987776, 683.702589373624, 570.395380896243, 580.901246788047, 589.7464090441066, 597.1772499196661, 619.3713380918372, 8202.0, 8481.618327175293, 8582.313414926792, 8646.135386461303, 8832.337574681924, 523.7041071794424, 582.860507707431, 607.8723468071754, 613.8189234175928, 623.1929651101743, 3865.4974853268895, 3885.0287428142965, 3909.9413508797393, 4059.6752259819145, 4137.731047481904, 94483.05516944743, 97620.0, 97695.02304977001, 97988.51005744925, 98335.0, 80565.59717201376, 82241.58879205566, 82935.17064829274, 83032.0, 83404.0, 54743.72628136834, 69383.0, 69878.3012169882, 77193.6140319306, 77204.2279577197, 8746.387752857494, 8789.956050219964, 8801.735947921572, 8866.024737279024, 9206.0, 51358.48641513687, 51927.0, 51949.22076168936, 52699.0, 53344.0, 69197.30802691908, 72351.63824181056, 72771.63614181895, 74336.62831685807, 75773.0, 10903.400312982545, 11147.331160130418, 11222.214444988773, 11542.711432213926, 11591.304521728724, 12067.879321206676, 12119.272843629411, 12131.757364852478, 12736.936315318364, 13068.215907045607, 9673.78407494379, 11852.585159519376, 11952.880471195176, 12059.336736479578, 12060.939695301468, 11489.253198542068, 11512.30926144434, 11515.596954106566, 11781.587644432746, 12538.561150359694, 11070.335779853234, 11203.495842686936, 11262.662120136409, 11278.379689117177, 11749.941250293694, 8509.91490085116, 9556.713298601053, 9581.041895810364, 9986.850197246902, 10377.377357358582, 8467.872981905153, 8980.506072166094, 9912.553935073083, 9920.40477571348, 9959.800803983735], "unit": "score", "name": "yui.html", "value": 7000.582700311619}], "name": "dromaeo_css", "value": 7526.8093074967255}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 117.0, 114.0, 117.0, 126.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 142.0, 148.0, 121.0, 140.0, 137.0, 122.0, 159.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 137.9}, {"lowerIsBetter": true, "replicates": [192.0, 214.0, 223.0, 230.0, 247.0, 222.0, 194.0, 195.0, 200.0, 196.0], "unit": "score", "name": "audio-dft", "value": 211.3}, {"lowerIsBetter": true, "replicates": [67.0, 75.0, 76.0, 136.0, 48.0, 58.0, 81.0, 77.0, 132.0, 63.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [105.0, 82.0, 118.0, 98.0, 110.0, 113.0, 142.0, 82.0, 83.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 104.2}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 117.0, 125.0, 90.0, 93.0, 85.0, 92.0, 87.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.5}, {"lowerIsBetter": true, "replicates": [103.0, 98.0, 96.0, 98.0, 98.0, 97.0, 115.0, 130.0, 138.0, 141.0], "unit": "score", "name": "imaging-darkroom", "value": 111.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 91.0, 92.0, 91.0, 96.0, 94.0, 139.0, 140.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 102.3}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 55.0, 56.0, 57.0, 54.0, 63.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 69.0, 97.0, 97.0, 60.0, 55.0, 69.0, 94.0, 91.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.4}, {"lowerIsBetter": true, "replicates": [75.0, 81.0, 92.0, 109.0, 101.0, 87.0, 86.0, 85.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 154.0, 142.0, 134.0, 124.0, 135.0, 137.0, 124.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.7}, {"lowerIsBetter": true, "replicates": [135.0, 142.0, 143.0, 145.0, 115.0, 154.0, 167.0, 150.0, 143.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [60.0, 83.0, 95.0, 92.0, 79.0, 69.0, 66.0, 67.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.2}], "name": "kraken", "value": 1534.8}]} 19:57:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1534.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7526.81"}}} 19:57:21 INFO - Return code: 0 19:57:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:57:21 ERROR - # TBPL SUCCESS # 19:57:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:57:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:57:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:57:21 INFO - 2016-02-20 19:57:21.711 screenresolution[1712:19441] starting screenresolution argv=screenresolution get 19:57:21 INFO - 2016-02-20 19:57:21.714 screenresolution[1712:19441] Display 0: 1600x1200x32@60 19:57:21 INFO - 2016-02-20 19:57:21.719 screenresolution[1713:19444] starting screenresolution argv=screenresolution list 19:57:21 INFO - Available Modes on Display 0 19:57:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:57:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:57:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:57:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:57:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:57:21 INFO - Intel Iris: 19:57:21 INFO - Chipset Model: Intel Iris 19:57:21 INFO - Type: GPU 19:57:21 INFO - Bus: Built-In 19:57:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:57:21 INFO - Vendor: Intel (0x8086) 19:57:21 INFO - Device ID: 0x0a2e 19:57:21 INFO - Revision ID: 0x0009 19:57:21 INFO - Displays: 19:57:21 INFO - Display: 19:57:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:57:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:57:21 INFO - Display Serial Number: 1600x1200 60 19:57:21 INFO - Main Display: Yes 19:57:21 INFO - Mirror: Off 19:57:21 INFO - Online: Yes 19:57:21 INFO - Rotation: Supported 19:57:21 INFO - Return code: 0 19:57:21 INFO - Running post-action listener: _resource_record_post_action 19:57:21 INFO - Running post-run listener: _resource_record_post_run 19:57:23 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 33611264; Write bytes: 712338432; Read time: 349; Write time: 2379 19:57:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401562112; Write bytes: 394561024; Read time: 30119; Write time: 989 19:57:23 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 31829504; Write bytes: 304113152; Read time: 331; Write time: 1352 19:57:23 INFO - Running post-run listener: _upload_blobber_files 19:57:23 INFO - Blob upload gear active. 19:57:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:57:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:57:23 INFO - (blobuploader) - INFO - Open directory for files ... 19:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:24 INFO - (blobuploader) - INFO - Done attempting. 19:57:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:57:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:57:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:25 INFO - (blobuploader) - INFO - Done attempting. 19:57:25 INFO - (blobuploader) - INFO - Iteration through files over. 19:57:25 INFO - Return code: 0 19:57:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:57:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:57:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369912fe23946aa426ce2cd10cffd2d965889bf9cfc226676256c1068541a6f27e33e23b81141a2195c0c5bcb87bf24df8eac26c1820cdc1105037e21d9ad9d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bf328b50ca8cc7f18b8022ec9be3bd312cf19af8cd913197b94a713ac07f1451884777b57acdb37740faea979b902c0d2ff2c8872309efb3de13a4e00c4873c"} 19:57:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:57:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:57:25 INFO - Contents: 19:57:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/369912fe23946aa426ce2cd10cffd2d965889bf9cfc226676256c1068541a6f27e33e23b81141a2195c0c5bcb87bf24df8eac26c1820cdc1105037e21d9ad9d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bf328b50ca8cc7f18b8022ec9be3bd312cf19af8cd913197b94a713ac07f1451884777b57acdb37740faea979b902c0d2ff2c8872309efb3de13a4e00c4873c"} 19:57:25 INFO - Running post-run listener: copy_logs_to_upload_dir 19:57:25 INFO - Copying logs to upload dir... 19:57:25 INFO - mkdir: /builds/slave/test/build/upload/logs 19:57:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.445502 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-20 19:57:25.215849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-20 19:57:25.219001) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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/369912fe23946aa426ce2cd10cffd2d965889bf9cfc226676256c1068541a6f27e33e23b81141a2195c0c5bcb87bf24df8eac26c1820cdc1105037e21d9ad9d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bf328b50ca8cc7f18b8022ec9be3bd312cf19af8cd913197b94a713ac07f1451884777b57acdb37740faea979b902c0d2ff2c8872309efb3de13a4e00c4873c"} build_url:https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/PS6O4OkQQaWBe5-PHtp68Q/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/369912fe23946aa426ce2cd10cffd2d965889bf9cfc226676256c1068541a6f27e33e23b81141a2195c0c5bcb87bf24df8eac26c1820cdc1105037e21d9ad9d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bf328b50ca8cc7f18b8022ec9be3bd312cf19af8cd913197b94a713ac07f1451884777b57acdb37740faea979b902c0d2ff2c8872309efb3de13a4e00c4873c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-20 19:57:25.249177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:57:25.249505) ========= 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.b90OHcXDXT/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.4ZIVBeRZgs/Listeners TMPDIR=/var/folders/50/y6p535kd1q35zcnf_4b_jx_400000w/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.005372 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-20 19:57:25.300526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-20 19:57:25.303893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-20 19:57:25.304321) ========= ========= Total master_lag: 2.84 =========