builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0147 starttime: 1455194755.84 results: success (0) buildid: 20160211024834 builduid: 45974838395e414884e854445bef27c6 revision: b21946a2e9933fa9167456ce6b3866381f6f52c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.840748) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.841238) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.841582) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005692 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.865266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.865607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.881720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.882041) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.930465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.930787) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.931154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:55.931457) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-11 04:45:55-- 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.3M=0.001s 2016-02-11 04:45:56 (16.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:56.120174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:56.120618) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.025404 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:56.169530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 04:45:56.169965) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b21946a2e9933fa9167456ce6b3866381f6f52c5 --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 b21946a2e9933fa9167456ce6b3866381f6f52c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-11 04:45:56,240 truncating revision to first 12 chars 2016-02-11 04:45:56,240 Setting DEBUG logging. 2016-02-11 04:45:56,241 attempt 1/10 2016-02-11 04:45:56,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b21946a2e993?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 04:45:57,293 unpacking tar archive at: mozilla-central-b21946a2e993/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 04:45:57.486842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:57.487237) ========= echo b21946a2e9933fa9167456ce6b3866381f6f52c5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b21946a2e9933fa9167456ce6b3866381f6f52c5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 b21946a2e9933fa9167456ce6b3866381f6f52c5 program finished with exit code 0 elapsedTime=0.005570 script_repo_revision: 'b21946a2e9933fa9167456ce6b3866381f6f52c5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:57.537341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:57.537702) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 04:45:57.550430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-11 04:45:57.550724) ========= /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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:45:57 INFO - MultiFileLogger online at 20160211 04:45:57 in /builds/slave/test 04:45:57 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 04:45:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:45:57 INFO - {'append_to_log': False, 04:45:57 INFO - 'base_work_dir': '/builds/slave/test', 04:45:57 INFO - 'blob_upload_branch': 'Firefox', 04:45:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:45:57 INFO - 'branch': 'Firefox', 04:45:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:45:57 INFO - 'config_files': ('talos/mac_config.py',), 04:45:57 INFO - 'default_actions': ('clobber', 04:45:57 INFO - 'read-buildbot-config', 04:45:57 INFO - 'download-and-extract', 04:45:57 INFO - 'populate-webroot', 04:45:57 INFO - 'create-virtualenv', 04:45:57 INFO - 'install', 04:45:57 INFO - 'run-tests'), 04:45:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:45:57 INFO - 'download_minidump_stackwalk': True, 04:45:57 INFO - 'download_symbols': 'ondemand', 04:45:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:45:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:45:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:45:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:45:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:45:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:45:57 INFO - 'installer_path': 'installer.exe', 04:45:57 INFO - 'log_level': 'info', 04:45:57 INFO - 'log_name': 'talos', 04:45:57 INFO - 'log_to_console': True, 04:45:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:45:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:45:57 INFO - 'opt_config_files': (), 04:45:57 INFO - 'pip_index': False, 04:45:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:57 INFO - 'cmd': ('bash', 04:45:57 INFO - '-c', 04:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:57 INFO - 'enabled': True, 04:45:57 INFO - 'halt_on_failure': False, 04:45:57 INFO - 'name': 'check_screen_resolution'},), 04:45:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:45:57 INFO - 'cmd': ('bash', 04:45:57 INFO - '-c', 04:45:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:45:57 INFO - 'enabled': True, 04:45:57 INFO - 'halt_on_failure': False, 04:45:57 INFO - 'name': 'check_screen_resolution'},), 04:45:57 INFO - 'run_cmd_checks_enabled': True, 04:45:57 INFO - 'sps_profile': False, 04:45:57 INFO - 'sps_profile_interval': 0, 04:45:57 INFO - 'suite': 'dromaeojs-e10s', 04:45:57 INFO - 'system_bits': '32', 04:45:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:45:57 INFO - 'title': 't-yosemite-r7-0147', 04:45:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:45:57 INFO - 'use_talos_json': True, 04:45:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:45:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:45:57 INFO - 'work_dir': 'build'} 04:45:57 INFO - ##### 04:45:57 INFO - ##### Running clobber step. 04:45:57 INFO - ##### 04:45:57 INFO - Running pre-action listener: _resource_record_pre_action 04:45:57 INFO - Running main action method: clobber 04:45:57 INFO - rmtree: /builds/slave/test/build 04:45:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:45:59 INFO - Running post-action listener: _resource_record_post_action 04:45:59 INFO - ##### 04:45:59 INFO - ##### Running read-buildbot-config step. 04:45:59 INFO - ##### 04:45:59 INFO - Running pre-action listener: _resource_record_pre_action 04:45:59 INFO - Running main action method: read_buildbot_config 04:45:59 INFO - Using buildbot properties: 04:45:59 INFO - { 04:45:59 INFO - "project": "", 04:45:59 INFO - "product": "firefox", 04:45:59 INFO - "script_repo_revision": "production", 04:45:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:45:59 INFO - "repository": "", 04:45:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:45:59 INFO - "buildid": "20160211024834", 04:45:59 INFO - "pgo_build": "False", 04:45:59 INFO - "basedir": "/builds/slave/test", 04:45:59 INFO - "buildnumber": 105, 04:45:59 INFO - "slavename": "t-yosemite-r7-0147", 04:45:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:45:59 INFO - "platform": "yosemite_r7", 04:45:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:45:59 INFO - "branch": "mozilla-central", 04:45:59 INFO - "repo_path": "mozilla-central", 04:45:59 INFO - "revision": "b21946a2e9933fa9167456ce6b3866381f6f52c5", 04:45:59 INFO - "stage_platform": "macosx64", 04:45:59 INFO - "builduid": "45974838395e414884e854445bef27c6", 04:45:59 INFO - "slavebuilddir": "test" 04:45:59 INFO - } 04:45:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:45:59 INFO - Running post-action listener: _resource_record_post_action 04:45:59 INFO - ##### 04:45:59 INFO - ##### Running download-and-extract step. 04:45:59 INFO - ##### 04:45:59 INFO - Running pre-action listener: _resource_record_pre_action 04:45:59 INFO - Running main action method: download_and_extract 04:45:59 INFO - mkdir: /builds/slave/test/build/tests 04:45:59 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')]} 04:45:59 INFO - https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/test_packages.json 04:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/test_packages.json 04:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:46:01 INFO - Downloaded 1277 bytes. 04:46:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:46:01 INFO - Using the following test package requirements: 04:46:01 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:46:01 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:46:01 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:46:01 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'jsshell-mac.zip'], 04:46:01 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:46:01 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:46:01 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:46:01 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:46:01 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:46:01 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:46:01 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:46:01 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:46:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:46: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')]} 04:46:01 INFO - https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:02 INFO - Downloaded 17750554 bytes. 04:46:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:46:05 INFO - Return code: 0 04:46:05 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 04:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:05 INFO - https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:46:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:46:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:46:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:06 INFO - Downloaded 17750554 bytes. 04:46:06 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'] 04:46:06 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 04:46:10 INFO - Return code: 0 04:46: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')]} 04:46:10 INFO - https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:46:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:46:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:46:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:10 INFO - Downloaded 10706547 bytes. 04:46:10 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'] 04:46:10 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 04:46:11 INFO - Return code: 0 04:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:11 INFO - https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:46:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:46:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:46:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:46:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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 04:46:14 INFO - Downloaded 111198893 bytes. 04:46:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:46:14 INFO - mkdir: /builds/slave/test/properties 04:46:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:14 INFO - Contents: 04:46:14 INFO - build_url:https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:46:15 INFO - Running post-action listener: _resource_record_post_action 04:46:15 INFO - Running post-action listener: set_extra_try_arguments 04:46:15 INFO - ##### 04:46:15 INFO - ##### Running populate-webroot step. 04:46:15 INFO - ##### 04:46:15 INFO - Running pre-action listener: _resource_record_pre_action 04:46:15 INFO - Running main action method: populate_webroot 04:46:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:15 INFO - '--tppagecycles', 04:46:15 INFO - '7'], 04:46:15 INFO - 'tests': ['tsvgm']}}, 04:46:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:46:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:46:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'tests': ['damp', 'tps']}, 04:46:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['damp', 'tps']}, 04:46:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:46:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:15 INFO - 'other': {'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'other_l64': {'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'other_nol64': {'tests': ['a11yr', 04:46:15 INFO - 'ts_paint', 04:46:15 INFO - 'tpaint', 04:46:15 INFO - 'sessionrestore', 04:46:15 INFO - 'sessionrestore_no_auto_restore']}, 04:46:15 INFO - 'svgr': {'tests': ['tsvgx', 04:46:15 INFO - 'tsvgr_opacity', 04:46:15 INFO - 'tart', 04:46:15 INFO - 'tscrollx', 04:46:15 INFO - 'cart']}, 04:46:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['tsvgx', 04:46:15 INFO - 'tsvgr_opacity', 04:46:15 INFO - 'tart', 04:46:15 INFO - 'tscrollx', 04:46:15 INFO - 'cart']}, 04:46:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'tests': ['tp5o']}, 04:46:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'talos_options': ['--e10s'], 04:46:15 INFO - 'tests': ['tp5o']}, 04:46:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'talos_options': ['--xperf_path', 04:46:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:15 INFO - 'tests': ['tp5n']}, 04:46:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:15 INFO - 'talos_options': ['--e10s', 04:46:15 INFO - '--xperf_path', 04:46:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:15 INFO - 'tests': ['tp5n']}}, 04:46:15 INFO - 'talos.zip': {'path': '', 04:46:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:15 INFO - Running post-action listener: _resource_record_post_action 04:46:15 INFO - ##### 04:46:15 INFO - ##### Running create-virtualenv step. 04:46:15 INFO - ##### 04:46:15 INFO - Running pre-action listener: _resource_record_pre_action 04:46:15 INFO - Running main action method: create_virtualenv 04:46:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:15 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 04:46:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:15 INFO - Using real prefix '/tools/python27' 04:46:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:19 INFO - Installing pip.................done. 04:46:19 INFO - Return code: 0 04:46:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:19 INFO - 'HOME': '/Users/cltbld', 04:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:19 INFO - 'LOGNAME': 'cltbld', 04:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:19 INFO - 'MOZ_NO_REMOTE': '1', 04:46:19 INFO - 'NO_EM_RESTART': '1', 04:46:19 INFO - 'PAGER': '/bin/cat', 04:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:19 INFO - 'PWD': '/builds/slave/test', 04:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:19 INFO - 'SHELL': '/bin/bash', 04:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:19 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:19 INFO - 'USER': 'cltbld', 04:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:19 INFO - 'XPC_FLAGS': '0x0', 04:46:19 INFO - 'XPC_SERVICE_NAME': '0', 04:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:19 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 04:46:19 INFO - Cleaning up... 04:46:19 INFO - Return code: 0 04:46:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:19 INFO - 'HOME': '/Users/cltbld', 04:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:19 INFO - 'LOGNAME': 'cltbld', 04:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:19 INFO - 'MOZ_NO_REMOTE': '1', 04:46:19 INFO - 'NO_EM_RESTART': '1', 04:46:19 INFO - 'PAGER': '/bin/cat', 04:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:19 INFO - 'PWD': '/builds/slave/test', 04:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:19 INFO - 'SHELL': '/bin/bash', 04:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:19 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:19 INFO - 'USER': 'cltbld', 04:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:19 INFO - 'XPC_FLAGS': '0x0', 04:46:19 INFO - 'XPC_SERVICE_NAME': '0', 04:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:19 INFO - Downloading/unpacking psutil>=0.7.1 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:22 INFO - Installing collected packages: psutil 04:46:22 INFO - Running setup.py install for psutil 04:46:22 INFO - building 'psutil._psutil_osx' extension 04:46:22 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 04:46:22 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 04:46:22 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 04:46:23 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 04:46:23 INFO - building 'psutil._psutil_posix' extension 04:46:23 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 04:46:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:23 INFO - ^ 04:46:23 INFO - 1 warning generated. 04:46:23 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 04:46:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:23 INFO - Successfully installed psutil 04:46:23 INFO - Cleaning up... 04:46:23 INFO - Return code: 0 04:46:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:23 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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:23 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 04:46:23 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 04:46:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:23 INFO - 'HOME': '/Users/cltbld', 04:46:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:23 INFO - 'LOGNAME': 'cltbld', 04:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:23 INFO - 'MOZ_NO_REMOTE': '1', 04:46:23 INFO - 'NO_EM_RESTART': '1', 04:46:23 INFO - 'PAGER': '/bin/cat', 04:46:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:23 INFO - 'PWD': '/builds/slave/test', 04:46:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:23 INFO - 'SHELL': '/bin/bash', 04:46:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:23 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:23 INFO - 'USER': 'cltbld', 04:46:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:23 INFO - 'XPC_FLAGS': '0x0', 04:46:23 INFO - 'XPC_SERVICE_NAME': '0', 04:46:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:46:26 INFO - Installing collected packages: mozsystemmonitor 04:46:26 INFO - Running setup.py install for mozsystemmonitor 04:46:26 INFO - Successfully installed mozsystemmonitor 04:46:26 INFO - Cleaning up... 04:46:26 INFO - Return code: 0 04:46:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:26 INFO - 'HOME': '/Users/cltbld', 04:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:26 INFO - 'LOGNAME': 'cltbld', 04:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:26 INFO - 'MOZ_NO_REMOTE': '1', 04:46:26 INFO - 'NO_EM_RESTART': '1', 04:46:26 INFO - 'PAGER': '/bin/cat', 04:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:26 INFO - 'PWD': '/builds/slave/test', 04:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:26 INFO - 'SHELL': '/bin/bash', 04:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:26 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:26 INFO - 'USER': 'cltbld', 04:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:26 INFO - 'XPC_FLAGS': '0x0', 04:46:26 INFO - 'XPC_SERVICE_NAME': '0', 04:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:46:26 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 04:46:26 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 04:46:26 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 04:46:26 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 04:46:26 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 04:46:26 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 04:46:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:46:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:46:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:46:29 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 04:46:29 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 04:46:29 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 04:46:29 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 04:46:29 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 04:46:29 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 04:46:29 INFO - Downloading docopt-0.6.1.tar.gz 04:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:46:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:46:30 INFO - Running setup.py install for blobuploader 04:46:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:46:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:46:30 INFO - Running setup.py install for requests 04:46:30 INFO - Running setup.py install for docopt 04:46:30 INFO - Successfully installed blobuploader requests docopt 04:46:30 INFO - Cleaning up... 04:46:30 INFO - Return code: 0 04:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46: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')]} 04:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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')]} 04:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:30 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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:30 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 04:46:30 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 04:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:30 INFO - 'HOME': '/Users/cltbld', 04:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:30 INFO - 'LOGNAME': 'cltbld', 04:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:30 INFO - 'MOZ_NO_REMOTE': '1', 04:46:30 INFO - 'NO_EM_RESTART': '1', 04:46:30 INFO - 'PAGER': '/bin/cat', 04:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:30 INFO - 'PWD': '/builds/slave/test', 04:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:30 INFO - 'SHELL': '/bin/bash', 04:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:30 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:30 INFO - 'USER': 'cltbld', 04:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:30 INFO - 'XPC_FLAGS': '0x0', 04:46:30 INFO - 'XPC_SERVICE_NAME': '0', 04:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-daiE6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-_xGyqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ErfAsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WRrkqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Ze70s9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ORBYmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-9VE7sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-M5bMSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:31 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WFgqmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MedV2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-qPwfxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-AcLmtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MaJz_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-xEETXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OvTHs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-_HDkQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:32 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ebT1O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:46:32 INFO - Running setup.py install for manifestparser 04:46:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Running setup.py install for mozcrash 04:46:33 INFO - Running setup.py install for mozdebug 04:46:33 INFO - Running setup.py install for mozdevice 04:46:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Running setup.py install for mozfile 04:46:33 INFO - Running setup.py install for mozhttpd 04:46:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Running setup.py install for mozinfo 04:46:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:46:33 INFO - Running setup.py install for mozInstall 04:46:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Running setup.py install for mozleak 04:46:34 INFO - Running setup.py install for mozlog 04:46:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Running setup.py install for moznetwork 04:46:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Running setup.py install for mozprocess 04:46:34 INFO - Running setup.py install for mozprofile 04:46:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:46:34 INFO - Running setup.py install for mozrunner 04:46:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Running setup.py install for mozscreenshot 04:46:35 INFO - Running setup.py install for moztest 04:46:35 INFO - Running setup.py install for mozversion 04:46:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:46:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:46:35 INFO - Cleaning up... 04:46:35 INFO - Return code: 0 04:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:35 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')]} 04:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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')]} 04:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:35 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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:35 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 04:46:35 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 04:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:35 INFO - 'HOME': '/Users/cltbld', 04:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:35 INFO - 'LOGNAME': 'cltbld', 04:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:35 INFO - 'MOZ_NO_REMOTE': '1', 04:46:35 INFO - 'NO_EM_RESTART': '1', 04:46:35 INFO - 'PAGER': '/bin/cat', 04:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:35 INFO - 'PWD': '/builds/slave/test', 04:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:35 INFO - 'SHELL': '/bin/bash', 04:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:35 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:35 INFO - 'USER': 'cltbld', 04:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:35 INFO - 'XPC_FLAGS': '0x0', 04:46:35 INFO - 'XPC_SERVICE_NAME': '0', 04:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:46:35 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-qa82SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:46:35 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)) 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:46:35 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8dTUzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:46:35 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)) 04:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:46:35 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KUkhEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WwU0VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-2OhmNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-QvSkUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-4rgQ8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-5sm9Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MGQnFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-aukexD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-iAniMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:46:36 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)) 04:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:46:36 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-qTCObV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:46:37 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-p_x8H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:46:37 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-FPEIf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:37 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Sfpt4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:46:37 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-v6bwqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:46:37 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)) 04:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:46:37 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-pnIuA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:46:37 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)) 04:46:37 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)) 04:46:37 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)) 04:46:37 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)) 04:46:37 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)) 04:46:37 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)) 04:46:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:39 INFO - Downloading blessings-1.6.tar.gz 04:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:46:39 INFO - Installing collected packages: blessings 04:46:39 INFO - Running setup.py install for blessings 04:46:40 INFO - Successfully installed blessings 04:46:40 INFO - Cleaning up... 04:46:40 INFO - Return code: 0 04:46:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:46:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:40 INFO - Reading from file tmpfile_stdout 04:46:40 INFO - Current package versions: 04:46:40 INFO - blessings == 1.6 04:46:40 INFO - blobuploader == 1.2.4 04:46:40 INFO - docopt == 0.6.1 04:46:40 INFO - manifestparser == 1.1 04:46:40 INFO - mozInstall == 1.12 04:46:40 INFO - mozcrash == 0.16 04:46:40 INFO - mozdebug == 0.1 04:46:40 INFO - mozdevice == 0.48 04:46:40 INFO - mozfile == 1.2 04:46:40 INFO - mozhttpd == 0.7 04:46:40 INFO - mozinfo == 0.9 04:46:40 INFO - mozleak == 0.1 04:46:40 INFO - mozlog == 3.1 04:46:40 INFO - moznetwork == 0.27 04:46:40 INFO - mozprocess == 0.22 04:46:40 INFO - mozprofile == 0.28 04:46:40 INFO - mozrunner == 6.11 04:46:40 INFO - mozscreenshot == 0.1 04:46:40 INFO - mozsystemmonitor == 0.0 04:46:40 INFO - moztest == 0.7 04:46:40 INFO - mozversion == 1.4 04:46:40 INFO - psutil == 3.1.1 04:46:40 INFO - requests == 1.2.3 04:46:40 INFO - wsgiref == 0.1.2 04:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:40 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 04:46:40 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 04:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:40 INFO - 'HOME': '/Users/cltbld', 04:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PAGER': '/bin/cat', 04:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:40 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - 'XPC_FLAGS': '0x0', 04:46:40 INFO - 'XPC_SERVICE_NAME': '0', 04:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 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)) 04:46:40 INFO - Cleaning up... 04:46:40 INFO - Return code: 0 04:46:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:40 INFO - 'HOME': '/Users/cltbld', 04:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:40 INFO - 'LOGNAME': 'cltbld', 04:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:40 INFO - 'MOZ_NO_REMOTE': '1', 04:46:40 INFO - 'NO_EM_RESTART': '1', 04:46:40 INFO - 'PAGER': '/bin/cat', 04:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:40 INFO - 'PWD': '/builds/slave/test', 04:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:40 INFO - 'SHELL': '/bin/bash', 04:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:40 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:40 INFO - 'USER': 'cltbld', 04:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:40 INFO - 'XPC_FLAGS': '0x0', 04:46:40 INFO - 'XPC_SERVICE_NAME': '0', 04:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:40 INFO - Downloading/unpacking jsonschema 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:46:43 INFO - Downloading/unpacking functools32 (from jsonschema) 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:46:43 INFO - warning: no files found matching '*.txt' 04:46:43 INFO - no previously-included directories found matching 'build' 04:46:43 INFO - no previously-included directories found matching 'dist' 04:46:43 INFO - no previously-included directories found matching '.git*' 04:46:43 INFO - Installing collected packages: jsonschema, functools32 04:46:43 INFO - Running setup.py install for functools32 04:46:43 INFO - warning: no files found matching '*.txt' 04:46:43 INFO - no previously-included directories found matching 'build' 04:46:43 INFO - no previously-included directories found matching 'dist' 04:46:43 INFO - no previously-included directories found matching '.git*' 04:46:43 INFO - Successfully installed jsonschema functools32 04:46:43 INFO - Cleaning up... 04:46:43 INFO - Return code: 0 04:46:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:46:43 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')]} 04:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 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')]} 04:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:43 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 0x10a0b9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb024d0c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, '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.dHNlW7ahw2/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.gYdimEDLca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 04:46:43 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 04:46:43 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 04:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:43 INFO - 'HOME': '/Users/cltbld', 04:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:43 INFO - 'LOGNAME': 'cltbld', 04:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:43 INFO - 'MOZ_NO_REMOTE': '1', 04:46:43 INFO - 'NO_EM_RESTART': '1', 04:46:43 INFO - 'PAGER': '/bin/cat', 04:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:43 INFO - 'PWD': '/builds/slave/test', 04:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:43 INFO - 'SHELL': '/bin/bash', 04:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:46:43 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:43 INFO - 'USER': 'cltbld', 04:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:43 INFO - 'XPC_FLAGS': '0x0', 04:46:43 INFO - 'XPC_SERVICE_NAME': '0', 04:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:44 INFO - Downloading/unpacking flake8 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46: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 04:46:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:46:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:46:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:46 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 04:46:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:46:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:47 INFO - no previously-included directories found matching 'docs/_build' 04:46:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:46:47 INFO - Running setup.py install for pep8 04:46:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:46:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:46:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:46:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:46:47 INFO - no previously-included directories found matching 'docs/_build' 04:46:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:46:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:46:47 INFO - Cleaning up... 04:46:48 INFO - Return code: 0 04:46:48 INFO - Running post-action listener: _resource_record_post_action 04:46:48 INFO - Running post-action listener: _start_resource_monitoring 04:46:48 INFO - Starting resource monitoring. 04:46:48 INFO - ##### 04:46:48 INFO - ##### Running install step. 04:46:48 INFO - ##### 04:46:48 INFO - Running pre-action listener: _resource_record_pre_action 04:46:48 INFO - Running main action method: install 04:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:46:48 INFO - Reading from file tmpfile_stdout 04:46:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:46:48 INFO - Reading from file tmpfile_stdout 04:46:48 INFO - Output received: 04:46:48 INFO - Usage: mozinstall [options] installer 04:46:48 INFO - Options: 04:46:48 INFO - -h, --help show this help message and exit 04:46:48 INFO - -d DEST, --destination=DEST 04:46:48 INFO - Directory to install application into. [default: 04:46:48 INFO - "/builds/slave/test"] 04:46:48 INFO - --app=APP Application being installed. [default: firefox] 04:46:48 INFO - mkdir: /builds/slave/test/build/application 04:46:48 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'] 04:46:48 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 04:47:22 INFO - Reading from file tmpfile_stdout 04:47:22 INFO - Output received: 04:47:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:47:22 INFO - Running post-action listener: _resource_record_post_action 04:47:22 INFO - ##### 04:47:22 INFO - ##### Running run-tests step. 04:47:22 INFO - ##### 04:47:22 INFO - Running pre-action listener: _resource_record_pre_action 04:47:22 INFO - Running main action method: run_tests 04:47:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:22 INFO - 2016-02-11 04:47:22.658 screenresolution[1652:7528] starting screenresolution argv=screenresolution get 04:47:22 INFO - 2016-02-11 04:47:22.661 screenresolution[1652:7528] Display 0: 1600x1200x32@60 04:47:22 INFO - 2016-02-11 04:47:22.667 screenresolution[1653:7530] starting screenresolution argv=screenresolution list 04:47:22 INFO - Available Modes on Display 0 04:47:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:22 INFO - Intel Iris: 04:47:22 INFO - Chipset Model: Intel Iris 04:47:22 INFO - Type: GPU 04:47:22 INFO - Bus: Built-In 04:47:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:22 INFO - Vendor: Intel (0x8086) 04:47:22 INFO - Device ID: 0x0a2e 04:47:22 INFO - Revision ID: 0x0009 04:47:22 INFO - Displays: 04:47:22 INFO - Display: 04:47:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:22 INFO - Display Serial Number: 1600x1200 60 04:47:22 INFO - Main Display: Yes 04:47:22 INFO - Mirror: Off 04:47:22 INFO - Online: Yes 04:47:22 INFO - Rotation: Supported 04:47:22 INFO - Return code: 0 04:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:22 INFO - Python 2.7.3 04:47:22 INFO - Return code: 0 04:47:22 INFO - grabbing minidump binary from tooltool 04:47: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')]} 04:47:22 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 0x109f5dd30>, '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 0x109d81db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f54b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:22 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 04:47:22 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 04:47:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:22 INFO - Return code: 0 04:47:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:24 INFO - Return code: 0 04:47:24 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/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 04:47:24 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/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --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 04:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dHNlW7ahw2/Render', 04:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:24 INFO - 'HOME': '/Users/cltbld', 04:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:24 INFO - 'LOGNAME': 'cltbld', 04:47:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:24 INFO - 'MOZ_NO_REMOTE': '1', 04:47:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:24 INFO - 'NO_EM_RESTART': '1', 04:47:24 INFO - 'PAGER': '/bin/cat', 04:47:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:24 INFO - 'PWD': '/builds/slave/test', 04:47:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:24 INFO - 'SHELL': '/bin/bash', 04:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gYdimEDLca/Listeners', 04:47:24 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 04:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:24 INFO - 'USER': 'cltbld', 04:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:24 INFO - 'XPC_FLAGS': '0x0', 04:47:24 INFO - 'XPC_SERVICE_NAME': '0', 04:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:24 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/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 04:47:24 INFO - mozversion application_buildid: 20160211024834 04:47:24 INFO - mozversion application_changeset: b21946a2e9933fa9167456ce6b3866381f6f52c5 04:47:24 INFO - mozversion application_display_name: Nightly 04:47:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:24 INFO - mozversion application_name: Firefox 04:47:24 INFO - mozversion application_remotingname: firefox 04:47:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:24 INFO - mozversion application_vendor: Mozilla 04:47:24 INFO - mozversion application_version: 47.0a1 04:47:24 INFO - mozversion platform_buildid: 20160211024834 04:47:24 INFO - mozversion platform_changeset: b21946a2e9933fa9167456ce6b3866381f6f52c5 04:47:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:24 INFO - mozversion platform_version: 47.0a1 04:47:24 INFO - using testdate: 1455194844 04:47:24 INFO - actual date: 1455194844 04:47:24 INFO - starting webserver on 'localhost:49278' 04:47:24 INFO - SUITE-START | Running 2 tests 04:47:24 INFO - TEST-START | dromaeo_css 04:47:24 INFO - operating with platform_type : mac_ 04:47:24 INFO - Initialising browser for dromaeo_css test... 04:47:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp9IqFdx/profile http://localhost:49278/getInfo.html) 04:47:27 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 04:47:27 INFO - PROCESS | 1671 | colorDepth:24 04:47:27 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 04:47:27 INFO - PROCESS | 1671 | __metrics 04:47:27 INFO - TEST-INFO | 1671: exit 0 04:47:27 INFO - Browser initialized. 04:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:27 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp9IqFdx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:39 INFO - PROCESS | 1675 | RSS: Main: 256974848 04:47:39 INFO - PROCESS | 1675 | 04:48:29 INFO - PROCESS | 1675 | 1455194909610 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] 04:50:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:50:41 INFO - PROCESS | 1675 | RSS: Main: 274272256 04:50:41 INFO - PROCESS | 1675 | 04:53:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:53:43 INFO - PROCESS | 1675 | RSS: Main: 286867456 04:53:43 INFO - PROCESS | 1675 | 04:56:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:56:46 INFO - PROCESS | 1675 | RSS: Main: 288731136 04:56:46 INFO - PROCESS | 1675 | 04:59:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:59:48 INFO - PROCESS | 1675 | RSS: Main: 290484224 04:59:48 INFO - PROCESS | 1675 | 05:02:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:02:51 INFO - PROCESS | 1675 | RSS: Main: 292503552 05:02:51 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:05:54 INFO - PROCESS | 1675 | RSS: Main: 294436864 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | __start_tp_report 05:05:54 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:05:54 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:05:54 INFO - PROCESS | 1675 | |i|pagename|runs| 05:05:54 INFO - PROCESS | 1675 | |0;dojo.html;2695.703472618012;3543.5393398858178;3543.6279190684963;3573.5711714594254;3601.9599926226124;4834.8791280217965;5759.078547432412;5777.942220577793;5795.710214489269;5807.128930660403;5570.6657600543995;5749.223854779603;5760.222369980052;5786;5928.644281343122;5150.768215430306;5163.7159956202395;5206.895862082756;5228.712420816853;5285.2600635911;5259.631825772198;5280.287161233223;5282.550983166417;5285.154375299952;5288.418273989858;5073.315102461157;5106.31064806252;5201.921971170435;5209.661372010807;5226.8693282667855;5157.252198431206;5216.58267338612;5217.50433708797;5226.346706661668;5278.917821846512;5062.341895553592;5190;5191.740412979374;5196.220566914955;5208.270842082112;4686.601638860701;5334.51989320963;5665.093585026376;5732.197492351074;5732.426757324276;6254.562180647311;6267.937320626781;6274.905876411812;6304.211973503312;6306.463950564207;6148.555089553951;6161.815145545641;6248.218972628421;6258.530610204208;6282.654454005028;5848.853778655568;5849.853753656107;5852.423618177749;5890.705464726747;5941.673207973559;6152.323244443108;6256.405641464054;6282.151909492251;6287.1198032275515;6299.212598425197;5191.558717508979;6105.581053426346;6193.938060619426;6197.96901015501;6200.410960958701;6212.223472065992;6214.875702485925;6248.50011999039;6261.217347831521;6288.685565721696;6122.387761223931;6169.5064394848305;6223.564350495421;6224.439800417984;6276.497880169575;6264.968675156686;6267.62394256346;6281.371862813773;6285.59143655661;6287.402696743802;4021.3565829467143;4872.51274872517;4886.706797592155;4923.236898280772;4976.154053810861;3586.04969683029;4245.3844192591905;4343;4364.214441400515;4456.064226512469;5048.217526283432;5062.215356619729;5324.334458192726;5422.674639521641;5677.205191273225;5424.267723857308;6131.774283661862;6227.1282020517165;6249.843753906189;6262.718177682015;4801.159797035574;5684;5701.914471282934;5703.857403564944;5792.189093526909;5365.570754339644;5383.757730902119;5401.837944861661;5402.6758394496455;5437.483439073281;6190.690465476709;6262.342454042351;6285.731300619408;6336.461400780893;6356.68216589178;5171.844844654666;5319.202119682079;6161.938380616137;6179.660118693335;6238.313785483684;6328.778492752732;6364.713587888464;6371.840703982252;6375.649339286384;6378.425941665272;6082.60463069899;6131.540134489842;6144.709610981744;6208.503319734501;6251.124842522141;6033.42682445167;6147.508199343953;6148.292946311052;6165.198524191826;6190.164327815687;5995.61028533144;6086.756529738938;6122.112293717475;6169.938300616936;6190.938090619216;6145.832291864532;6193.535484838745;6194.752209911553;6228.439440450381;6245.469135123565;5926.762929482945;5981.9401805983125;6054.091886217103;6070.570003774838;6121.173641558333;6002.0996850472775;6134.8159555213415;6181.3200547938795;6197.690115494297;6199.969000154971;6059.151718759289;6096.272074548536;6099.979620341888;6101.45934676866;6108.760397969318 05:05:54 INFO - PROCESS | 1675 | |1;ext.html;490.8821882748139;503.451238150416;522.8666689994053;567.8551969247841;586.3842964886868;30705.846470767643;36875.63124368755;36921.26157476849;37042.814785926064;37078.44382334264;37954.430683539766;38372.42441363382;38484;38606.61393386065;38612;9403.858942115874;9662.420254784736;9708.126268635822;9755.073268039525;9815.362001469917;9556.18772404343;9659.420434773901;9663.033696630317;9674.129328360446;9718.56266468007;9676.225901927864;9686.225101991824;9709.902900971007;9730.756731081708;9732.805343893118;9627.181689556395;9674.613015479372;9714.90285097147;9722.125008749212;9724.513774311292;9387.953060234724;9539.236861051098;9544.761380965532;9557.61769529218;9583.137517623447;37525.81237093824;37549.436758448646;37745.490180393026;38061.619383806086;38087.23825523502;2728.9181324560295;2836.2767494289033;3008.247938015496;3074.2775447769754;3115.8597863096215;26742.73257267422;26906.192814215607;27299.317517062034;27310.863445682644;27376.45247095047;2753.9449211015667;2786.8049236553447;2793.9860300698365;2811.3674423254606;2817.0422056500684;316042;316338;317261;317327;317687;44718.77640611776;44792.3281150783;44942.325865111394;45037.77481112573;59836;43188.784056079516;43537.56462435398;43577.564224357986;43756;43770.781146094065;14804.889633277548;15016.774748378783;15022.774658380133;15185.012974156865;15206.46777362787;11959.820602690967;12038.277703337828;12081.335526546125;12108.910198082214;12231.633051008484;11780.645225798971;11855.644330670093;14421.567352979428;14431.278436078153;14448.711025779636;6167.136600875881;6209.720562574695;6242.001279795211;6283.08895210192;6285.245770507477;910.1717437132311;966.0677446264248;1030.618671091701;1031.0050800977094;1062.7236918401272;27999.160025199275;29060.273493162418;29344.559831602543;29485.26286842846;29901.850490747842;1012.9696109116738;1043.4261156363968;1089.9346039237512;1095.222392101601;1124.454639499842;14882.404703811726;14934.879884008742;15200.695986080438;15234.542963711106;15687.4509392173;519814;522244;525932;526663;527098;46440.83897902579;56368.71815640978;57021;57138.42861571331;57341.85316293651;1373.9313034348243;1399.1605036977733;1404.9859501404856;1443.1990245413897;1451.2380999974887;21529.569408611427;28818.71181288244;29389.265268367606;29482.262943426587;30103.096907091945;48668;49061.50938490712;49271;49312.50687493079;49438.258426124354;463632;463975;466186;466661;468324;30907.536386954664;33329.500057499645;40285.39571906365;44046.11907761763;44121.55878441175;40662.1867562653;41506.792466038685;41793.95515112025;41831.7908410456;42031.7898410506;31107.755689772155;33929;34096.65903340935;35108.366872484155;35470.11324716903;35234.47148292726;35336.29327413386;35787.28425431425;35979.64020359763;36040.8197959019;34662.82668586641;35960.82019589885;36067.81966090153;36368.09079773027;36508;30644.84677576598;32034;32365.51451728179;32478.35043299168;32635;24249.75750242475;24403;24489;24809.503809924063;24911.377215569755 05:05:54 INFO - PROCESS | 1675 | |2;jquery.html;363.61093629816105;369.97040236781044;371.6357969190194;373.1901773152259;374.1170836825093;15232.39070437184;18253.908730456347;18968.051597420126;19308.71036934447;19744.802551974477;11639.534418623245;13274.469021239163;18279.451616451493;18968;18973.810261897375;4000.0599859033105;5148.742562871851;5333.093374126388;5418.160185171305;5808.622439541437;5115.360579927509;5920.230370051887;5956.672383018932;6021.608595441304;6030.728617212236;5972.134040564116;6447.129637498948;6463.321351258121;6474.255460622042;6496.116126323361;5822.563307751914;5973.701314934279;5981.820545383645;6369.522285828558;6431.070678796365;5484.341878974548;5613.831585052455;5662.207290979266;5690.800821971211;5703.486686198221;19562.70655940162;23551.646725299135;23774.405639858967;23966;24046.398840028964;1970.8718933269436;2032.309014934929;2093.1627349060345;2194.5062360968814;2243.25972429098;10081.143102836268;10224;10227.130693891027;13578.932105339509;13870.167789932637;1742.808291087992;1775.2366482412558;1775.5916139287906;1811.8641101917408;1844.206990993872;93151.06848931492;98480;98651.50674246655;98690.50654746681;100283;10321.535530900977;11138.61014864492;11362.48868800906;11433.970942615204;11548.076153907836;13519.391627376792;13621;13669.794953075712;13728.45086196541;13798.586042418743;7056.50604457683;8527.147285271423;8529.914700853036;8570.657173713107;8617.784555386166;7218.025566548554;8535.445196062235;8558.700445484377;8566.785830354167;8608.612612432456;3817.7401457518954;4001.579834117376;4185.22573323936;4225.450691410097;4399.296112621965;1666.5833541614597;1682.2093616000461;1785.9285628574712;1833.5049536625036;1837.7702787151607;743.7991742229676;910.2490445382454;953.8473844184897;960.9951950240204;995.4027583450016;16606.50180494587;17635.735463968052;18656.440306790817;18684.719729204073;19629.116689748997;862.2153840005565;946.2997381937455;947.2564037230741;981.1562056631292;1038.7299302181486;10491.475426228659;10699.893001070046;10703.25077244601;10734.087602553871;10739.946300268604;725085;764191;785482;788742;793295;108705;111957.44021279842;114167;115415.42292288653;117058.41470792591;1117.6647005898199;1131.3777422417638;1131.5869707556847;1147.9196456247982;1147.971300717472;17508.824911751228;17581.912090439466;17768.911155444657;17818.020008899115;17922.551936201176;38971;49570.50429495659;50084;50729.49270507395;50826.74586627043;71243;71888.921666174;72165;72309.6384518074;74126.62936685498;6397;7444.516106453063;7615.7334493292465;7727.884081738666;7755.2244775521995;11161.553537858395;12072.45673944657;12131.42291502099;12271.447784849881;12433.254004759743;10019.348742331726;10294.124999375137;10561.841572376266;10668.253222274367;10669.146468282674;10391.116755075904;10425.947870260903;10450.581976720847;10565.577376904837;10690;10030.498475076363;10530.57877684884;10811.297265677706;10968.725781855199;10997.955194256532;7404.333609975128;7424.96287518559;7679.731209407644;7841.294283514511;7866.9213307866185;9839.901600983898;10333.48332583383;10552;10690.786184276427;10731.248812583044 05:05:54 INFO - PROCESS | 1675 | |3;mootools.html;1324.8873845723112;1519.7872297878296;1739.1043612539545;1901.3440363074735;1916.4346517777271;7976.122626511079;8565.57172141392;8693.000304964931;8898.199162075412;8908.955455222731;8062.758117256477;8587.52768597727;8611.397202195849;8705.477671339724;8729.738107856758;1977.6143651987832;2119.2582596091397;2120.9257675981344;2414.8188885833547;2489.7634724701124;2478.6901637295337;2514.5976643737004;2526.848389096651;2534.9239522814346;2544.414784599543;1924.6631839428114;2013.8892360920142;2190.901409436571;2483.776460118589;2507.122507122511;2437.2810021043833;2437.6709144265565;2473.332200305916;2475.9133430329944;2479.3429741118616;2479.1446950801947;2483.0316176691103;2489.626556016612;2492.19003823758;2516.4086439686657;7909.802254943673;8310.418270721051;8664.306855451548;8703.999040110342;8774.034856165817;5252.343457067866;5444.373897001856;5447.400785913546;5535.225068490415;5561.888762224733;3111.1444352802932;3677.025588219124;3699.2601479704167;3718.1262403335463;3751.8931915085113;950.6672664567416;1055.9577616895315;1064.940384317609;1077.8275475923815;1102.779444111181;11812.763744725058;11910.523579056828;11935.045196384268;11944.28334299936;11948.820767688492;4935;4964.280179373971;5128.205128205134;5129.102407078746;5132.56373208274;9199.77000574991;9249.260059195249;9284.62861485533;9310.581023853943;9322.906770932204;5325.6272060956135;5407.567394608422;5442.374126975369;5443.591730620219;5445.319335083114;5003.7998480061115;5052.065367906949;5070.949290507047;5078.238264260317;5088.542031217208;3412.7611067225057;3726.552813662378;3726.5900750917376;3728.5339332583426;3752.4746535485056;1100.4772732951944;1138.2601309148954;1185.6561597136733;1187.857457105153;1191.93444360561;1004.6031817432073;1088.4992903264429;1097.6213206443765;1247.6943148928572;1371.746226947998;7912.327452166515;8043.235892590194;8051.114377418479;8134.75595732129;8138.186181381933;625.7246811402969;643.5462998585986;644.458654730029;645.9903101453482;787.8936343593541;5272.446393128743;6054.273487181478;6116.235470566179;6247.0629405589525;6256.343083976208;10575.947120264349;10847.457627118612;11026.283291586022;11029.22795404314;11103.167262455348;10762.73093172677;10777.299475534066;10815.18886083547;10826.025657690689;10924.781504370027;8185.508869467851;8320.126386729427;8406.705765298308;8407.70573029941;8483.44857584255;7859.724909628136;7893.842123157619;7907;7918.841623167389;7921.247481489249;7363.77908662741;9465.810683786423;9836.5081745911;9838.163756080814;9942.801143976936;9919.950400247953;9959.203263739028;9972.900270997197;10105.44420056904;10238.283320167517;6904.965475172592;7056.153261608434;7057.929420705933;7068.505204635831;7101.360877521048;8194.180581941759;8231.835363292821;8290.83418331618;8293.087760346478;8302.54336011525;6894.896576551456;7477.289657482531;7825.686972521035;7928.643211055632;8011.998500187477;7594.430417718803;7681.500702454323;7705.537667739729;7756.0304961879765;7800.882986755089;7673.731419400294;7740.496867703581;7804.765857024298;7836.373090152888;7846.6861325548625;6880.4839637026425;7022.052022976833;7060.329268719669;7085.468589855678;7107.289271072851;7107.3603375694365;7142.821429464305;7167.820804479929;7172.175199852084;7185.461090418344 05:05:54 INFO - PROCESS | 1675 | |4;prototype.html;273.36579136403543;330.4448526475522;330.6049271121011;332.0668920333861;334.61352138280296;6025.457708806207;6160.630362178261;6726.966365168179;6814.591124532525;6815.761448349309;6713.2951040140815;6786.796396108112;6814.080099186608;6848.14398200225;6893.345132212432;4930.728809915444;4954.430240522332;4962.6774259673;4969.552740253376;4995.100881841267;4855.927161092586;4996.075725990703;5004.224345226496;5005.6746311489815;5019.974900125512;4955.479674634147;4969.329140566014;4969.353983982077;4982.9252561211615;4985.351904252442;4954.97522512387;4960.107180707471;4978.477259887714;4983.900321993576;5003.17447621142;4254.574542545752;4264.445622069142;4271.103068355649;4279.893002674927;4286.592773686495;6273.592216505958;6506.284308726036;6546.476281897437;6582.9670851645915;6588.242352129519;5908.822735317947;5918.082697181943;5923.4076592340425;5928.318243401977;5933.91099133509;6913.619750913697;6956.721731130749;7001.004713656584;7150.712871683095;7283.162436319838;4704.670673052888;4713.2458806590785;4720.33915251865;4740.241561350167;4793.952060479385;7635.847283054308;7642.656080476392;7648.273414025659;7669.616519174075;7717.189695082048;4730.266808644666;4801.351817504662;4838.419389673261;4839.322494850724;4847.563719265283;4946.134426475424;4951.777170027357;4952.257161425815;4953.00939812039;4955.752212389366;5828.88342233153;5843.474087332161;5846.269216347957;5866.413358664099;5873.295204575393;7257.419406447471;7274.709011639475;7275.126984761757;7276.199618042011;7307.232740562271;1653.3634550698068;1722.9913850430667;1724;1726.1369315342329;1729.524380795266;1119.44027986007;1122.3669560789033;1132.932024078558;1134.6312448454285;1137.3062431916524;6654.168228971379;6660.8667826643195;6703.93296067033;6704.865902681919;6734.158230221223;7518.28576285263;7549.396048316122;7558.319751222416;7575.924240757632;7582.962085189539;4846.3699719037;6359.268684101295;6674.098996635489;6679.365460281266;6682.665866706645;3029.9092326762348;3365.360581489509;4001.3397789365013;4032.6572241359227;4051.7366371186367;6924.4114250289285;7456.96271518639;7933.365330773524;7935.047794264725;7940.920590794018;7582.241775822484;7807.375409967189;7860.842783144305;7864.134945156028;7865.370770338473;6383.36166383358;7008.412092632909;7354;7535.246475352531;7910.16943220965;7441.995330630512;7532.585707786125;7558.9244107558225;7562.621868906643;7580.393568514616;6584.670766461562;6990.161180658353;7405.148407933157;7518.736844210426;7546.698257031658;6451.290607812026;7530.359919406912;7908;7932.246436588515;7934.325582325567;4862.878428039327;4913.459519452929;4918.6556941015215;4930.950690493192;4945.777440015136;7486.288802563748;7496.100467943882;7500.587467689329;7504.812379690551;7507.812304692427;6981.79054628362;7181.097009292437;7213.819654508679;7217.530860494051;7261.164966028974;7211.134663840373;7221.783346499614;7223.494355395072;7231.927680723125;7247.746328878464;6788.287229840796;6993.230744618189;6995.300469952964;7013.754518591825;7015.36861682451;6354.586951848115;6360.554761166674;7212.855742885218;7228.20489746117;7237.312455316736;7035.718571257297;7052.2242553318065;7062.293770622897;7067.187273463617;7091.361777440055 05:05:54 INFO - PROCESS | 1675 | |5;yui.html;696.8989496523008;705.7635692043166;747.1557140431312;755.1655420760059;783.3811289081626;14333.78499322511;15063.17152556609;15161.924190379033;15181.240937953085;15219.08685478872;13957.930210348934;14043.087199332062;14043.297835108255;14055.297235138254;14064.789028164585;677.1298880937995;851.6508231625035;856.7986523167066;873.7990262239689;884.6594061286387;858.5406807358033;864.2437866866492;869.6086760957563;869.9173578510031;873.838339907116;902.3052249767675;907.1065000974036;915.716128000322;918.1736437206534;925.4678559828126;898.0570401078841;904.2675432899373;907.804821963281;910.3400034974657;912.5665308978215;667.6761770541284;669.6484345718488;676.7326905872202;679.0222080204489;686.7802303262957;14688.485902993343;14724.779128313085;14736.115833050051;14751.409943602242;14765.704685906221;10918.454077296183;12885.226886386847;12939.611811645666;13028.674283142997;13198.076134670577;7939.801504962365;10039.598416063349;10097.141742951859;10127.189824813997;10133;3166.5250212468313;3533.487644291589;3609.4946707460977;3611.9277614447565;3623.6738693517445;81432.59283703603;81477;81947;83993.90015249606;84208.15791842065;7568.470207085451;9271.119243671841;9342.112499312554;9396.718098457057;9745.463999480096;20849.478763031046;20892.89553552253;21049.263275785273;21058;21070;7395.334419902235;7504;7635.389168866477;7764.728234511765;7895.01312335958;4139.068709540329;4143.399207114951;4155.148194620096;4161.708680392343;4172.4784401949755;3484.5470088888283;3499.3526197653514;3505.6844883960566;3515.8066306353394;3520.9119772005392;554.2074832988784;651.569963823874;651.8859199640044;676.1683129750435;677.5494296293009;523.332750742806;549.9477549632778;587.7296443635976;616.5622408090306;623.9656818874914;8440.873386899078;8652.307815374756;8719.302455803521;8738.21356077956;8827.69103081389;503.14967704579146;579.8142797978145;608.3733754233147;615.7752420366534;616.2635650397822;3919.0594257378593;4107.363358679409;4134.4005119258145;4158.168366326747;4163.271427500175;85140.57429712811;85478;89545;89670.10329896749;90020.6496902547;74576;74695;74957.25042749612;75520.62239688876;75830;63213.73572528524;65311.67344163249;65619.67190164019;65901.67049164724;67138.66430667815;6810.625415601991;8174.959125204336;8196.877046844183;8270.37972152079;8485.95757021211;38906.02734931536;45295.7735211335;46155.53844461647;47596.04807903753;48229.75885120552;51045.44772761421;55679;61967.07049394173;62868;63751.6812415935;10697.679069627924;10919;10925.562977480811;11006.504707288352;11197.888021119685;11701.707457313636;11779.469923853276;12039.75920481568;12919.031072669775;12993.805092923803;11283.475342369798;11341.20611557216;11689.298642081503;11845.940770296093;12272.754544908874;11240.662780116609;11670.183087183816;11783.234089784137;11841.171118022;12327.815082773586;11152.442377881236;11401.600943966921;11454.14093942941;11544.94227528857;12101.69745756328;9234.676786312446;9316.767080823034;9700.708978730649;9874.456904870302;9998.450085245382;9240.260779137518;9360.950386565997;10069.34757482778;10127.898721012696;10174.593016279267 05:05:54 INFO - PROCESS | 1675 | __end_tp_report 05:05:54 INFO - PROCESS | 1675 | __start_cc_report 05:05:54 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,377 05:05:54 INFO - PROCESS | 1675 | __end_cc_report 05:05:54 INFO - PROCESS | 1675 | __startTimestamp1455195954349__endTimestamp 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:05:54 INFO - PROCESS | 1675 | Number of tests: 6 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5701.06 Median:6002.10 stddev:689.64 (11.5%) stddev-sans-first:650.21 05:05:54 INFO - PROCESS | 1675 | Values: 2695.7 3543.5 3543.6 3573.6 3602.0 4834.9 5759.1 5777.9 5795.7 5807.1 5570.7 5749.2 5760.2 5786.0 5928.6 5150.8 5163.7 5206.9 5228.7 5285.3 5259.6 5280.3 5282.6 5285.2 5288.4 5073.3 5106.3 5201.9 5209.7 5226.9 5157.3 5216.6 5217.5 5226.3 5278.9 5062.3 5190.0 5191.7 5196.2 5208.3 4686.6 5334.5 5665.1 5732.2 5732.4 6254.6 6267.9 6274.9 6304.2 6306.5 6148.6 6161.8 6248.2 6258.5 6282.7 5848.9 5849.9 5852.4 5890.7 5941.7 6152.3 6256.4 6282.2 6287.1 6299.2 5191.6 6105.6 6193.9 6198.0 6200.4 6212.2 6214.9 6248.5 6261.2 6288.7 6122.4 6169.5 6223.6 6224.4 6276.5 6265.0 6267.6 6281.4 6285.6 6287.4 4021.4 4872.5 4886.7 4923.2 4976.2 3586.0 4245.4 4343.0 4364.2 4456.1 5048.2 5062.2 5324.3 5422.7 5677.2 5424.3 6131.8 6227.1 6249.8 6262.7 4801.2 5684.0 5701.9 5703.9 5792.2 5365.6 5383.8 5401.8 5402.7 5437.5 6190.7 6262.3 6285.7 6336.5 6356.7 5171.8 5319.2 6161.9 6179.7 6238.3 6328.8 6364.7 6371.8 6375.6 6378.4 6082.6 6131.5 6144.7 6208.5 6251.1 6033.4 6147.5 6148.3 6165.2 6190.2 5995.6 6086.8 6122.1 6169.9 6190.9 6145.8 6193.5 6194.8 6228.4 6245.5 5926.8 5981.9 6054.1 6070.6 6121.2 6002.1 6134.8 6181.3 6197.7 6200.0 6059.2 6096.3 6100.0 6101.5 6108.8 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:57243.10 Median:36691.82 stddev:118238.08 (322.2%) stddev-sans-first:118492.99 05:05:54 INFO - PROCESS | 1675 | Values: 490.9 503.5 522.9 567.9 586.4 30705.8 36875.6 36921.3 37042.8 37078.4 37954.4 38372.4 38484.0 38606.6 38612.0 9403.9 9662.4 9708.1 9755.1 9815.4 9556.2 9659.4 9663.0 9674.1 9718.6 9676.2 9686.2 9709.9 9730.8 9732.8 9627.2 9674.6 9714.9 9722.1 9724.5 9388.0 9539.2 9544.8 9557.6 9583.1 37525.8 37549.4 37745.5 38061.6 38087.2 2728.9 2836.3 3008.2 3074.3 3115.9 26742.7 26906.2 27299.3 27310.9 27376.5 2753.9 2786.8 2794.0 2811.4 2817.0 316042.0 316338.0 317261.0 317327.0 317687.0 44718.8 44792.3 44942.3 45037.8 59836.0 43188.8 43537.6 43577.6 43756.0 43770.8 14804.9 15016.8 15022.8 15185.0 15206.5 11959.8 12038.3 12081.3 12108.9 12231.6 11780.6 11855.6 14421.6 14431.3 14448.7 6167.1 6209.7 6242.0 6283.1 6285.2 910.2 966.1 1030.6 1031.0 1062.7 27999.2 29060.3 29344.6 29485.3 29901.9 1013.0 1043.4 1089.9 1095.2 1124.5 14882.4 14934.9 15200.7 15234.5 15687.5 519814.0 522244.0 525932.0 526663.0 527098.0 46440.8 56368.7 57021.0 57138.4 57341.9 1373.9 1399.2 1405.0 1443.2 1451.2 21529.6 28818.7 29389.3 29482.3 30103.1 48668.0 49061.5 49271.0 49312.5 49438.3 463632.0 463975.0 466186.0 466661.0 468324.0 30907.5 33329.5 40285.4 44046.1 44121.6 40662.2 41506.8 41794.0 41831.8 42031.8 31107.8 33929.0 34096.7 35108.4 35470.1 35234.5 35336.3 35787.3 35979.6 36040.8 34662.8 35960.8 36067.8 36368.1 36508.0 30644.8 32034.0 32365.5 32478.4 32635.0 24249.8 24403.0 24489.0 24809.5 24911.4 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:38097.14 Median:2218.88 stddev:126931.71 (5720.5%) stddev-sans-first:127256.16 05:05:54 INFO - PROCESS | 1675 | Values: 363.6 370.0 371.6 373.2 374.1 15232.4 18253.9 18968.1 19308.7 19744.8 11639.5 13274.5 18279.5 18968.0 18973.8 4000.1 5148.7 5333.1 5418.2 5808.6 5115.4 5920.2 5956.7 6021.6 6030.7 5972.1 6447.1 6463.3 6474.3 6496.1 5822.6 5973.7 5981.8 6369.5 6431.1 5484.3 5613.8 5662.2 5690.8 5703.5 19562.7 23551.6 23774.4 23966.0 24046.4 1970.9 2032.3 2093.2 2194.5 2243.3 10081.1 10224.0 10227.1 13578.9 13870.2 1742.8 1775.2 1775.6 1811.9 1844.2 93151.1 98480.0 98651.5 98690.5 100283.0 10321.5 11138.6 11362.5 11434.0 11548.1 13519.4 13621.0 13669.8 13728.5 13798.6 7056.5 8527.1 8529.9 8570.7 8617.8 7218.0 8535.4 8558.7 8566.8 8608.6 3817.7 4001.6 4185.2 4225.5 4399.3 1666.6 1682.2 1785.9 1833.5 1837.8 743.8 910.2 953.8 961.0 995.4 16606.5 17635.7 18656.4 18684.7 19629.1 862.2 946.3 947.3 981.2 1038.7 10491.5 10699.9 10703.3 10734.1 10739.9 725085.0 764191.0 785482.0 788742.0 793295.0 108705.0 111957.4 114167.0 115415.4 117058.4 1117.7 1131.4 1131.6 1147.9 1148.0 17508.8 17581.9 17768.9 17818.0 17922.6 38971.0 49570.5 50084.0 50729.5 50826.7 71243.0 71888.9 72165.0 72309.6 74126.6 6397.0 7444.5 7615.7 7727.9 7755.2 11161.6 12072.5 12131.4 12271.4 12433.3 10019.3 10294.1 10561.8 10668.3 10669.1 10391.1 10425.9 10450.6 10565.6 10690.0 10030.5 10530.6 10811.3 10968.7 10998.0 7404.3 7425.0 7679.7 7841.3 7866.9 9839.9 10333.5 10552.0 10690.8 10731.2 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:6018.37 Median:5548.56 stddev:3213.54 (57.9%) stddev-sans-first:3203.18 05:05:54 INFO - PROCESS | 1675 | Values: 1324.9 1519.8 1739.1 1901.3 1916.4 7976.1 8565.6 8693.0 8898.2 8909.0 8062.8 8587.5 8611.4 8705.5 8729.7 1977.6 2119.3 2120.9 2414.8 2489.8 2478.7 2514.6 2526.8 2534.9 2544.4 1924.7 2013.9 2190.9 2483.8 2507.1 2437.3 2437.7 2473.3 2475.9 2479.3 2479.1 2483.0 2489.6 2492.2 2516.4 7909.8 8310.4 8664.3 8704.0 8774.0 5252.3 5444.4 5447.4 5535.2 5561.9 3111.1 3677.0 3699.3 3718.1 3751.9 950.7 1056.0 1064.9 1077.8 1102.8 11812.8 11910.5 11935.0 11944.3 11948.8 4935.0 4964.3 5128.2 5129.1 5132.6 9199.8 9249.3 9284.6 9310.6 9322.9 5325.6 5407.6 5442.4 5443.6 5445.3 5003.8 5052.1 5070.9 5078.2 5088.5 3412.8 3726.6 3726.6 3728.5 3752.5 1100.5 1138.3 1185.7 1187.9 1191.9 1004.6 1088.5 1097.6 1247.7 1371.7 7912.3 8043.2 8051.1 8134.8 8138.2 625.7 643.5 644.5 646.0 787.9 5272.4 6054.3 6116.2 6247.1 6256.3 10575.9 10847.5 11026.3 11029.2 11103.2 10762.7 10777.3 10815.2 10826.0 10924.8 8185.5 8320.1 8406.7 8407.7 8483.4 7859.7 7893.8 7907.0 7918.8 7921.2 7363.8 9465.8 9836.5 9838.2 9942.8 9920.0 9959.2 9972.9 10105.4 10238.3 6905.0 7056.2 7057.9 7068.5 7101.4 8194.2 8231.8 8290.8 8293.1 8302.5 6894.9 7477.3 7825.7 7928.6 8012.0 7594.4 7681.5 7705.5 7756.0 7800.9 7673.7 7740.5 7804.8 7836.4 7846.7 6880.5 7022.1 7060.3 7085.5 7107.3 7107.4 7142.8 7167.8 7172.2 7185.5 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5896.87 Median:6667.48 stddev:1869.07 (28.0%) stddev-sans-first:1826.03 05:05:54 INFO - PROCESS | 1675 | Values: 273.4 330.4 330.6 332.1 334.6 6025.5 6160.6 6727.0 6814.6 6815.8 6713.3 6786.8 6814.1 6848.1 6893.3 4930.7 4954.4 4962.7 4969.6 4995.1 4855.9 4996.1 5004.2 5005.7 5020.0 4955.5 4969.3 4969.4 4982.9 4985.4 4955.0 4960.1 4978.5 4983.9 5003.2 4254.6 4264.4 4271.1 4279.9 4286.6 6273.6 6506.3 6546.5 6583.0 6588.2 5908.8 5918.1 5923.4 5928.3 5933.9 6913.6 6956.7 7001.0 7150.7 7283.2 4704.7 4713.2 4720.3 4740.2 4794.0 7635.8 7642.7 7648.3 7669.6 7717.2 4730.3 4801.4 4838.4 4839.3 4847.6 4946.1 4951.8 4952.3 4953.0 4955.8 5828.9 5843.5 5846.3 5866.4 5873.3 7257.4 7274.7 7275.1 7276.2 7307.2 1653.4 1723.0 1724.0 1726.1 1729.5 1119.4 1122.4 1132.9 1134.6 1137.3 6654.2 6660.9 6703.9 6704.9 6734.2 7518.3 7549.4 7558.3 7575.9 7583.0 4846.4 6359.3 6674.1 6679.4 6682.7 3029.9 3365.4 4001.3 4032.7 4051.7 6924.4 7457.0 7933.4 7935.0 7940.9 7582.2 7807.4 7860.8 7864.1 7865.4 6383.4 7008.4 7354.0 7535.2 7910.2 7442.0 7532.6 7558.9 7562.6 7580.4 6584.7 6990.2 7405.1 7518.7 7546.7 6451.3 7530.4 7908.0 7932.2 7934.3 4862.9 4913.5 4918.7 4931.0 4945.8 7486.3 7496.1 7500.6 7504.8 7507.8 6981.8 7181.1 7213.8 7217.5 7261.2 7211.1 7221.8 7223.5 7231.9 7247.7 6788.3 6993.2 6995.3 7013.8 7015.4 6354.6 6360.6 7212.9 7228.2 7237.3 7035.7 7052.2 7062.3 7067.2 7091.4 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:17651.47 Median:612.07 stddev:24446.40 (3994.0%) stddev-sans-first:24481.83 05:05:54 INFO - PROCESS | 1675 | Values: 696.9 705.8 747.2 755.2 783.4 14333.8 15063.2 15161.9 15181.2 15219.1 13957.9 14043.1 14043.3 14055.3 14064.8 677.1 851.7 856.8 873.8 884.7 858.5 864.2 869.6 869.9 873.8 902.3 907.1 915.7 918.2 925.5 898.1 904.3 907.8 910.3 912.6 667.7 669.6 676.7 679.0 686.8 14688.5 14724.8 14736.1 14751.4 14765.7 10918.5 12885.2 12939.6 13028.7 13198.1 7939.8 10039.6 10097.1 10127.2 10133.0 3166.5 3533.5 3609.5 3611.9 3623.7 81432.6 81477.0 81947.0 83993.9 84208.2 7568.5 9271.1 9342.1 9396.7 9745.5 20849.5 20892.9 21049.3 21058.0 21070.0 7395.3 7504.0 7635.4 7764.7 7895.0 4139.1 4143.4 4155.1 4161.7 4172.5 3484.5 3499.4 3505.7 3515.8 3520.9 554.2 651.6 651.9 676.2 677.5 523.3 549.9 587.7 616.6 624.0 8440.9 8652.3 8719.3 8738.2 8827.7 503.1 579.8 608.4 615.8 616.3 3919.1 4107.4 4134.4 4158.2 4163.3 85140.6 85478.0 89545.0 89670.1 90020.6 74576.0 74695.0 74957.3 75520.6 75830.0 63213.7 65311.7 65619.7 65901.7 67138.7 6810.6 8175.0 8196.9 8270.4 8486.0 38906.0 45295.8 46155.5 47596.0 48229.8 51045.4 55679.0 61967.1 62868.0 63751.7 10697.7 10919.0 10925.6 11006.5 11197.9 11701.7 11779.5 12039.8 12919.0 12993.8 11283.5 11341.2 11689.3 11845.9 12272.8 11240.7 11670.2 11783.2 11841.2 12327.8 11152.4 11401.6 11454.1 11544.9 12101.7 9234.7 9316.8 9700.7 9874.5 9998.5 9240.3 9361.0 10069.3 10127.9 10174.6 05:05:54 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:05:54 INFO - PROCESS | 1675 | 05:05:54 INFO - TEST-INFO | 1675: exit 0 05:05:54 INFO - TEST-OK | dromaeo_css | took 1110353ms 05:05:54 INFO - TEST-START | kraken 05:05:54 INFO - operating with platform_type : mac_ 05:05:54 INFO - Initialising browser for kraken test... 05:05:54 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpuHNAg3/profile http://localhost:49278/getInfo.html) 05:05:57 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 05:05:57 INFO - PROCESS | 1687 | colorDepth:24 05:05:57 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 05:05:57 INFO - PROCESS | 1687 | __metrics 05:05:58 INFO - TEST-INFO | 1687: exit 0 05:05:58 INFO - Browser initialized. 05:05:58 INFO - Running cycle 1/1 for kraken test... 05:05:58 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpuHNAg3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:10 INFO - PROCESS | 1690 | RSS: Main: 259067904 05:06:10 INFO - PROCESS | 1690 | 05:06:13 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:13 INFO - PROCESS | 1690 | RSS: Main: 271216640 05:06:13 INFO - PROCESS | 1690 | 05:06:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:06:17 INFO - PROCESS | 1690 | RSS: Main: 279031808 05:06:17 INFO - PROCESS | 1690 | 05:06:20 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:06:21 INFO - PROCESS | 1690 | RSS: Main: 281403392 05:06:21 INFO - PROCESS | 1690 | 05:06:23 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:06:23 INFO - PROCESS | 1690 | RSS: Main: 283906048 05:06:23 INFO - PROCESS | 1690 | 05:06:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:26 INFO - PROCESS | 1690 | RSS: Main: 284217344 05:06:26 INFO - PROCESS | 1690 | 05:06:29 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:29 INFO - PROCESS | 1690 | RSS: Main: 286076928 05:06:29 INFO - PROCESS | 1690 | 05:06:32 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:33 INFO - PROCESS | 1690 | RSS: Main: 285847552 05:06:33 INFO - PROCESS | 1690 | 05:06:36 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:06:37 INFO - PROCESS | 1690 | RSS: Main: 285851648 05:06:37 INFO - PROCESS | 1690 | 05:06:38 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:06:39 INFO - PROCESS | 1690 | RSS: Main: 284168192 05:06:39 INFO - PROCESS | 1690 | 05:06:40 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:06:41 INFO - PROCESS | 1690 | RSS: Main: 284352512 05:06:41 INFO - PROCESS | 1690 | 05:06:43 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:06:44 INFO - PROCESS | 1690 | RSS: Main: 284643328 05:06:44 INFO - PROCESS | 1690 | 05:06:47 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:06:47 INFO - PROCESS | 1690 | RSS: Main: 284712960 05:06:47 INFO - PROCESS | 1690 | 05:06:50 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:06:51 INFO - PROCESS | 1690 | RSS: Main: 286621696 05:06:51 INFO - PROCESS | 1690 | 05:06:52 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:06:52 INFO - PROCESS | 1690 | RSS: Main: 287711232 05:06:52 INFO - PROCESS | 1690 | 05:06:52 INFO - PROCESS | 1690 | __start_tp_report 05:06:52 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 05:06:52 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 05:06:52 INFO - PROCESS | 1690 | |i|pagename|runs| 05:06:52 INFO - PROCESS | 1690 | |0;ai-astar;117;108;115;114;113;126;115;116;117;116 05:06:52 INFO - PROCESS | 1690 | |1;audio-beat-detection;185;152;145;187;154;172;144;125;150;124 05:06:52 INFO - PROCESS | 1690 | |2;audio-dft;193;194;192;213;232;264;278;239;199;198 05:06:52 INFO - PROCESS | 1690 | |3;audio-fft;72;79;71;125;60;56;59;60;91;57 05:06:52 INFO - PROCESS | 1690 | |4;audio-oscillator;83;83;123;83;83;83;115;80;83;122 05:06:52 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;87;94;87;94;87;93;93;141;104;94 05:06:52 INFO - PROCESS | 1690 | |6;imaging-darkroom;93;136;153;150;97;97;96;96;98;111 05:06:53 INFO - PROCESS | 1690 | |7;imaging-desaturate;92;96;86;106;86;89;121;136;77;100 05:06:53 INFO - PROCESS | 1690 | |8;json-parse-financial;56;57;56;58;57;64;88;92;45;46 05:06:53 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;64;66;66;73;71;73;66;67;64;68 05:06:53 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;87;95;110;114;87;84;90;105;104;84 05:06:53 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;130;136;142;140;145;135;138;123;136;127 05:06:53 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;143;147;124;180;189;179;164;142;141;142 05:06:53 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;70;71;67;68;70;67;67;76;94;93 05:06:53 INFO - PROCESS | 1690 | __end_tp_report 05:06:53 INFO - PROCESS | 1690 | __start_cc_report 05:06:53 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,922 05:06:53 INFO - PROCESS | 1690 | __end_cc_report 05:06:53 INFO - PROCESS | 1690 | __startTimestamp1455196012995__endTimestamp 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | ------- Summary: start ------- 05:06:53 INFO - PROCESS | 1690 | Number of tests: 14 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:4.47 (3.9%) stddev-sans-first:4.72 05:06:53 INFO - PROCESS | 1690 | Values: 117.0 108.0 115.0 114.0 113.0 126.0 115.0 116.0 117.0 116.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:153.00 stddev:21.90 (14.3%) stddev-sans-first:20.11 05:06:53 INFO - PROCESS | 1690 | Values: 185.0 152.0 145.0 187.0 154.0 172.0 144.0 125.0 150.0 124.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:220.20 Median:222.50 stddev:31.57 (14.2%) stddev-sans-first:31.91 05:06:53 INFO - PROCESS | 1690 | Values: 193.0 194.0 192.0 213.0 232.0 264.0 278.0 239.0 199.0 198.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:73.00 Median:65.50 stddev:21.47 (32.8%) stddev-sans-first:22.77 05:06:53 INFO - PROCESS | 1690 | Values: 72.0 79.0 71.0 125.0 60.0 56.0 59.0 60.0 91.0 57.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:83.00 stddev:18.22 (22.0%) stddev-sans-first:18.90 05:06:53 INFO - PROCESS | 1690 | Values: 83.0 83.0 123.0 83.0 83.0 83.0 115.0 80.0 83.0 122.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:93.00 stddev:16.13 (17.3%) stddev-sans-first:16.67 05:06:53 INFO - PROCESS | 1690 | Values: 87.0 94.0 87.0 94.0 87.0 93.0 93.0 141.0 104.0 94.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:96.00 stddev:24.07 (25.1%) stddev-sans-first:24.46 05:06:53 INFO - PROCESS | 1690 | Values: 93.0 136.0 153.0 150.0 97.0 97.0 96.0 96.0 98.0 111.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:98.90 Median:86.00 stddev:17.90 (20.8%) stddev-sans-first:18.81 05:06:53 INFO - PROCESS | 1690 | Values: 92.0 96.0 86.0 106.0 86.0 89.0 121.0 136.0 77.0 100.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:57.50 stddev:15.86 (27.6%) stddev-sans-first:16.67 05:06:53 INFO - PROCESS | 1690 | Values: 56.0 57.0 56.0 58.0 57.0 64.0 88.0 92.0 45.0 46.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:3.39 (5.0%) stddev-sans-first:3.31 05:06:53 INFO - PROCESS | 1690 | Values: 64.0 66.0 66.0 73.0 71.0 73.0 66.0 67.0 64.0 68.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:85.50 stddev:11.31 (13.2%) stddev-sans-first:11.52 05:06:53 INFO - PROCESS | 1690 | Values: 87.0 95.0 110.0 114.0 87.0 84.0 90.0 105.0 104.0 84.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:137.00 stddev:6.81 (5.0%) stddev-sans-first:6.96 05:06:53 INFO - PROCESS | 1690 | Values: 130.0 136.0 142.0 140.0 145.0 135.0 138.0 123.0 136.0 127.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.10 Median:155.50 stddev:21.45 (13.8%) stddev-sans-first:22.30 05:06:53 INFO - PROCESS | 1690 | Values: 143.0 147.0 124.0 180.0 189.0 179.0 164.0 142.0 141.0 142.0 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:70.50 stddev:10.48 (14.9%) stddev-sans-first:11.00 05:06:53 INFO - PROCESS | 1690 | Values: 70.0 71.0 67.0 68.0 70.0 67.0 67.0 76.0 94.0 93.0 05:06:53 INFO - PROCESS | 1690 | -------- Summary: end -------- 05:06:53 INFO - PROCESS | 1690 | 05:06:53 INFO - TEST-INFO | 1690: exit 0 05:06:53 INFO - TEST-OK | kraken | took 58911ms 05:06:53 INFO - SUITE-END | took 1169s 05:06:54 INFO - Completed test suite (00:19:29) 05:06:54 INFO - Working with test: dromaeo_css 05:06:54 INFO - Generating results file: dromaeo_css 05:06:54 INFO - Working with test: kraken 05:06:54 INFO - Generating results file: kraken 05:06:54 INFO - javascript benchmark 05:06:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:06:54 INFO - process_Request line: dromaeo_css 7410.35 graph.html#tests=[[72,1,61]] 05:06:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:06:54 INFO - process_Request line: kraken 1555.80 graph.html#tests=[[232,1,61]] 05:06:54 INFO - RETURN: dromaeo_css: 7410.35 05:06:54 INFO - RETURN: kraken: 1555.80 05:06:54 INFO - javascript benchmark 05:06:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2695.703472618012, 3543.5393398858178, 3543.6279190684963, 3573.5711714594254, 3601.9599926226124, 4834.8791280217965, 5759.078547432412, 5777.942220577793, 5795.710214489269, 5807.128930660403, 5570.6657600543995, 5749.223854779603, 5760.222369980052, 5786.0, 5928.644281343122, 5150.768215430306, 5163.7159956202395, 5206.895862082756, 5228.712420816853, 5285.2600635911, 5259.631825772198, 5280.287161233223, 5282.550983166417, 5285.154375299952, 5288.418273989858, 5073.315102461157, 5106.31064806252, 5201.921971170435, 5209.661372010807, 5226.8693282667855, 5157.252198431206, 5216.58267338612, 5217.50433708797, 5226.346706661668, 5278.917821846512, 5062.341895553592, 5190.0, 5191.740412979374, 5196.220566914955, 5208.270842082112, 4686.601638860701, 5334.51989320963, 5665.093585026376, 5732.197492351074, 5732.426757324276, 6254.562180647311, 6267.937320626781, 6274.905876411812, 6304.211973503312, 6306.463950564207, 6148.555089553951, 6161.815145545641, 6248.218972628421, 6258.530610204208, 6282.654454005028, 5848.853778655568, 5849.853753656107, 5852.423618177749, 5890.705464726747, 5941.673207973559, 6152.323244443108, 6256.405641464054, 6282.151909492251, 6287.1198032275515, 6299.212598425197, 5191.558717508979, 6105.581053426346, 6193.938060619426, 6197.96901015501, 6200.410960958701, 6212.223472065992, 6214.875702485925, 6248.50011999039, 6261.217347831521, 6288.685565721696, 6122.387761223931, 6169.5064394848305, 6223.564350495421, 6224.439800417984, 6276.497880169575, 6264.968675156686, 6267.62394256346, 6281.371862813773, 6285.59143655661, 6287.402696743802, 4021.3565829467143, 4872.51274872517, 4886.706797592155, 4923.236898280772, 4976.154053810861, 3586.04969683029, 4245.3844192591905, 4343.0, 4364.214441400515, 4456.064226512469, 5048.217526283432, 5062.215356619729, 5324.334458192726, 5422.674639521641, 5677.205191273225, 5424.267723857308, 6131.774283661862, 6227.1282020517165, 6249.843753906189, 6262.718177682015, 4801.159797035574, 5684.0, 5701.914471282934, 5703.857403564944, 5792.189093526909, 5365.570754339644, 5383.757730902119, 5401.837944861661, 5402.6758394496455, 5437.483439073281, 6190.690465476709, 6262.342454042351, 6285.731300619408, 6336.461400780893, 6356.68216589178, 5171.844844654666, 5319.202119682079, 6161.938380616137, 6179.660118693335, 6238.313785483684, 6328.778492752732, 6364.713587888464, 6371.840703982252, 6375.649339286384, 6378.425941665272, 6082.60463069899, 6131.540134489842, 6144.709610981744, 6208.503319734501, 6251.124842522141, 6033.42682445167, 6147.508199343953, 6148.292946311052, 6165.198524191826, 6190.164327815687, 5995.61028533144, 6086.756529738938, 6122.112293717475, 6169.938300616936, 6190.938090619216, 6145.832291864532, 6193.535484838745, 6194.752209911553, 6228.439440450381, 6245.469135123565, 5926.762929482945, 5981.9401805983125, 6054.091886217103, 6070.570003774838, 6121.173641558333, 6002.0996850472775, 6134.8159555213415, 6181.3200547938795, 6197.690115494297, 6199.969000154971, 6059.151718759289, 6096.272074548536, 6099.979620341888, 6101.45934676866, 6108.760397969318], "unit": "score", "name": "dojo.html", "value": 5656.633358123329}, {"lowerIsBetter": false, "replicates": [490.8821882748139, 503.451238150416, 522.8666689994053, 567.8551969247841, 586.3842964886868, 30705.846470767643, 36875.63124368755, 36921.26157476849, 37042.814785926064, 37078.44382334264, 37954.430683539766, 38372.42441363382, 38484.0, 38606.61393386065, 38612.0, 9403.858942115874, 9662.420254784736, 9708.126268635822, 9755.073268039525, 9815.362001469917, 9556.18772404343, 9659.420434773901, 9663.033696630317, 9674.129328360446, 9718.56266468007, 9676.225901927864, 9686.225101991824, 9709.902900971007, 9730.756731081708, 9732.805343893118, 9627.181689556395, 9674.613015479372, 9714.90285097147, 9722.125008749212, 9724.513774311292, 9387.953060234724, 9539.236861051098, 9544.761380965532, 9557.61769529218, 9583.137517623447, 37525.81237093824, 37549.436758448646, 37745.490180393026, 38061.619383806086, 38087.23825523502, 2728.9181324560295, 2836.2767494289033, 3008.247938015496, 3074.2775447769754, 3115.8597863096215, 26742.73257267422, 26906.192814215607, 27299.317517062034, 27310.863445682644, 27376.45247095047, 2753.9449211015667, 2786.8049236553447, 2793.9860300698365, 2811.3674423254606, 2817.0422056500684, 316042.0, 316338.0, 317261.0, 317327.0, 317687.0, 44718.77640611776, 44792.3281150783, 44942.325865111394, 45037.77481112573, 59836.0, 43188.784056079516, 43537.56462435398, 43577.564224357986, 43756.0, 43770.781146094065, 14804.889633277548, 15016.774748378783, 15022.774658380133, 15185.012974156865, 15206.46777362787, 11959.820602690967, 12038.277703337828, 12081.335526546125, 12108.910198082214, 12231.633051008484, 11780.645225798971, 11855.644330670093, 14421.567352979428, 14431.278436078153, 14448.711025779636, 6167.136600875881, 6209.720562574695, 6242.001279795211, 6283.08895210192, 6285.245770507477, 910.1717437132311, 966.0677446264248, 1030.618671091701, 1031.0050800977094, 1062.7236918401272, 27999.160025199275, 29060.273493162418, 29344.559831602543, 29485.26286842846, 29901.850490747842, 1012.9696109116738, 1043.4261156363968, 1089.9346039237512, 1095.222392101601, 1124.454639499842, 14882.404703811726, 14934.879884008742, 15200.695986080438, 15234.542963711106, 15687.4509392173, 519814.0, 522244.0, 525932.0, 526663.0, 527098.0, 46440.83897902579, 56368.71815640978, 57021.0, 57138.42861571331, 57341.85316293651, 1373.9313034348243, 1399.1605036977733, 1404.9859501404856, 1443.1990245413897, 1451.2380999974887, 21529.569408611427, 28818.71181288244, 29389.265268367606, 29482.262943426587, 30103.096907091945, 48668.0, 49061.50938490712, 49271.0, 49312.50687493079, 49438.258426124354, 463632.0, 463975.0, 466186.0, 466661.0, 468324.0, 30907.536386954664, 33329.500057499645, 40285.39571906365, 44046.11907761763, 44121.55878441175, 40662.1867562653, 41506.792466038685, 41793.95515112025, 41831.7908410456, 42031.7898410506, 31107.755689772155, 33929.0, 34096.65903340935, 35108.366872484155, 35470.11324716903, 35234.47148292726, 35336.29327413386, 35787.28425431425, 35979.64020359763, 36040.8197959019, 34662.82668586641, 35960.82019589885, 36067.81966090153, 36368.09079773027, 36508.0, 30644.84677576598, 32034.0, 32365.51451728179, 32478.35043299168, 32635.0, 24249.75750242475, 24403.0, 24489.0, 24809.503809924063, 24911.377215569755], "unit": "score", "name": "ext.html", "value": 18417.604446479636}, {"lowerIsBetter": false, "replicates": [363.61093629816105, 369.97040236781044, 371.6357969190194, 373.1901773152259, 374.1170836825093, 15232.39070437184, 18253.908730456347, 18968.051597420126, 19308.71036934447, 19744.802551974477, 11639.534418623245, 13274.469021239163, 18279.451616451493, 18968.0, 18973.810261897375, 4000.0599859033105, 5148.742562871851, 5333.093374126388, 5418.160185171305, 5808.622439541437, 5115.360579927509, 5920.230370051887, 5956.672383018932, 6021.608595441304, 6030.728617212236, 5972.134040564116, 6447.129637498948, 6463.321351258121, 6474.255460622042, 6496.116126323361, 5822.563307751914, 5973.701314934279, 5981.820545383645, 6369.522285828558, 6431.070678796365, 5484.341878974548, 5613.831585052455, 5662.207290979266, 5690.800821971211, 5703.486686198221, 19562.70655940162, 23551.646725299135, 23774.405639858967, 23966.0, 24046.398840028964, 1970.8718933269436, 2032.309014934929, 2093.1627349060345, 2194.5062360968814, 2243.25972429098, 10081.143102836268, 10224.0, 10227.130693891027, 13578.932105339509, 13870.167789932637, 1742.808291087992, 1775.2366482412558, 1775.5916139287906, 1811.8641101917408, 1844.206990993872, 93151.06848931492, 98480.0, 98651.50674246655, 98690.50654746681, 100283.0, 10321.535530900977, 11138.61014864492, 11362.48868800906, 11433.970942615204, 11548.076153907836, 13519.391627376792, 13621.0, 13669.794953075712, 13728.45086196541, 13798.586042418743, 7056.50604457683, 8527.147285271423, 8529.914700853036, 8570.657173713107, 8617.784555386166, 7218.025566548554, 8535.445196062235, 8558.700445484377, 8566.785830354167, 8608.612612432456, 3817.7401457518954, 4001.579834117376, 4185.22573323936, 4225.450691410097, 4399.296112621965, 1666.5833541614597, 1682.2093616000461, 1785.9285628574712, 1833.5049536625036, 1837.7702787151607, 743.7991742229676, 910.2490445382454, 953.8473844184897, 960.9951950240204, 995.4027583450016, 16606.50180494587, 17635.735463968052, 18656.440306790817, 18684.719729204073, 19629.116689748997, 862.2153840005565, 946.2997381937455, 947.2564037230741, 981.1562056631292, 1038.7299302181486, 10491.475426228659, 10699.893001070046, 10703.25077244601, 10734.087602553871, 10739.946300268604, 725085.0, 764191.0, 785482.0, 788742.0, 793295.0, 108705.0, 111957.44021279842, 114167.0, 115415.42292288653, 117058.41470792591, 1117.6647005898199, 1131.3777422417638, 1131.5869707556847, 1147.9196456247982, 1147.971300717472, 17508.824911751228, 17581.912090439466, 17768.911155444657, 17818.020008899115, 17922.551936201176, 38971.0, 49570.50429495659, 50084.0, 50729.49270507395, 50826.74586627043, 71243.0, 71888.921666174, 72165.0, 72309.6384518074, 74126.62936685498, 6397.0, 7444.516106453063, 7615.7334493292465, 7727.884081738666, 7755.2244775521995, 11161.553537858395, 12072.45673944657, 12131.42291502099, 12271.447784849881, 12433.254004759743, 10019.348742331726, 10294.124999375137, 10561.841572376266, 10668.253222274367, 10669.146468282674, 10391.116755075904, 10425.947870260903, 10450.581976720847, 10565.577376904837, 10690.0, 10030.498475076363, 10530.57877684884, 10811.297265677706, 10968.725781855199, 10997.955194256532, 7404.333609975128, 7424.96287518559, 7679.731209407644, 7841.294283514511, 7866.9213307866185, 9839.901600983898, 10333.48332583383, 10552.0, 10690.786184276427, 10731.248812583044], "unit": "score", "name": "jquery.html", "value": 9183.643150999453}, {"lowerIsBetter": false, "replicates": [1324.8873845723112, 1519.7872297878296, 1739.1043612539545, 1901.3440363074735, 1916.4346517777271, 7976.122626511079, 8565.57172141392, 8693.000304964931, 8898.199162075412, 8908.955455222731, 8062.758117256477, 8587.52768597727, 8611.397202195849, 8705.477671339724, 8729.738107856758, 1977.6143651987832, 2119.2582596091397, 2120.9257675981344, 2414.8188885833547, 2489.7634724701124, 2478.6901637295337, 2514.5976643737004, 2526.848389096651, 2534.9239522814346, 2544.414784599543, 1924.6631839428114, 2013.8892360920142, 2190.901409436571, 2483.776460118589, 2507.122507122511, 2437.2810021043833, 2437.6709144265565, 2473.332200305916, 2475.9133430329944, 2479.3429741118616, 2479.1446950801947, 2483.0316176691103, 2489.626556016612, 2492.19003823758, 2516.4086439686657, 7909.802254943673, 8310.418270721051, 8664.306855451548, 8703.999040110342, 8774.034856165817, 5252.343457067866, 5444.373897001856, 5447.400785913546, 5535.225068490415, 5561.888762224733, 3111.1444352802932, 3677.025588219124, 3699.2601479704167, 3718.1262403335463, 3751.8931915085113, 950.6672664567416, 1055.9577616895315, 1064.940384317609, 1077.8275475923815, 1102.779444111181, 11812.763744725058, 11910.523579056828, 11935.045196384268, 11944.28334299936, 11948.820767688492, 4935.0, 4964.280179373971, 5128.205128205134, 5129.102407078746, 5132.56373208274, 9199.77000574991, 9249.260059195249, 9284.62861485533, 9310.581023853943, 9322.906770932204, 5325.6272060956135, 5407.567394608422, 5442.374126975369, 5443.591730620219, 5445.319335083114, 5003.7998480061115, 5052.065367906949, 5070.949290507047, 5078.238264260317, 5088.542031217208, 3412.7611067225057, 3726.552813662378, 3726.5900750917376, 3728.5339332583426, 3752.4746535485056, 1100.4772732951944, 1138.2601309148954, 1185.6561597136733, 1187.857457105153, 1191.93444360561, 1004.6031817432073, 1088.4992903264429, 1097.6213206443765, 1247.6943148928572, 1371.746226947998, 7912.327452166515, 8043.235892590194, 8051.114377418479, 8134.75595732129, 8138.186181381933, 625.7246811402969, 643.5462998585986, 644.458654730029, 645.9903101453482, 787.8936343593541, 5272.446393128743, 6054.273487181478, 6116.235470566179, 6247.0629405589525, 6256.343083976208, 10575.947120264349, 10847.457627118612, 11026.283291586022, 11029.22795404314, 11103.167262455348, 10762.73093172677, 10777.299475534066, 10815.18886083547, 10826.025657690689, 10924.781504370027, 8185.508869467851, 8320.126386729427, 8406.705765298308, 8407.70573029941, 8483.44857584255, 7859.724909628136, 7893.842123157619, 7907.0, 7918.841623167389, 7921.247481489249, 7363.77908662741, 9465.810683786423, 9836.5081745911, 9838.163756080814, 9942.801143976936, 9919.950400247953, 9959.203263739028, 9972.900270997197, 10105.44420056904, 10238.283320167517, 6904.965475172592, 7056.153261608434, 7057.929420705933, 7068.505204635831, 7101.360877521048, 8194.180581941759, 8231.835363292821, 8290.83418331618, 8293.087760346478, 8302.54336011525, 6894.896576551456, 7477.289657482531, 7825.686972521035, 7928.643211055632, 8011.998500187477, 7594.430417718803, 7681.500702454323, 7705.537667739729, 7756.0304961879765, 7800.882986755089, 7673.731419400294, 7740.496867703581, 7804.765857024298, 7836.373090152888, 7846.6861325548625, 6880.4839637026425, 7022.052022976833, 7060.329268719669, 7085.468589855678, 7107.289271072851, 7107.3603375694365, 7142.821429464305, 7167.820804479929, 7172.175199852084, 7185.461090418344], "unit": "score", "name": "mootools.html", "value": 4821.403840537986}, {"lowerIsBetter": false, "replicates": [273.36579136403543, 330.4448526475522, 330.6049271121011, 332.0668920333861, 334.61352138280296, 6025.457708806207, 6160.630362178261, 6726.966365168179, 6814.591124532525, 6815.761448349309, 6713.2951040140815, 6786.796396108112, 6814.080099186608, 6848.14398200225, 6893.345132212432, 4930.728809915444, 4954.430240522332, 4962.6774259673, 4969.552740253376, 4995.100881841267, 4855.927161092586, 4996.075725990703, 5004.224345226496, 5005.6746311489815, 5019.974900125512, 4955.479674634147, 4969.329140566014, 4969.353983982077, 4982.9252561211615, 4985.351904252442, 4954.97522512387, 4960.107180707471, 4978.477259887714, 4983.900321993576, 5003.17447621142, 4254.574542545752, 4264.445622069142, 4271.103068355649, 4279.893002674927, 4286.592773686495, 6273.592216505958, 6506.284308726036, 6546.476281897437, 6582.9670851645915, 6588.242352129519, 5908.822735317947, 5918.082697181943, 5923.4076592340425, 5928.318243401977, 5933.91099133509, 6913.619750913697, 6956.721731130749, 7001.004713656584, 7150.712871683095, 7283.162436319838, 4704.670673052888, 4713.2458806590785, 4720.33915251865, 4740.241561350167, 4793.952060479385, 7635.847283054308, 7642.656080476392, 7648.273414025659, 7669.616519174075, 7717.189695082048, 4730.266808644666, 4801.351817504662, 4838.419389673261, 4839.322494850724, 4847.563719265283, 4946.134426475424, 4951.777170027357, 4952.257161425815, 4953.00939812039, 4955.752212389366, 5828.88342233153, 5843.474087332161, 5846.269216347957, 5866.413358664099, 5873.295204575393, 7257.419406447471, 7274.709011639475, 7275.126984761757, 7276.199618042011, 7307.232740562271, 1653.3634550698068, 1722.9913850430667, 1724.0, 1726.1369315342329, 1729.524380795266, 1119.44027986007, 1122.3669560789033, 1132.932024078558, 1134.6312448454285, 1137.3062431916524, 6654.168228971379, 6660.8667826643195, 6703.93296067033, 6704.865902681919, 6734.158230221223, 7518.28576285263, 7549.396048316122, 7558.319751222416, 7575.924240757632, 7582.962085189539, 4846.3699719037, 6359.268684101295, 6674.098996635489, 6679.365460281266, 6682.665866706645, 3029.9092326762348, 3365.360581489509, 4001.3397789365013, 4032.6572241359227, 4051.7366371186367, 6924.4114250289285, 7456.96271518639, 7933.365330773524, 7935.047794264725, 7940.920590794018, 7582.241775822484, 7807.375409967189, 7860.842783144305, 7864.134945156028, 7865.370770338473, 6383.36166383358, 7008.412092632909, 7354.0, 7535.246475352531, 7910.16943220965, 7441.995330630512, 7532.585707786125, 7558.9244107558225, 7562.621868906643, 7580.393568514616, 6584.670766461562, 6990.161180658353, 7405.148407933157, 7518.736844210426, 7546.698257031658, 6451.290607812026, 7530.359919406912, 7908.0, 7932.246436588515, 7934.325582325567, 4862.878428039327, 4913.459519452929, 4918.6556941015215, 4930.950690493192, 4945.777440015136, 7486.288802563748, 7496.100467943882, 7500.587467689329, 7504.812379690551, 7507.812304692427, 6981.79054628362, 7181.097009292437, 7213.819654508679, 7217.530860494051, 7261.164966028974, 7211.134663840373, 7221.783346499614, 7223.494355395072, 7231.927680723125, 7247.746328878464, 6788.287229840796, 6993.230744618189, 6995.300469952964, 7013.754518591825, 7015.36861682451, 6354.586951848115, 6360.554761166674, 7212.855742885218, 7228.20489746117, 7237.312455316736, 7035.718571257297, 7052.2242553318065, 7062.293770622897, 7067.187273463617, 7091.361777440055], "unit": "score", "name": "prototype.html", "value": 5268.7835605488535}, {"lowerIsBetter": false, "replicates": [696.8989496523008, 705.7635692043166, 747.1557140431312, 755.1655420760059, 783.3811289081626, 14333.78499322511, 15063.17152556609, 15161.924190379033, 15181.240937953085, 15219.08685478872, 13957.930210348934, 14043.087199332062, 14043.297835108255, 14055.297235138254, 14064.789028164585, 677.1298880937995, 851.6508231625035, 856.7986523167066, 873.7990262239689, 884.6594061286387, 858.5406807358033, 864.2437866866492, 869.6086760957563, 869.9173578510031, 873.838339907116, 902.3052249767675, 907.1065000974036, 915.716128000322, 918.1736437206534, 925.4678559828126, 898.0570401078841, 904.2675432899373, 907.804821963281, 910.3400034974657, 912.5665308978215, 667.6761770541284, 669.6484345718488, 676.7326905872202, 679.0222080204489, 686.7802303262957, 14688.485902993343, 14724.779128313085, 14736.115833050051, 14751.409943602242, 14765.704685906221, 10918.454077296183, 12885.226886386847, 12939.611811645666, 13028.674283142997, 13198.076134670577, 7939.801504962365, 10039.598416063349, 10097.141742951859, 10127.189824813997, 10133.0, 3166.5250212468313, 3533.487644291589, 3609.4946707460977, 3611.9277614447565, 3623.6738693517445, 81432.59283703603, 81477.0, 81947.0, 83993.90015249606, 84208.15791842065, 7568.470207085451, 9271.119243671841, 9342.112499312554, 9396.718098457057, 9745.463999480096, 20849.478763031046, 20892.89553552253, 21049.263275785273, 21058.0, 21070.0, 7395.334419902235, 7504.0, 7635.389168866477, 7764.728234511765, 7895.01312335958, 4139.068709540329, 4143.399207114951, 4155.148194620096, 4161.708680392343, 4172.4784401949755, 3484.5470088888283, 3499.3526197653514, 3505.6844883960566, 3515.8066306353394, 3520.9119772005392, 554.2074832988784, 651.569963823874, 651.8859199640044, 676.1683129750435, 677.5494296293009, 523.332750742806, 549.9477549632778, 587.7296443635976, 616.5622408090306, 623.9656818874914, 8440.873386899078, 8652.307815374756, 8719.302455803521, 8738.21356077956, 8827.69103081389, 503.14967704579146, 579.8142797978145, 608.3733754233147, 615.7752420366534, 616.2635650397822, 3919.0594257378593, 4107.363358679409, 4134.4005119258145, 4158.168366326747, 4163.271427500175, 85140.57429712811, 85478.0, 89545.0, 89670.10329896749, 90020.6496902547, 74576.0, 74695.0, 74957.25042749612, 75520.62239688876, 75830.0, 63213.73572528524, 65311.67344163249, 65619.67190164019, 65901.67049164724, 67138.66430667815, 6810.625415601991, 8174.959125204336, 8196.877046844183, 8270.37972152079, 8485.95757021211, 38906.02734931536, 45295.7735211335, 46155.53844461647, 47596.04807903753, 48229.75885120552, 51045.44772761421, 55679.0, 61967.07049394173, 62868.0, 63751.6812415935, 10697.679069627924, 10919.0, 10925.562977480811, 11006.504707288352, 11197.888021119685, 11701.707457313636, 11779.469923853276, 12039.75920481568, 12919.031072669775, 12993.805092923803, 11283.475342369798, 11341.20611557216, 11689.298642081503, 11845.940770296093, 12272.754544908874, 11240.662780116609, 11670.183087183816, 11783.234089784137, 11841.171118022, 12327.815082773586, 11152.442377881236, 11401.600943966921, 11454.14093942941, 11544.94227528857, 12101.69745756328, 9234.676786312446, 9316.767080823034, 9700.708978730649, 9874.456904870302, 9998.450085245382, 9240.260779137518, 9360.950386565997, 10069.34757482778, 10127.898721012696, 10174.593016279267], "unit": "score", "name": "yui.html", "value": 6812.547125680309}], "name": "dromaeo_css", "value": 7410.348542759487}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 108.0, 115.0, 114.0, 113.0, 126.0, 115.0, 116.0, 117.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [185.0, 152.0, 145.0, 187.0, 154.0, 172.0, 144.0, 125.0, 150.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [193.0, 194.0, 192.0, 213.0, 232.0, 264.0, 278.0, 239.0, 199.0, 198.0], "unit": "score", "name": "audio-dft", "value": 220.2}, {"lowerIsBetter": true, "replicates": [72.0, 79.0, 71.0, 125.0, 60.0, 56.0, 59.0, 60.0, 91.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 123.0, 83.0, 83.0, 83.0, 115.0, 80.0, 83.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 87.0, 94.0, 87.0, 93.0, 93.0, 141.0, 104.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.4}, {"lowerIsBetter": true, "replicates": [93.0, 136.0, 153.0, 150.0, 97.0, 97.0, 96.0, 96.0, 98.0, 111.0], "unit": "score", "name": "imaging-darkroom", "value": 112.7}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 86.0, 106.0, 86.0, 89.0, 121.0, 136.0, 77.0, 100.0], "unit": "score", "name": "imaging-desaturate", "value": 98.9}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 58.0, 57.0, 64.0, 88.0, 92.0, 45.0, 46.0], "unit": "score", "name": "json-parse-financial", "value": 61.9}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 66.0, 73.0, 71.0, 73.0, 66.0, 67.0, 64.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [87.0, 95.0, 110.0, 114.0, 87.0, 84.0, 90.0, 105.0, 104.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.0}, {"lowerIsBetter": true, "replicates": [130.0, 136.0, 142.0, 140.0, 145.0, 135.0, 138.0, 123.0, 136.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.2}, {"lowerIsBetter": true, "replicates": [143.0, 147.0, 124.0, 180.0, 189.0, 179.0, 164.0, 142.0, 141.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.1}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 67.0, 68.0, 70.0, 67.0, 67.0, 76.0, 94.0, 93.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.3}], "name": "kraken", "value": 1555.8}]} 05:06:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1555.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7410.35"}}} 05:06:54 INFO - Return code: 0 05:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:06:54 INFO - # TBPL SUCCESS # 05:06:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:06:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:06:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:06:54 INFO - 2016-02-11 05:06:54.777 screenresolution[1695:10427] starting screenresolution argv=screenresolution get 05:06:54 INFO - 2016-02-11 05:06:54.779 screenresolution[1695:10427] Display 0: 1600x1200x32@60 05:06:54 INFO - 2016-02-11 05:06:54.785 screenresolution[1696:10430] starting screenresolution argv=screenresolution list 05:06:54 INFO - Available Modes on Display 0 05:06:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:06:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:06:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:06:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:06:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:06:55 INFO - Intel Iris: 05:06:55 INFO - Chipset Model: Intel Iris 05:06:55 INFO - Type: GPU 05:06:55 INFO - Bus: Built-In 05:06:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:06:55 INFO - Vendor: Intel (0x8086) 05:06:55 INFO - Device ID: 0x0a2e 05:06:55 INFO - Revision ID: 0x0009 05:06:55 INFO - Displays: 05:06:55 INFO - Display: 05:06:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:06:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:06:55 INFO - Display Serial Number: 1600x1200 60 05:06:55 INFO - Main Display: Yes 05:06:55 INFO - Mirror: Off 05:06:55 INFO - Online: Yes 05:06:55 INFO - Rotation: Supported 05:06:55 INFO - Return code: 0 05:06:55 INFO - Running post-action listener: _resource_record_post_action 05:06:55 INFO - Running post-run listener: _resource_record_post_run 05:06:56 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 39208448; Write bytes: 708828160; Read time: 426; Write time: 1943 05:06:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395127296; Write bytes: 388798464; Read time: 29877; Write time: 663 05:06:56 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 37414400; Write bytes: 302216192; Read time: 408; Write time: 1241 05:06:56 INFO - Running post-run listener: _upload_blobber_files 05:06:56 INFO - Blob upload gear active. 05:06:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:06:56 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 05:06:56 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'] 05:06:56 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 05:06:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:06:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:06:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:57 INFO - (blobuploader) - INFO - Done attempting. 05:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:06:58 INFO - (blobuploader) - INFO - Done attempting. 05:06:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:06:58 INFO - Return code: 0 05:06:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:06:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:06:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c616abc8fdb7539936e57fcf9962bc739090d1d5e2840f2bb9c94015d8bf203b8c22f935755a3b7dc1f7c9fd296b1bd4a15995b73d90ed901b87e2083c101e2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e8ab59032beef4b230d00aee6a13af682825f0360aa23c4e1d61676391a8debf5829c2f21858cef1dc82669527b8847ae0579ec18b72c0d593aa675ab19ad4"} 05:06:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:06:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:06:58 INFO - Contents: 05:06:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c616abc8fdb7539936e57fcf9962bc739090d1d5e2840f2bb9c94015d8bf203b8c22f935755a3b7dc1f7c9fd296b1bd4a15995b73d90ed901b87e2083c101e2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e8ab59032beef4b230d00aee6a13af682825f0360aa23c4e1d61676391a8debf5829c2f21858cef1dc82669527b8847ae0579ec18b72c0d593aa675ab19ad4"} 05:06:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:06:58 INFO - Copying logs to upload dir... 05:06:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:06:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.652815 ========= master_lag: 25.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-11 05:07:23.323995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 05:07:23.327441) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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/c616abc8fdb7539936e57fcf9962bc739090d1d5e2840f2bb9c94015d8bf203b8c22f935755a3b7dc1f7c9fd296b1bd4a15995b73d90ed901b87e2083c101e2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e8ab59032beef4b230d00aee6a13af682825f0360aa23c4e1d61676391a8debf5829c2f21858cef1dc82669527b8847ae0579ec18b72c0d593aa675ab19ad4"} build_url:https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/UzxfCw7WSGWMtvzVRmflrQ/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/c616abc8fdb7539936e57fcf9962bc739090d1d5e2840f2bb9c94015d8bf203b8c22f935755a3b7dc1f7c9fd296b1bd4a15995b73d90ed901b87e2083c101e2b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77e8ab59032beef4b230d00aee6a13af682825f0360aa23c4e1d61676391a8debf5829c2f21858cef1dc82669527b8847ae0579ec18b72c0d593aa675ab19ad4"}' ========= master_lag: 0.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 05:07:23.869789) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:07:23.870085) ========= 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.dHNlW7ahw2/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.gYdimEDLca/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005310 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 05:07:23.956716) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-11 05:07:23.957014) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-02-11 05:07:27.319877) ========= ========= Total master_lag: 25.89 =========