builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0031 starttime: 1457016604.39 results: success (0) buildid: 20160303025433 builduid: 84a2091766ac414b8c7c7c6b45bbf29e revision: 7e43bdd93e439b8c8d6e62d48d9de3e293655560 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.387077) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.387568) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.387896) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.006183 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.411052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.411404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.426682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.427005) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005443 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.476341) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.476681) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.477106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.477418) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-03-03 06:50:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.4M=0s 2016-03-03 06:50:04 (37.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.457619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.950419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:04.950775) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.019614 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:05.000885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 06:50:05.001344) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e43bdd93e439b8c8d6e62d48d9de3e293655560 --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 7e43bdd93e439b8c8d6e62d48d9de3e293655560 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-03-03 06:50:05,081 truncating revision to first 12 chars 2016-03-03 06:50:05,081 Setting DEBUG logging. 2016-03-03 06:50:05,081 attempt 1/10 2016-03-03 06:50:05,081 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e43bdd93e43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 06:50:06,352 unpacking tar archive at: mozilla-central-7e43bdd93e43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.524828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 06:50:06.543291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:06.543718) ========= echo 7e43bdd93e439b8c8d6e62d48d9de3e293655560 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7e43bdd93e439b8c8d6e62d48d9de3e293655560'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 7e43bdd93e439b8c8d6e62d48d9de3e293655560 program finished with exit code 0 elapsedTime=0.005544 script_repo_revision: '7e43bdd93e439b8c8d6e62d48d9de3e293655560' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:06.595561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:06.595944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:50:06.609803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-03-03 06:50:06.610241) ========= /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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:06 INFO - MultiFileLogger online at 20160303 06:50:06 in /builds/slave/test 06:50:06 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 06:50:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:50:06 INFO - {'append_to_log': False, 06:50:06 INFO - 'base_work_dir': '/builds/slave/test', 06:50:06 INFO - 'blob_upload_branch': 'Firefox', 06:50:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:50:06 INFO - 'branch': 'Firefox', 06:50:06 INFO - 'buildbot_json_path': 'buildprops.json', 06:50:06 INFO - 'config_files': ('talos/mac_config.py',), 06:50:06 INFO - 'default_actions': ('clobber', 06:50:06 INFO - 'read-buildbot-config', 06:50:06 INFO - 'download-and-extract', 06:50:06 INFO - 'populate-webroot', 06:50:06 INFO - 'create-virtualenv', 06:50:06 INFO - 'install', 06:50:06 INFO - 'run-tests'), 06:50:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:50:06 INFO - 'download_minidump_stackwalk': True, 06:50:06 INFO - 'download_symbols': 'ondemand', 06:50:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:50:06 INFO - 'tooltool.py': '/tools/tooltool.py', 06:50:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:50:06 INFO - '/tools/misc-python/virtualenv.py')}, 06:50:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:50:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:50:06 INFO - 'installer_path': 'installer.exe', 06:50:06 INFO - 'log_level': 'info', 06:50:06 INFO - 'log_name': 'talos', 06:50:06 INFO - 'log_to_console': True, 06:50:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:50:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:50:06 INFO - 'opt_config_files': (), 06:50:06 INFO - 'pip_index': False, 06:50:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:06 INFO - 'cmd': ('bash', 06:50:06 INFO - '-c', 06:50:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:06 INFO - 'enabled': True, 06:50:06 INFO - 'halt_on_failure': False, 06:50:06 INFO - 'name': 'check_screen_resolution'},), 06:50:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:50:06 INFO - 'cmd': ('bash', 06:50:06 INFO - '-c', 06:50:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:50:06 INFO - 'enabled': True, 06:50:06 INFO - 'halt_on_failure': False, 06:50:06 INFO - 'name': 'check_screen_resolution'},), 06:50:06 INFO - 'run_cmd_checks_enabled': True, 06:50:06 INFO - 'sps_profile': False, 06:50:06 INFO - 'sps_profile_interval': 0, 06:50:06 INFO - 'suite': 'dromaeojs-e10s', 06:50:06 INFO - 'system_bits': '32', 06:50:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:50:06 INFO - 'title': 't-yosemite-r7-0031', 06:50:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:50:06 INFO - 'use_talos_json': True, 06:50:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:50:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:50:06 INFO - 'work_dir': 'build'} 06:50:06 INFO - ##### 06:50:06 INFO - ##### Running clobber step. 06:50:06 INFO - ##### 06:50:06 INFO - Running pre-action listener: _resource_record_pre_action 06:50:06 INFO - Running main action method: clobber 06:50:06 INFO - rmtree: /builds/slave/test/build 06:50:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:50:08 INFO - Running post-action listener: _resource_record_post_action 06:50:08 INFO - ##### 06:50:08 INFO - ##### Running read-buildbot-config step. 06:50:08 INFO - ##### 06:50:08 INFO - Running pre-action listener: _resource_record_pre_action 06:50:08 INFO - Running main action method: read_buildbot_config 06:50:08 INFO - Using buildbot properties: 06:50:08 INFO - { 06:50:08 INFO - "project": "", 06:50:08 INFO - "product": "firefox", 06:50:08 INFO - "script_repo_revision": "production", 06:50:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:50:08 INFO - "repository": "", 06:50:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:50:08 INFO - "buildid": "20160303025433", 06:50:08 INFO - "pgo_build": "False", 06:50:08 INFO - "basedir": "/builds/slave/test", 06:50:08 INFO - "buildnumber": 160, 06:50:08 INFO - "slavename": "t-yosemite-r7-0031", 06:50:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:50:08 INFO - "platform": "yosemite_r7", 06:50:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:50:08 INFO - "branch": "mozilla-central", 06:50:08 INFO - "repo_path": "mozilla-central", 06:50:08 INFO - "revision": "7e43bdd93e439b8c8d6e62d48d9de3e293655560", 06:50:08 INFO - "stage_platform": "macosx64", 06:50:08 INFO - "builduid": "84a2091766ac414b8c7c7c6b45bbf29e", 06:50:08 INFO - "slavebuilddir": "test" 06:50:08 INFO - } 06:50:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:50:08 INFO - Running post-action listener: _resource_record_post_action 06:50:08 INFO - ##### 06:50:08 INFO - ##### Running download-and-extract step. 06:50:08 INFO - ##### 06:50:08 INFO - Running pre-action listener: _resource_record_pre_action 06:50:08 INFO - Running main action method: download_and_extract 06:50:08 INFO - mkdir: /builds/slave/test/build/tests 06:50:08 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')]} 06:50:08 INFO - https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:50:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:50:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:50:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:50:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 06:50:13 INFO - Downloaded 1277 bytes. 06:50:13 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:50:13 INFO - Using the following test package requirements: 06:50:13 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:50:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:50:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:50:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'jsshell-mac.zip'], 06:50:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:50:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:50:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:50:13 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:50:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:50:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:50:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:50:13 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:50:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:13 INFO - https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:50:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:50:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:17 INFO - Downloaded 17855043 bytes. 06:50:17 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'] 06:50:17 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 06:50:20 INFO - Return code: 0 06:50:20 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 06:50:20 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')]} 06:50:20 INFO - https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:50:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:50:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:50:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:21 INFO - Downloaded 17855043 bytes. 06:50:21 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'] 06:50:21 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 06:50:25 INFO - Return code: 0 06:50:25 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')]} 06:50:25 INFO - https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:25 INFO - Downloaded 10808263 bytes. 06:50:25 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'] 06:50:25 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 06:50:26 INFO - Return code: 0 06:50: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')]} 06:50:26 INFO - https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:50:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:50:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:50:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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 06:50:29 INFO - Downloaded 110973859 bytes. 06:50:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:50:29 INFO - mkdir: /builds/slave/test/properties 06:50:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:29 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:29 INFO - Contents: 06:50:29 INFO - build_url:https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:50:30 INFO - Running post-action listener: _resource_record_post_action 06:50:30 INFO - Running post-action listener: set_extra_try_arguments 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running populate-webroot step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: populate_webroot 06:50:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:30 INFO - '--tppagecycles', 06:50:30 INFO - '7'], 06:50:30 INFO - 'tests': ['tsvgm']}}, 06:50:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:50:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:50:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'tests': ['damp', 'tps']}, 06:50:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['damp', 'tps']}, 06:50:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:50:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:30 INFO - 'other': {'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'other_l64': {'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'other_nol64': {'tests': ['a11yr', 06:50:30 INFO - 'ts_paint', 06:50:30 INFO - 'tpaint', 06:50:30 INFO - 'sessionrestore', 06:50:30 INFO - 'sessionrestore_no_auto_restore']}, 06:50:30 INFO - 'svgr': {'tests': ['tsvgx', 06:50:30 INFO - 'tsvgr_opacity', 06:50:30 INFO - 'tart', 06:50:30 INFO - 'tscrollx', 06:50:30 INFO - 'cart']}, 06:50:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['tsvgx', 06:50:30 INFO - 'tsvgr_opacity', 06:50:30 INFO - 'tart', 06:50:30 INFO - 'tscrollx', 06:50:30 INFO - 'cart']}, 06:50:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'tests': ['tp5o']}, 06:50:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'talos_options': ['--e10s'], 06:50:30 INFO - 'tests': ['tp5o']}, 06:50:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'talos_options': ['--xperf_path', 06:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:30 INFO - 'tests': ['tp5n']}, 06:50:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:30 INFO - 'talos_options': ['--e10s', 06:50:30 INFO - '--xperf_path', 06:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:30 INFO - 'tests': ['tp5n']}}, 06:50:30 INFO - 'talos.zip': {'path': '', 06:50:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:30 INFO - Running post-action listener: _resource_record_post_action 06:50:30 INFO - ##### 06:50:30 INFO - ##### Running create-virtualenv step. 06:50:30 INFO - ##### 06:50:30 INFO - Running pre-action listener: _resource_record_pre_action 06:50:30 INFO - Running main action method: create_virtualenv 06:50:30 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:30 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 06:50:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:30 INFO - Using real prefix '/tools/python27' 06:50:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:31 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:34 INFO - Installing pip.................done. 06:50:34 INFO - Return code: 0 06:50:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:34 INFO - 'HOME': '/Users/cltbld', 06:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:34 INFO - 'LOGNAME': 'cltbld', 06:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:34 INFO - 'MOZ_NO_REMOTE': '1', 06:50:34 INFO - 'NO_EM_RESTART': '1', 06:50:34 INFO - 'PAGER': '/bin/cat', 06:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:34 INFO - 'PWD': '/builds/slave/test', 06:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:34 INFO - 'SHELL': '/bin/bash', 06:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:34 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:34 INFO - 'USER': 'cltbld', 06:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:34 INFO - 'XPC_FLAGS': '0x0', 06:50:34 INFO - 'XPC_SERVICE_NAME': '0', 06:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:34 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 06:50:34 INFO - Cleaning up... 06:50:34 INFO - Return code: 0 06:50:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:34 INFO - 'HOME': '/Users/cltbld', 06:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:34 INFO - 'LOGNAME': 'cltbld', 06:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:34 INFO - 'MOZ_NO_REMOTE': '1', 06:50:34 INFO - 'NO_EM_RESTART': '1', 06:50:34 INFO - 'PAGER': '/bin/cat', 06:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:34 INFO - 'PWD': '/builds/slave/test', 06:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:34 INFO - 'SHELL': '/bin/bash', 06:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:34 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:34 INFO - 'USER': 'cltbld', 06:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:34 INFO - 'XPC_FLAGS': '0x0', 06:50:34 INFO - 'XPC_SERVICE_NAME': '0', 06:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:34 INFO - Downloading/unpacking psutil>=0.7.1 06:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:37 INFO - Installing collected packages: psutil 06:50:37 INFO - Running setup.py install for psutil 06:50:37 INFO - building 'psutil._psutil_osx' extension 06:50:37 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 06:50:38 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 06:50:38 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 06:50:38 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 06:50:38 INFO - building 'psutil._psutil_posix' extension 06:50:38 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 06:50:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:50:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:50:38 INFO - ^ 06:50:38 INFO - 1 warning generated. 06:50:38 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 06:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:38 INFO - Successfully installed psutil 06:50:38 INFO - Cleaning up... 06:50:38 INFO - Return code: 0 06:50:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:50:38 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')]} 06:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:38 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')]} 06:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:38 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:38 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 06:50:38 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 06:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:38 INFO - 'HOME': '/Users/cltbld', 06:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:38 INFO - 'LOGNAME': 'cltbld', 06:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:38 INFO - 'MOZ_NO_REMOTE': '1', 06:50:38 INFO - 'NO_EM_RESTART': '1', 06:50:38 INFO - 'PAGER': '/bin/cat', 06:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:38 INFO - 'PWD': '/builds/slave/test', 06:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:38 INFO - 'SHELL': '/bin/bash', 06:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:38 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:38 INFO - 'USER': 'cltbld', 06:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:38 INFO - 'XPC_FLAGS': '0x0', 06:50:38 INFO - 'XPC_SERVICE_NAME': '0', 06:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:50:41 INFO - Installing collected packages: mozsystemmonitor 06:50:41 INFO - Running setup.py install for mozsystemmonitor 06:50:41 INFO - Successfully installed mozsystemmonitor 06:50:41 INFO - Cleaning up... 06:50:41 INFO - Return code: 0 06:50:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50:41 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')]} 06:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:41 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')]} 06:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:41 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:41 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 06:50:41 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 06:50:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:41 INFO - 'HOME': '/Users/cltbld', 06:50:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:41 INFO - 'LOGNAME': 'cltbld', 06:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:41 INFO - 'MOZ_NO_REMOTE': '1', 06:50:41 INFO - 'NO_EM_RESTART': '1', 06:50:41 INFO - 'PAGER': '/bin/cat', 06:50:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:41 INFO - 'PWD': '/builds/slave/test', 06:50:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:41 INFO - 'SHELL': '/bin/bash', 06:50:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:41 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:41 INFO - 'USER': 'cltbld', 06:50:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:41 INFO - 'XPC_FLAGS': '0x0', 06:50:41 INFO - 'XPC_SERVICE_NAME': '0', 06:50:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:45 INFO - Downloading docopt-0.6.1.tar.gz 06:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:45 INFO - Running setup.py install for blobuploader 06:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:45 INFO - Running setup.py install for requests 06:50:46 INFO - Running setup.py install for docopt 06:50:46 INFO - Successfully installed blobuploader requests docopt 06:50:46 INFO - Cleaning up... 06:50:46 INFO - Return code: 0 06:50:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:46 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:46 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 06:50:46 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 06:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:46 INFO - 'HOME': '/Users/cltbld', 06:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:46 INFO - 'LOGNAME': 'cltbld', 06:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:46 INFO - 'MOZ_NO_REMOTE': '1', 06:50:46 INFO - 'NO_EM_RESTART': '1', 06:50:46 INFO - 'PAGER': '/bin/cat', 06:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:46 INFO - 'PWD': '/builds/slave/test', 06:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:46 INFO - 'SHELL': '/bin/bash', 06:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:46 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:46 INFO - 'USER': 'cltbld', 06:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:46 INFO - 'XPC_FLAGS': '0x0', 06:50:46 INFO - 'XPC_SERVICE_NAME': '0', 06:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:46 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-hVOxxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:46 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_aRplT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:46 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-wWCSbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:46 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FwMBMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:46 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-D6z9s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-LqWiEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-yFivoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-zV0_je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-3yWXL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kUV2PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kY219X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YUSopR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-I0aqoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:47 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_vcsBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:48 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-okMpQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:48 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-FZlHLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:48 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-eucc6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:48 INFO - Running setup.py install for manifestparser 06:50:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:48 INFO - Running setup.py install for mozcrash 06:50:48 INFO - Running setup.py install for mozdebug 06:50:48 INFO - Running setup.py install for mozdevice 06:50:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:48 INFO - Running setup.py install for mozfile 06:50:49 INFO - Running setup.py install for mozhttpd 06:50:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Running setup.py install for mozinfo 06:50:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Running setup.py install for mozInstall 06:50:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Running setup.py install for mozleak 06:50:49 INFO - Running setup.py install for mozlog 06:50:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Running setup.py install for moznetwork 06:50:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:49 INFO - Running setup.py install for mozprocess 06:50:50 INFO - Running setup.py install for mozprofile 06:50:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:50 INFO - Running setup.py install for mozrunner 06:50:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:50 INFO - Running setup.py install for mozscreenshot 06:50:50 INFO - Running setup.py install for moztest 06:50:50 INFO - Running setup.py install for mozversion 06:50:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:50 INFO - Cleaning up... 06:50:50 INFO - Return code: 0 06:50:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:50 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')]} 06:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:50 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')]} 06:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:50 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:50 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 06:50:50 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 06:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:50 INFO - 'HOME': '/Users/cltbld', 06:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:50 INFO - 'LOGNAME': 'cltbld', 06:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:50 INFO - 'MOZ_NO_REMOTE': '1', 06:50:50 INFO - 'NO_EM_RESTART': '1', 06:50:50 INFO - 'PAGER': '/bin/cat', 06:50:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:50 INFO - 'PWD': '/builds/slave/test', 06:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:50 INFO - 'SHELL': '/bin/bash', 06:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:50 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:50 INFO - 'USER': 'cltbld', 06:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:50 INFO - 'XPC_FLAGS': '0x0', 06:50:50 INFO - 'XPC_SERVICE_NAME': '0', 06:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-TlpaIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-hcN86Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-pkKLc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UA6hVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-8_dqNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-oUJcwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Gv3huP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:51 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)) 06:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:51 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-_wE3_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UAiiJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AYmj_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AIvSCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-2JqE51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-i8zbkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-N0SISR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-B4T3uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-VZVB20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:52 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)) 06:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:52 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-r5jEJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:52 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)) 06:50:52 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)) 06:50:52 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)) 06:50:52 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)) 06:50:52 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)) 06:50:52 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)) 06:50:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:55 INFO - Downloading blessings-1.6.tar.gz 06:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:55 INFO - Installing collected packages: blessings 06:50:55 INFO - Running setup.py install for blessings 06:50:55 INFO - Successfully installed blessings 06:50:55 INFO - Cleaning up... 06:50:55 INFO - Return code: 0 06:50:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:55 INFO - Reading from file tmpfile_stdout 06:50:55 INFO - Current package versions: 06:50:55 INFO - blessings == 1.6 06:50:55 INFO - blobuploader == 1.2.4 06:50:55 INFO - docopt == 0.6.1 06:50:55 INFO - manifestparser == 1.1 06:50:55 INFO - mozInstall == 1.12 06:50:55 INFO - mozcrash == 0.16 06:50:55 INFO - mozdebug == 0.1 06:50:55 INFO - mozdevice == 0.48 06:50:55 INFO - mozfile == 1.2 06:50:55 INFO - mozhttpd == 0.7 06:50:55 INFO - mozinfo == 0.9 06:50:55 INFO - mozleak == 0.1 06:50:55 INFO - mozlog == 3.1 06:50:55 INFO - moznetwork == 0.27 06:50:55 INFO - mozprocess == 0.22 06:50:55 INFO - mozprofile == 0.28 06:50:55 INFO - mozrunner == 6.11 06:50:55 INFO - mozscreenshot == 0.1 06:50:55 INFO - mozsystemmonitor == 0.0 06:50:55 INFO - moztest == 0.7 06:50:55 INFO - mozversion == 1.4 06:50:55 INFO - psutil == 3.1.1 06:50:55 INFO - requests == 1.2.3 06:50:55 INFO - wsgiref == 0.1.2 06:50:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:55 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')]} 06:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:55 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')]} 06:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:55 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:55 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 06:50:55 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 06:50:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:55 INFO - 'HOME': '/Users/cltbld', 06:50:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:55 INFO - 'LOGNAME': 'cltbld', 06:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:55 INFO - 'MOZ_NO_REMOTE': '1', 06:50:55 INFO - 'NO_EM_RESTART': '1', 06:50:55 INFO - 'PAGER': '/bin/cat', 06:50:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:55 INFO - 'PWD': '/builds/slave/test', 06:50:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:55 INFO - 'SHELL': '/bin/bash', 06:50:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:55 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:55 INFO - 'USER': 'cltbld', 06:50:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:55 INFO - 'XPC_FLAGS': '0x0', 06:50:55 INFO - 'XPC_SERVICE_NAME': '0', 06:50:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 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)) 06:50:56 INFO - Cleaning up... 06:50:56 INFO - Return code: 0 06:50:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:56 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:56 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 06:50:56 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 06:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:56 INFO - 'HOME': '/Users/cltbld', 06:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:56 INFO - 'LOGNAME': 'cltbld', 06:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:56 INFO - 'MOZ_NO_REMOTE': '1', 06:50:56 INFO - 'NO_EM_RESTART': '1', 06:50:56 INFO - 'PAGER': '/bin/cat', 06:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:56 INFO - 'PWD': '/builds/slave/test', 06:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:56 INFO - 'SHELL': '/bin/bash', 06:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:56 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:56 INFO - 'USER': 'cltbld', 06:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:56 INFO - 'XPC_FLAGS': '0x0', 06:50:56 INFO - 'XPC_SERVICE_NAME': '0', 06:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:56 INFO - Downloading/unpacking jsonschema 06:50:56 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 06:50:56 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 06:50:56 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 06:50:56 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 06:50:56 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 06:50:56 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 06:50:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:58 INFO - Downloading/unpacking functools32 (from jsonschema) 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:58 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 06:50:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:59 INFO - warning: no files found matching '*.txt' 06:50:59 INFO - no previously-included directories found matching 'build' 06:50:59 INFO - no previously-included directories found matching 'dist' 06:50:59 INFO - no previously-included directories found matching '.git*' 06:50:59 INFO - Installing collected packages: jsonschema, functools32 06:50:59 INFO - Running setup.py install for functools32 06:50:59 INFO - warning: no files found matching '*.txt' 06:50:59 INFO - no previously-included directories found matching 'build' 06:50:59 INFO - no previously-included directories found matching 'dist' 06:50:59 INFO - no previously-included directories found matching '.git*' 06:50:59 INFO - Successfully installed jsonschema functools32 06:50:59 INFO - Cleaning up... 06:50:59 INFO - Return code: 0 06:50:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:59 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 0x1055f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055ff4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7facdbc94700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, '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.0SloosmNjx/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.pmJa4Glx9c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 06:50:59 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 06:50:59 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 06:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:50:59 INFO - 'HOME': '/Users/cltbld', 06:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:50:59 INFO - 'LOGNAME': 'cltbld', 06:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:59 INFO - 'MOZ_NO_REMOTE': '1', 06:50:59 INFO - 'NO_EM_RESTART': '1', 06:50:59 INFO - 'PAGER': '/bin/cat', 06:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:59 INFO - 'PWD': '/builds/slave/test', 06:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:50:59 INFO - 'SHELL': '/bin/bash', 06:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:50:59 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:50:59 INFO - 'USER': 'cltbld', 06:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:59 INFO - 'XPC_FLAGS': '0x0', 06:50:59 INFO - 'XPC_SERVICE_NAME': '0', 06:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:59 INFO - Downloading/unpacking flake8 06:50:59 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 06:50:59 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 06:50:59 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 06:50:59 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 06:50:59 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 06:50:59 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 06:51:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:51:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:51:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 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 06:51:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:51:02 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 06:51:02 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 06:51:02 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 06:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:51:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:03 INFO - no previously-included directories found matching 'docs/_build' 06:51:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:51:03 INFO - Running setup.py install for pep8 06:51:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:51:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:51:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:51:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:51:03 INFO - no previously-included directories found matching 'docs/_build' 06:51:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:51:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:51:03 INFO - Cleaning up... 06:51:03 INFO - Return code: 0 06:51:03 INFO - Running post-action listener: _resource_record_post_action 06:51:03 INFO - Running post-action listener: _start_resource_monitoring 06:51:03 INFO - Starting resource monitoring. 06:51:03 INFO - ##### 06:51:03 INFO - ##### Running install step. 06:51:03 INFO - ##### 06:51:03 INFO - Running pre-action listener: _resource_record_pre_action 06:51:03 INFO - Running main action method: install 06:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:51:04 INFO - Reading from file tmpfile_stdout 06:51:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:51:04 INFO - Reading from file tmpfile_stdout 06:51:04 INFO - Output received: 06:51:04 INFO - Usage: mozinstall [options] installer 06:51:04 INFO - Options: 06:51:04 INFO - -h, --help show this help message and exit 06:51:04 INFO - -d DEST, --destination=DEST 06:51:04 INFO - Directory to install application into. [default: 06:51:04 INFO - "/builds/slave/test"] 06:51:04 INFO - --app=APP Application being installed. [default: firefox] 06:51:04 INFO - mkdir: /builds/slave/test/build/application 06:51:04 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'] 06:51:04 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 06:51:38 INFO - Reading from file tmpfile_stdout 06:51:38 INFO - Output received: 06:51:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:51:38 INFO - Running post-action listener: _resource_record_post_action 06:51:38 INFO - ##### 06:51:38 INFO - ##### Running run-tests step. 06:51:38 INFO - ##### 06:51:38 INFO - Running pre-action listener: _resource_record_pre_action 06:51:38 INFO - Running main action method: run_tests 06:51:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:51:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:51:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:51:38 INFO - 2016-03-03 06:51:38.069 screenresolution[1960:19558] starting screenresolution argv=screenresolution get 06:51:38 INFO - 2016-03-03 06:51:38.072 screenresolution[1960:19558] Display 0: 1600x1200x32@60 06:51:38 INFO - 2016-03-03 06:51:38.078 screenresolution[1961:19560] starting screenresolution argv=screenresolution list 06:51:38 INFO - Available Modes on Display 0 06:51:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:51:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:51:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:51:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:51:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:51:38 INFO - Intel Iris: 06:51:38 INFO - Chipset Model: Intel Iris 06:51:38 INFO - Type: GPU 06:51:38 INFO - Bus: Built-In 06:51:38 INFO - VRAM (Dynamic, Max): 1536 MB 06:51:38 INFO - Vendor: Intel (0x8086) 06:51:38 INFO - Device ID: 0x0a2e 06:51:38 INFO - Revision ID: 0x0009 06:51:38 INFO - Displays: 06:51:38 INFO - Display: 06:51:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:51:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:51:38 INFO - Display Serial Number: 1600x1200 60 06:51:38 INFO - Main Display: Yes 06:51:38 INFO - Mirror: Off 06:51:38 INFO - Online: Yes 06:51:38 INFO - Rotation: Supported 06:51:38 INFO - Return code: 0 06:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:51:38 INFO - Python 2.7.3 06:51:38 INFO - Return code: 0 06:51:38 INFO - grabbing minidump binary from tooltool 06:51:38 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')]} 06:51:38 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 0x10549cd30>, '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 0x1052c0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105493b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:51:38 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 06:51:38 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 06:51:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:51:38 INFO - Return code: 0 06:51:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:51:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:51:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:51:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:51:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:51:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:51:39 INFO - Return code: 0 06:51:39 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/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 06:51:39 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/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --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 06:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0SloosmNjx/Render', 06:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:51:39 INFO - 'HOME': '/Users/cltbld', 06:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:51:39 INFO - 'LOGNAME': 'cltbld', 06:51:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:39 INFO - 'MOZ_NO_REMOTE': '1', 06:51:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:39 INFO - 'NO_EM_RESTART': '1', 06:51:39 INFO - 'PAGER': '/bin/cat', 06:51:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:39 INFO - 'PWD': '/builds/slave/test', 06:51:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:51:39 INFO - 'SHELL': '/bin/bash', 06:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pmJa4Glx9c/Listeners', 06:51:39 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 06:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:51:39 INFO - 'USER': 'cltbld', 06:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:39 INFO - 'XPC_FLAGS': '0x0', 06:51:39 INFO - 'XPC_SERVICE_NAME': '0', 06:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:51:39 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/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--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 06:51:39 INFO - mozversion application_buildid: 20160303025433 06:51:39 INFO - mozversion application_changeset: 7e43bdd93e439b8c8d6e62d48d9de3e293655560 06:51:39 INFO - mozversion application_display_name: Nightly 06:51:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:51:39 INFO - mozversion application_name: Firefox 06:51:39 INFO - mozversion application_remotingname: firefox 06:51:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:51:39 INFO - mozversion application_vendor: Mozilla 06:51:39 INFO - mozversion application_version: 47.0a1 06:51:39 INFO - mozversion platform_buildid: 20160303025433 06:51:39 INFO - mozversion platform_changeset: 7e43bdd93e439b8c8d6e62d48d9de3e293655560 06:51:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:51:39 INFO - mozversion platform_version: 47.0a1 06:51:39 INFO - using testdate: 1457016699 06:51:39 INFO - actual date: 1457016699 06:51:40 INFO - starting webserver on 'localhost:56228' 06:51:40 INFO - SUITE-START | Running 2 tests 06:51:40 INFO - TEST-START | dromaeo_css 06:51:40 INFO - operating with platform_type : mac_ 06:51:40 INFO - Initialising browser for dromaeo_css test... 06:51:40 INFO - TEST-INFO | started process 1979 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpe4GbHW/profile http://localhost:56228/getInfo.html) 06:51:43 INFO - PROCESS | 1979 | __metrics Screen width/height:1600/1200 06:51:43 INFO - PROCESS | 1979 | colorDepth:24 06:51:43 INFO - PROCESS | 1979 | Browser inner width/height: 1024/689 06:51:43 INFO - PROCESS | 1979 | __metrics 06:51:43 ERROR - PROCESS | 1979 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 06:51:43 INFO - TEST-INFO | 1979: exit 0 06:51:43 INFO - Browser initialized. 06:51:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:51:43 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpe4GbHW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:56 INFO - PROCESS | 1983 | RSS: Main: 254701568 06:51:56 INFO - PROCESS | 1983 | 06:52:45 INFO - PROCESS | 1983 | 1457016765729 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] 06:54:56 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56228/tests/dromaeo/cssquery-ext.html) 06:54:57 INFO - PROCESS | 1983 | RSS: Main: 268361728 06:54:57 INFO - PROCESS | 1983 | 06:57:59 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-ext.html (next: http://localhost:56228/tests/dromaeo/cssquery-jquery.html) 06:58:00 INFO - PROCESS | 1983 | RSS: Main: 280129536 06:58:00 INFO - PROCESS | 1983 | 07:01:02 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56228/tests/dromaeo/cssquery-mootools.html) 07:01:02 INFO - PROCESS | 1983 | RSS: Main: 282083328 07:01:02 INFO - PROCESS | 1983 | 07:04:04 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56228/tests/dromaeo/cssquery-prototype.html) 07:04:04 INFO - PROCESS | 1983 | RSS: Main: 282746880 07:04:04 INFO - PROCESS | 1983 | 07:07:07 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56228/tests/dromaeo/cssquery-yui.html) 07:07:08 INFO - PROCESS | 1983 | RSS: Main: 287580160 07:07:08 INFO - PROCESS | 1983 | 07:10:10 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:56228/tests/dromaeo/cssquery-yui.html (next: http://localhost:56228/tests/dromaeo/cssquery-dojo.html) 07:10:11 INFO - PROCESS | 1983 | RSS: Main: 287645696 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | __start_tp_report 07:10:11 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 07:10:11 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 07:10:11 INFO - PROCESS | 1983 | |i|pagename|runs| 07:10:11 INFO - PROCESS | 1983 | |0;dojo.html;3504.859805607776;3505.3339865425583;3565.768225065369;3574.9642503574973;3584.820758962052;5714.428557144289;5754.942450575498;5759.222504961829;5768.826935191951;5770.538356931446;5606;5742.39704830993;5785.768569257225;5829.79595714149;5857.707114644272;5165.767540460679;5241.371035475749;5272.683638981654;5298.576113910878;5331.253624492574;5269.683818970874;5281.86795330116;5300.814471493499;5323.760430780605;5350.384705758848;5152.407473140581;5176.327077479922;5251.10731175701;5273.789048438058;5283.735813209324;5233.162693968947;5235.136202526579;5242.370915490165;5281.9207711884355;5306.965141797351;5144.56271216947;5208.765605547759;5209.791608335662;5209.817656382046;5247.422783493813;5574.163875418679;5591.860203494904;5624.3813180550105;5670.716464176775;5674.744636491368;6278.497720182374;6278.780242691484;6288.119663247149;6290.685465726695;6300.401461861115;6130.856783744145;6147.846303842395;6230.345813689542;6277.309495955441;6325.778597749103;4876.951230487721;5860.120981852756;5888.29340479141;5892.057270836645;5909.940900590982;5266.947330526722;6313.494920406449;6315.747370105236;6328.968355158195;6339.366063393623;6070.180525629072;6120.9957324329725;6169.722362493699;6224.62652240867;6234.470070044097;6130.061839218087;6145.893739127;6256.906146407808;6258.812235632939;6302.212223472066;5382.919256211082;6111.816645500642;6206.534509911775;6281.089242059876;6311.558190926683;6099.8243298231955;6180.072989051679;6214.4407003369915;6256.812295631047;6289.119523266746;4943.060818444484;4963.652544321935;4974.676646017997;4975.278584605285;4980.203167493184;4471.776411179428;4478.305862591304;4489.304157855538;4491.416115904912;4521.84173553924;4358.280883654225;5665.405132461115;5690.4025077367105;5813.389594092644;5843.970780146072;6256.374362563798;6271.43557079865;6283.591566548251;6286.591371560834;6319.083732858801;4978.477259887732;5728.125825405299;5730.398308177665;5744.655320680772;5750.568707346965;5010.123228435009;5170.922436163461;5438.15708565173;5443.972780136153;5477.561795056386;6326.49388048955;6351.333110023474;6360;6366.5861718989045;6384.074309225043;6173.351798061139;6210.534209934363;6239.875202495834;6279.183706118175;6298.0867774171575;6178.474829639351;6245.156903817927;6270.811875643738;6292.937070629235;6301.40136687014;6213.347598502092;6235.625862448268;6240.656763878031;6245.6252624842655;6269.279032911091;4957.859692270726;6137.867325793431;6279.089532017741;6290.968545157245;6323.557350985387;6042.637441753509;6116.731440059472;6129.693515324305;6150.876982460415;6201.627902325875;5396.568274538106;6044.093385992136;6125;6135.110408990582;6177.413145751147;5266.97366513165;5810.506106980785;6000.189974353581;6043.576949613484;6044.90932636002;6116.122740413202;6186.969065154645;6191.226096737908;6197.938020619917;6240.313565507881;6052.6973651316375;6060.999935010674;6061.180603024483;6094.512439004958;6099.420555047263 07:10:11 INFO - PROCESS | 1983 | |1;ext.html;423.7139930546882;551.2255281329731;589.6638915817983;592.8321207221777;624.3257282135295;29895.10314690563;36733.63266367336;37440.43839342408;37460.43809342859;37498.8125059375;39928.401073983914;40418.39372409409;40418.7979060105;40663.39004914929;40677;9353.204977576897;9547.761305967371;9590.328676992578;9601.423914565148;9646.37298575594;9392.671256506024;9461.621535138585;9468.999999999965;9537.856932146024;9574.80850382992;9488.573014214342;9569.569369378394;9579.61681532738;9586.089321514444;9604.471754053524;9440.95279523598;9479.668211612596;9494.24046076319;9495.477748723782;9559.28305377096;8682.652693892236;9444.905550944472;9549.522523873778;9572.904270957271;9581.520923953774;37663.24673506542;38073.80963095167;38085;38143.618563814285;38225;3106.7359274461473;3114.1280441476424;3436.8453419596176;3742.139307959185;3807.1433927366397;28405;28780.992665256614;28909.843606255723;28991.56512652291;29474.410511789643;2739.76711979482;2764.7235276472393;2775.736305051017;2869.024531659246;2902.100348891829;460468;462839;465723;465748;466427;57629.559261017974;58461.41538584645;58489.12266316009;58565;58676.70661646665;63938.08185754342;68174.31825681779;68323;69120;69671;15515.689686206439;15697.764533531777;15902.92048539773;16050.357985680443;16092.919535402249;10070.69787906364;10721.820599734023;12116.030717542575;12324;12419.627411177678;20623.381298561068;20940.895295523424;20942.057607407703;21014.579708405745;21015.369538913856;7421.777346679608;9159.038300978435;9208.723738287728;9241.584128714225;9245.907540924505;891.64334266294;903.385697725553;922.3589605224305;1013.2957594471771;1019.5412064570972;28667.85666071698;28711.856440718082;28994.13017609475;29202.415951680847;29347.119586412442;1042.0933787604831;1059.9188827396013;1087.8251488392516;1106.5960924262747;1176.5705517486226;12431;13771.449142034407;13803.378847951866;14049.227292498806;14063.789043164361;618393;621316;622603;630050;631691;54747.905041898935;55182.72408638011;55458.72270638621;55481.722591387595;55529;1393.7351903138372;1406.0579411793917;1414.2857856782464;1430.9713805723827;1445.7975883376337;27311;27375.315617108936;27688.307792305353;27734.890604376407;27858.303542411602;45889.311660324456;46161.30758038565;46488;46695.83260418517;46705;449928;451534;456505;456544;457748;31505.52741708922;31947.68052319447;32218.83890580532;41755.7912210437;42757.1448571033;40947.7952610235;41813.58186418097;41982.950426239586;42387.788061059495;42532.1493570133;34544.96365109051;34618;34818;35492.82253588819;35725.28549428945;30214.69785302119;34562.135946601535;34672.653273466945;34856.47715284323;35334.46998294976;33953.15117121993;34805;35929.64070359263;36545;36803;30297.848510757307;31975.840120799247;32387;32498.675013249565;33223;19215.90392048031;19545;23479.882600586887;24166.75833241645;24685.753142468344 07:10:11 INFO - PROCESS | 1983 | |2;jquery.html;351.10818520956786;359.04494045838067;359.9748017638765;360.6267513123917;361.16570721633025;18930.24279028839;18968.336108236213;19762.90118549405;19779.406617801455;19995.60008799823;18763.718544221847;18809.905950470227;19639.901800491014;19647.705284420746;19657.41027769169;5507.669539827603;5743.253377060976;5753.424657534255;5765.106408506688;5778.8266352009505;4142.917141657165;5605.355384130837;6055.182550355712;6293.276273228592;6331.303556608769;6256.718447669843;6258.749650013994;6259.624422534663;6267.185265915425;6276.121343011982;5354.785808567653;6043.7280322385595;6285.622862628257;6289.559730818844;6324.114623952651;5394.838154855361;5419.512243898029;5448.482394172547;5449.346078470569;5468.535174510172;10527.789304230035;12752.936235318764;13161.341932903317;13240;13276.336183190802;1736.2967997960845;2044.8568600197991;2068.1830676882696;2118;2147.7744836792067;8985;9038.231750301233;9980.700578982642;10873.156429985222;14199.006069575134;1641.7537369394568;1666.6583350413136;1725.956851078733;1729.0231019473956;1751.1594434671301;102159.48920255351;111259.44370278259;111378.88621113767;111717;113527;11151.888481115247;11166.106711463064;11171.44142792857;11188.272762270426;11292.153088518395;13135.146215495963;13430.865691343157;13439.664008399868;13474.797878031837;13476.191428514321;6977.7208911642965;8104.270615644502;8214.83570328602;8409.990801103906;8481.872771908425;8501;8501.532415717194;8536.74389768308;8630.266427353745;8646.2218400343;4306.956930430718;4404.559544045634;4406;4408.933865992013;4494.213512635276;1775.4496106207116;1833.6882729935942;1877.7183422486462;1887.2168050259263;1903.5812121333286;385.6394271356291;704.5490885833071;711.8327193109615;785.6582386661706;930;9841.852372214422;11339.829902551468;11951.282923024646;12027.398630068461;12247.142700011093;427.8032105231566;436.9388285640013;442.05400443051894;444.5465625062418;452.31474316410663;6031.668258245839;6113.20528331323;6168.228971378578;6239.313675495692;6241.968790156111;583564;619663;621624;625209;638779;102471;125885;126696.36651816682;129727;129868;456.0855484753115;460.9815607375667;461.04563553444046;464.13670572734685;464.8256903661127;10877.891221087688;10926.56293748273;10949.452527373758;11079.5568177272;11147.108231341635;50235.24647130369;50238;50930.745346273034;50988.49011509837;53169.13908013201;65212.36969075811;75008.24991750013;76561;78965.60517197607;79795.60102199452;7785.805354865947;7788.88316675239;8106.39202059836;8198.959005204935;8364.581770911309;11266.774664506827;11455.427228638368;12913.806292905427;13453.529126480526;13496.32518374097;10106.595736170471;11490.77018459643;11549.711257218636;11610.722820489907;11823.231489953125;11158.27471214401;11480.024197943269;11607.941960290145;11609.709757256136;11662.76674466489;11727.237729547553;11740.236884602473;11769.117316201491;12108.636740897788;12122.878771212176;8101.351891848756;8106.79733006656;8226.807112968705;8231.917680823355;8465.95767021161;11086.556537738401;11659.358735269641;11749.76500470003;11860.05119590448;11992.340421276913 07:10:11 INFO - PROCESS | 1983 | |3;mootools.html;1545.3509525999082;1548.473519003539;1785.401890366727;1903.2672421117866;1919.4241727481751;7771.650275737591;8314.41799074065;8527.701530446435;8716.259117974972;8736.781580460492;8428.873566896502;8492.19324164205;8540.74377768668;8585.270252028586;8593.95703021484;2441.4994926040163;2452.9509409811794;2462.322861213163;2466.8766561671932;2468.395243165427;2376.738558758535;2380.4048987753063;2385.105585405473;2393.3179043972473;2394.2705315939843;2374.2667852467707;2381.476075263448;2400.303911865557;2442.511497700458;2454.0797201049604;2425.599776036952;2432.2338463384067;2444.0346063304896;2450.963235551468;2465.9136930207537;2417.818663600219;2441.4506735984437;2454.1901172612993;2457.7665121813397;2458.6926634170727;8550.957245213796;8569.957150214272;8590.1839325264;8601.182887625666;8641.092685268082;5218.034663587248;5326;5347.385050719178;5352.304200453955;5375.838724838261;3564.9643503564894;3617.7286703497343;3670.4861319415304;3671.6695497405094;3697.907552311187;840.64272684109;1042.4006196437078;1062.5474351533533;1079.865016872891;1082.658962426833;11506.252093613888;11682.182247242696;11684.357360345177;11689.415529223505;11701.53193872244;4781.995780886053;4795.808167673324;4804.42346918372;4857.077155340474;4867.148249056472;9867;9955.601775929026;9970.45162516054;10009.299349045497;10027.849582256273;5353.384360798558;5362.570994320445;5391.32608423947;5409.7295135243085;5421.512063914267;4332.588404101605;4694.953050469451;4807.591354734886;4862.027594481118;4940;3738.2336620992633;3816.9427458588143;3830.540335159799;3832.7125465589634;3854.3640299350295;1288.0983311681673;1290.1356091418772;1295.6307452376216;1300.6163181861373;1316.0261406559077;1314.1589382795019;1324.1922427319328;1328.1566205459603;1329.7872340425486;1338.9799153012711;7936.007999000125;8007.479513831582;8108.918910810934;8129.187081291823;8131.837363252702;422.566868959313;494.3721473728345;500.96743711658627;507.36072548589044;507.41393690287777;6170.352113028157;6179.721912513947;6191.690415479208;6192.969035154795;6199.876002479925;10173.338732982333;10287.845682314772;10302.175825933908;10329.896701032894;10364.896351036545;9906.752331191778;10047.799044019079;10253.692389228336;10314.226433017404;10320.43237621923;8108.5945702714625;8175.550344731097;8269.21442462965;8304.460210086447;8327;7747.72882949094;7916.564588947663;7962.7213047543055;7981.760547183594;8196.713115040944;8843;9396.577154028222;9407.294452915921;9458;9703.126718595078;9500.762480937756;9835.065668761743;9868.802623947624;9870.654527091518;9987.25095617817;6733.61960798045;7145.1068616422945;7382.114146302478;7433.2195119513835;7555.320021198118;8007.919920800718;8121.066077400938;8152.225538573826;8162.428629995843;8230.135835737401;7156.570605763671;7221;7243.818904527218;7318.414526837947;7382.446316526175;7099.751508697171;7260.4554658401885;7268.164161121327;7269.877870443899;7282.927170728225;7418.591977441292;7667.194944530744;7678.769636910902;7686.192949740197;7690.154083050972;5890.646561206341;6937.895931561132;7013.859722805618;7027.543209691558;7034.613096279753;6829.556078854858;6911.861762764817;7009.824754381181;7038.894416583653;7044.189918159273 07:10:11 INFO - PROCESS | 1983 | |4;prototype.html;269.2863910636813;318.82623969936384;322.91119942015945;328.26141182339734;329.1212462724525;5540.612157149001;5632.493075623193;6938.306169383065;7045.823854403642;7048.577085374868;6888.690008949597;6906.136732908387;6926.134233220848;6933.168019837614;6938.548994315379;4833.854984350475;4945.208766597345;5038.899222015558;5045.268436076767;5123.514180887548;5013.924791128136;5019.799208031674;5041.420236672793;5050.191969284915;5066.670666406671;4076.7961601919933;4922.21244600864;5002.674826136307;5011.32347133136;5026.52248036436;4398.7243699327155;4615.65382596305;5008.12357837377;5010.3737032870895;5027.2207807789855;4313.180495705806;4316.546762589915;4321.913561728779;4323.005708686988;4323.351497275403;6377.489800815923;6684;6698.296678848699;6704.631245281507;6731.899021514681;4797.880052998703;5789.65262084272;5840.912386314166;5856.092305692625;5856.736446859902;7386.926130738678;7391.852162956765;7398.852022959511;7424.55452672836;7446.925530744732;4076.9184616307803;4492.0791237796175;4692.131955588193;4698.248280275174;4702.1771190041945;7774.766756997299;7842.29419352261;7862.68549258029;7868.0951690555175;7894.64474098667;4551.95448045522;4727.669063165614;4733.455652599995;4742.407199100113;4755.144074066701;4772.403449568804;4829.396325459317;4833.589144922651;4837.4920633333695;4844.4186697596515;4888.364512613409;5802.883942321215;5861.531077513789;5888.3228428731245;5893.823185304362;7369.115706115301;7464.290892365217;7473.51422157558;7479.289467500579;7486.737964171228;1659.31138577489;1676.9077700726334;1678.8740844436472;1679.2023788700515;1680.0675625027982;1023.4166525080782;1065.8880817514205;1067.3915867955345;1075.4031512510633;1075.7310672331917;6687.398134167948;6785.796426107225;6790;6795.932040679629;6810.659467026728;7446.515976461513;7627.389808815282;7647.847043059219;7655;7656.157822639505;6014.8195554133445;6613.702383392759;6666.400023997863;6873.793786186422;6954.09596752429;3854.9784307158625;4049.5747946465785;4104.8152833122585;4105.261053010427;4116.6912481564;7032.824179395556;8104.756857294291;8106.270435660819;8122.553259570662;8125.95937020323;7704.499207551491;7976.122626511079;8044.597770111588;8073.515589064557;8121.472104313319;6471.741130354733;7997.480163789452;8016.919830801734;8091.433599647969;8135.616945119225;6924.6537673117155;7117.252688467636;7747.18654541265;7762.262585054411;7765.301122898966;7650.273224043707;7651.426143039405;7661.770146895602;7678.846423071395;7688.192739762245;7859.921400785919;8129.065157506962;8131.349492040505;8138.87791683137;8148.388870834592;4773.594244489257;4790.233562629963;4826.493218212037;4834.758262086952;4840.031993601364;6203.286622038523;7587.317141457074;7750.302472777477;7762.534247945141;7816.7264145754625;7436.479446438698;7458.627068646438;7473.252674732484;7486.438517111347;7489.325960663567;7176.461765367514;7235.131784185932;7390.445716571171;7396.186419493743;7415.258474152542;6686;7227.313405226495;7295.124585049828;7296.671649775879;7319.268073192851;6733.831654208684;7467.402607791472;7475.738349157753;7505.549667019996;7518.849623007619;7105.928940710527;7219.350258476762;7318.63406829667;7328.706851725871;7332.376747976482 07:10:11 INFO - PROCESS | 1983 | |5;yui.html;663.1975309875052;680.4114441008526;712.6543626341223;722.9240929702385;723.1683563901514;14655;14696.559103226893;14822.851771482281;14865.851341486581;14884.181370024644;13320.267385293804;14014.78977815331;14025.78961315581;14040.508582199625;14050.08674436161;724.2467833453202;859.3168431097262;859.7549698335991;864.5763575847852;895.9686410975618;871.1201686296822;884.6196135661663;886.9689560865371;887.7603047177258;889.7019498468021;924.4915296586884;927.8932922713873;931.9394239374419;934.9672761453351;936.3071327217843;884.385352180235;889.6530353162271;912.1380295620642;926.0646746785727;926.3237836379448;657.2474516678424;660.8480049588574;674.7773234832493;686.498855835243;694.9861002779916;14444.277786110653;14543.400225975134;14714.33785479656;14748.778768318483;14761.040532365361;10118.747031324203;12501.749965000648;12637.74724505514;12811.231326120462;12820.230786152768;8530.402871798977;9830.311878168532;9871.568622549761;9934.801303973953;9964.850527242097;3288.293017001356;3435.4159792835276;3472.670096340869;3485.8954231372845;3488.1105318143964;82078;82135;82776;82977.75533367065;83021;9307.348485606079;9520.190783783455;9588.280878933969;9700;9793.314467987315;20918.58162836765;21322;21355.572888542454;21434.78565214328;21453.356399308046;7312.726785368564;7348.52234604749;7407.444441666897;7472.17806041335;7536.698532058656;4025.677945764332;4036.2734707752297;4067.247559201557;4076.103257283393;4090.284200264942;3445.3970555152746;3484.9651503484642;3485.302939412077;3490.0402389343135;3494.580650321978;564.2467306146259;656.3731636287334;659.4164164714167;659.4262991197593;661.4014317043084;545.4055079962859;573.7590212110923;581.0934941491287;586.1647152807233;603.3966033966034;6315.905261421082;7874.803129921684;7948.761537153895;7971.561564113914;8162.632681529345;483.3619622098866;506.9366329208849;518.5203686589889;524.3079135541126;550.620072150215;3358.261182539837;3725.9068523287133;3844.500214972036;3867.6398832936275;3921.3529767588598;84726.576367119;86323;86803;86946;87357.25285494255;76171.61914190394;76302;77241;77773.61113194398;78122.60938695385;65464.69070618561;66001;66239;66800.6659966697;67110.66444667746;7711.961440192763;7770.689172433039;7792.2986931176465;7854.136045035156;7994.2805147537;48071.03857922752;48559.5144048555;49124;49376.75311623419;50242.49757502378;58634;61797.691011546456;70367.64816175886;70909.6454517724;71174.28825711677;10632.41521716313;10638.680839574825;10733.195010374096;10830.945845270724;11090.778184436105;11795.528178873092;11869.5845645402;12247.448864800926;12329.815052774395;12344;10990.835137473105;11239.325640461599;11812.468438920441;11869.347185904859;12324.938375308066;10893.128549715846;11199.66401007971;11301.660950171508;11526.538938442369;11613.825792612948;10936.617218397318;10992.945035274772;11041.613543525938;11414.429278535874;11520.251183673034;9261.351705380559;9272.72181834546;9315.72052838416;9424.811503770023;9743.805123897624;9288.210502107397;9343.205827504738;9367.85948210791;9400.95299523498;9542.570584323583 07:10:11 INFO - PROCESS | 1983 | __end_tp_report 07:10:11 INFO - PROCESS | 1983 | __start_cc_report 07:10:11 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,348 07:10:11 INFO - PROCESS | 1983 | __end_cc_report 07:10:11 INFO - PROCESS | 1983 | __startTimestamp1457017811008__endTimestamp 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | ------- Summary: start ------- 07:10:11 INFO - PROCESS | 1983 | Number of tests: 6 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#0] dojo.html Cycles:165 Average:5736.69 Median:6042.64 stddev:636.82 (10.5%) stddev-sans-first:614.23 07:10:11 INFO - PROCESS | 1983 | Values: 3504.9 3505.3 3565.8 3575.0 3584.8 5714.4 5754.9 5759.2 5768.8 5770.5 5606.0 5742.4 5785.8 5829.8 5857.7 5165.8 5241.4 5272.7 5298.6 5331.3 5269.7 5281.9 5300.8 5323.8 5350.4 5152.4 5176.3 5251.1 5273.8 5283.7 5233.2 5235.1 5242.4 5281.9 5307.0 5144.6 5208.8 5209.8 5209.8 5247.4 5574.2 5591.9 5624.4 5670.7 5674.7 6278.5 6278.8 6288.1 6290.7 6300.4 6130.9 6147.8 6230.3 6277.3 6325.8 4877.0 5860.1 5888.3 5892.1 5909.9 5266.9 6313.5 6315.7 6329.0 6339.4 6070.2 6121.0 6169.7 6224.6 6234.5 6130.1 6145.9 6256.9 6258.8 6302.2 5382.9 6111.8 6206.5 6281.1 6311.6 6099.8 6180.1 6214.4 6256.8 6289.1 4943.1 4963.7 4974.7 4975.3 4980.2 4471.8 4478.3 4489.3 4491.4 4521.8 4358.3 5665.4 5690.4 5813.4 5844.0 6256.4 6271.4 6283.6 6286.6 6319.1 4978.5 5728.1 5730.4 5744.7 5750.6 5010.1 5170.9 5438.2 5444.0 5477.6 6326.5 6351.3 6360.0 6366.6 6384.1 6173.4 6210.5 6239.9 6279.2 6298.1 6178.5 6245.2 6270.8 6292.9 6301.4 6213.3 6235.6 6240.7 6245.6 6269.3 4957.9 6137.9 6279.1 6291.0 6323.6 6042.6 6116.7 6129.7 6150.9 6201.6 5396.6 6044.1 6125.0 6135.1 6177.4 5267.0 5810.5 6000.2 6043.6 6044.9 6116.1 6187.0 6191.2 6197.9 6240.3 6052.7 6061.0 6061.2 6094.5 6099.4 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#1] ext.html Cycles:180 Average:64902.14 Median:20940.48 stddev:138899.36 (663.3%) stddev-sans-first:139204.65 07:10:11 INFO - PROCESS | 1983 | Values: 423.7 551.2 589.7 592.8 624.3 29895.1 36733.6 37440.4 37460.4 37498.8 39928.4 40418.4 40418.8 40663.4 40677.0 9353.2 9547.8 9590.3 9601.4 9646.4 9392.7 9461.6 9469.0 9537.9 9574.8 9488.6 9569.6 9579.6 9586.1 9604.5 9441.0 9479.7 9494.2 9495.5 9559.3 8682.7 9444.9 9549.5 9572.9 9581.5 37663.2 38073.8 38085.0 38143.6 38225.0 3106.7 3114.1 3436.8 3742.1 3807.1 28405.0 28781.0 28909.8 28991.6 29474.4 2739.8 2764.7 2775.7 2869.0 2902.1 460468.0 462839.0 465723.0 465748.0 466427.0 57629.6 58461.4 58489.1 58565.0 58676.7 63938.1 68174.3 68323.0 69120.0 69671.0 15515.7 15697.8 15902.9 16050.4 16092.9 10070.7 10721.8 12116.0 12324.0 12419.6 20623.4 20940.9 20942.1 21014.6 21015.4 7421.8 9159.0 9208.7 9241.6 9245.9 891.6 903.4 922.4 1013.3 1019.5 28667.9 28711.9 28994.1 29202.4 29347.1 1042.1 1059.9 1087.8 1106.6 1176.6 12431.0 13771.4 13803.4 14049.2 14063.8 618393.0 621316.0 622603.0 630050.0 631691.0 54747.9 55182.7 55458.7 55481.7 55529.0 1393.7 1406.1 1414.3 1431.0 1445.8 27311.0 27375.3 27688.3 27734.9 27858.3 45889.3 46161.3 46488.0 46695.8 46705.0 449928.0 451534.0 456505.0 456544.0 457748.0 31505.5 31947.7 32218.8 41755.8 42757.1 40947.8 41813.6 41983.0 42387.8 42532.1 34545.0 34618.0 34818.0 35492.8 35725.3 30214.7 34562.1 34672.7 34856.5 35334.5 33953.2 34805.0 35929.6 36545.0 36803.0 30297.8 31975.8 32387.0 32498.7 33223.0 19215.9 19545.0 23479.9 24166.8 24685.8 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#2] jquery.html Cycles:180 Average:34028.54 Median:373.40 stddev:102850.61 (27544.2%) stddev-sans-first:103108.04 07:10:11 INFO - PROCESS | 1983 | Values: 351.1 359.0 360.0 360.6 361.2 18930.2 18968.3 19762.9 19779.4 19995.6 18763.7 18809.9 19639.9 19647.7 19657.4 5507.7 5743.3 5753.4 5765.1 5778.8 4142.9 5605.4 6055.2 6293.3 6331.3 6256.7 6258.7 6259.6 6267.2 6276.1 5354.8 6043.7 6285.6 6289.6 6324.1 5394.8 5419.5 5448.5 5449.3 5468.5 10527.8 12752.9 13161.3 13240.0 13276.3 1736.3 2044.9 2068.2 2118.0 2147.8 8985.0 9038.2 9980.7 10873.2 14199.0 1641.8 1666.7 1726.0 1729.0 1751.2 102159.5 111259.4 111378.9 111717.0 113527.0 11151.9 11166.1 11171.4 11188.3 11292.2 13135.1 13430.9 13439.7 13474.8 13476.2 6977.7 8104.3 8214.8 8410.0 8481.9 8501.0 8501.5 8536.7 8630.3 8646.2 4307.0 4404.6 4406.0 4408.9 4494.2 1775.4 1833.7 1877.7 1887.2 1903.6 385.6 704.5 711.8 785.7 930.0 9841.9 11339.8 11951.3 12027.4 12247.1 427.8 436.9 442.1 444.5 452.3 6031.7 6113.2 6168.2 6239.3 6242.0 583564.0 619663.0 621624.0 625209.0 638779.0 102471.0 125885.0 126696.4 129727.0 129868.0 456.1 461.0 461.0 464.1 464.8 10877.9 10926.6 10949.5 11079.6 11147.1 50235.2 50238.0 50930.7 50988.5 53169.1 65212.4 75008.2 76561.0 78965.6 79795.6 7785.8 7788.9 8106.4 8199.0 8364.6 11266.8 11455.4 12913.8 13453.5 13496.3 10106.6 11490.8 11549.7 11610.7 11823.2 11158.3 11480.0 11607.9 11609.7 11662.8 11727.2 11740.2 11769.1 12108.6 12122.9 8101.4 8106.8 8226.8 8231.9 8466.0 11086.6 11659.4 11749.8 11860.1 11992.3 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#3] mootools.html Cycles:180 Average:5950.89 Median:5369.20 stddev:3129.69 (58.3%) stddev-sans-first:3120.95 07:10:11 INFO - PROCESS | 1983 | Values: 1545.4 1548.5 1785.4 1903.3 1919.4 7771.7 8314.4 8527.7 8716.3 8736.8 8428.9 8492.2 8540.7 8585.3 8594.0 2441.5 2453.0 2462.3 2466.9 2468.4 2376.7 2380.4 2385.1 2393.3 2394.3 2374.3 2381.5 2400.3 2442.5 2454.1 2425.6 2432.2 2444.0 2451.0 2465.9 2417.8 2441.5 2454.2 2457.8 2458.7 8551.0 8570.0 8590.2 8601.2 8641.1 5218.0 5326.0 5347.4 5352.3 5375.8 3565.0 3617.7 3670.5 3671.7 3697.9 840.6 1042.4 1062.5 1079.9 1082.7 11506.3 11682.2 11684.4 11689.4 11701.5 4782.0 4795.8 4804.4 4857.1 4867.1 9867.0 9955.6 9970.5 10009.3 10027.8 5353.4 5362.6 5391.3 5409.7 5421.5 4332.6 4695.0 4807.6 4862.0 4940.0 3738.2 3816.9 3830.5 3832.7 3854.4 1288.1 1290.1 1295.6 1300.6 1316.0 1314.2 1324.2 1328.2 1329.8 1339.0 7936.0 8007.5 8108.9 8129.2 8131.8 422.6 494.4 501.0 507.4 507.4 6170.4 6179.7 6191.7 6193.0 6199.9 10173.3 10287.8 10302.2 10329.9 10364.9 9906.8 10047.8 10253.7 10314.2 10320.4 8108.6 8175.6 8269.2 8304.5 8327.0 7747.7 7916.6 7962.7 7981.8 8196.7 8843.0 9396.6 9407.3 9458.0 9703.1 9500.8 9835.1 9868.8 9870.7 9987.3 6733.6 7145.1 7382.1 7433.2 7555.3 8007.9 8121.1 8152.2 8162.4 8230.1 7156.6 7221.0 7243.8 7318.4 7382.4 7099.8 7260.5 7268.2 7269.9 7282.9 7418.6 7667.2 7678.8 7686.2 7690.2 5890.6 6937.9 7013.9 7027.5 7034.6 6829.6 6911.9 7009.8 7038.9 7044.2 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#4] prototype.html Cycles:180 Average:5993.68 Median:6787.90 stddev:1972.62 (29.1%) stddev-sans-first:1930.79 07:10:11 INFO - PROCESS | 1983 | Values: 269.3 318.8 322.9 328.3 329.1 5540.6 5632.5 6938.3 7045.8 7048.6 6888.7 6906.1 6926.1 6933.2 6938.5 4833.9 4945.2 5038.9 5045.3 5123.5 5013.9 5019.8 5041.4 5050.2 5066.7 4076.8 4922.2 5002.7 5011.3 5026.5 4398.7 4615.7 5008.1 5010.4 5027.2 4313.2 4316.5 4321.9 4323.0 4323.4 6377.5 6684.0 6698.3 6704.6 6731.9 4797.9 5789.7 5840.9 5856.1 5856.7 7386.9 7391.9 7398.9 7424.6 7446.9 4076.9 4492.1 4692.1 4698.2 4702.2 7774.8 7842.3 7862.7 7868.1 7894.6 4552.0 4727.7 4733.5 4742.4 4755.1 4772.4 4829.4 4833.6 4837.5 4844.4 4888.4 5802.9 5861.5 5888.3 5893.8 7369.1 7464.3 7473.5 7479.3 7486.7 1659.3 1676.9 1678.9 1679.2 1680.1 1023.4 1065.9 1067.4 1075.4 1075.7 6687.4 6785.8 6790.0 6795.9 6810.7 7446.5 7627.4 7647.8 7655.0 7656.2 6014.8 6613.7 6666.4 6873.8 6954.1 3855.0 4049.6 4104.8 4105.3 4116.7 7032.8 8104.8 8106.3 8122.6 8126.0 7704.5 7976.1 8044.6 8073.5 8121.5 6471.7 7997.5 8016.9 8091.4 8135.6 6924.7 7117.3 7747.2 7762.3 7765.3 7650.3 7651.4 7661.8 7678.8 7688.2 7859.9 8129.1 8131.3 8138.9 8148.4 4773.6 4790.2 4826.5 4834.8 4840.0 6203.3 7587.3 7750.3 7762.5 7816.7 7436.5 7458.6 7473.3 7486.4 7489.3 7176.5 7235.1 7390.4 7396.2 7415.3 6686.0 7227.3 7295.1 7296.7 7319.3 6733.8 7467.4 7475.7 7505.5 7518.8 7105.9 7219.4 7318.6 7328.7 7332.4 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - PROCESS | 1983 | [#5] yui.html Cycles:180 Average:17895.61 Median:656.81 stddev:25046.84 (3813.4%) stddev-sans-first:25083.68 07:10:11 INFO - PROCESS | 1983 | Values: 663.2 680.4 712.7 722.9 723.2 14655.0 14696.6 14822.9 14865.9 14884.2 13320.3 14014.8 14025.8 14040.5 14050.1 724.2 859.3 859.8 864.6 896.0 871.1 884.6 887.0 887.8 889.7 924.5 927.9 931.9 935.0 936.3 884.4 889.7 912.1 926.1 926.3 657.2 660.8 674.8 686.5 695.0 14444.3 14543.4 14714.3 14748.8 14761.0 10118.7 12501.7 12637.7 12811.2 12820.2 8530.4 9830.3 9871.6 9934.8 9964.9 3288.3 3435.4 3472.7 3485.9 3488.1 82078.0 82135.0 82776.0 82977.8 83021.0 9307.3 9520.2 9588.3 9700.0 9793.3 20918.6 21322.0 21355.6 21434.8 21453.4 7312.7 7348.5 7407.4 7472.2 7536.7 4025.7 4036.3 4067.2 4076.1 4090.3 3445.4 3485.0 3485.3 3490.0 3494.6 564.2 656.4 659.4 659.4 661.4 545.4 573.8 581.1 586.2 603.4 6315.9 7874.8 7948.8 7971.6 8162.6 483.4 506.9 518.5 524.3 550.6 3358.3 3725.9 3844.5 3867.6 3921.4 84726.6 86323.0 86803.0 86946.0 87357.3 76171.6 76302.0 77241.0 77773.6 78122.6 65464.7 66001.0 66239.0 66800.7 67110.7 7712.0 7770.7 7792.3 7854.1 7994.3 48071.0 48559.5 49124.0 49376.8 50242.5 58634.0 61797.7 70367.6 70909.6 71174.3 10632.4 10638.7 10733.2 10830.9 11090.8 11795.5 11869.6 12247.4 12329.8 12344.0 10990.8 11239.3 11812.5 11869.3 12324.9 10893.1 11199.7 11301.7 11526.5 11613.8 10936.6 10992.9 11041.6 11414.4 11520.3 9261.4 9272.7 9315.7 9424.8 9743.8 9288.2 9343.2 9367.9 9401.0 9542.6 07:10:11 INFO - PROCESS | 1983 | -------- Summary: end -------- 07:10:11 INFO - PROCESS | 1983 | 07:10:11 INFO - TEST-INFO | 1983: exit 0 07:10:11 INFO - TEST-OK | dromaeo_css | took 1111179ms 07:10:11 INFO - TEST-START | kraken 07:10:11 INFO - operating with platform_type : mac_ 07:10:11 INFO - Initialising browser for kraken test... 07:10:11 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp93GRJC/profile http://localhost:56228/getInfo.html) 07:10:14 INFO - PROCESS | 1988 | __metrics Screen width/height:1600/1200 07:10:14 INFO - PROCESS | 1988 | colorDepth:24 07:10:14 INFO - PROCESS | 1988 | Browser inner width/height: 1024/689 07:10:14 INFO - PROCESS | 1988 | __metrics 07:10:14 ERROR - PROCESS | 1988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 07:10:14 INFO - TEST-INFO | 1988: exit 0 07:10:14 INFO - Browser initialized. 07:10:14 INFO - Running cycle 1/1 for kraken test... 07:10:14 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmp93GRJC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:26 INFO - PROCESS | 1991 | RSS: Main: 254050304 07:10:26 INFO - PROCESS | 1991 | 07:10:29 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection) 07:10:30 INFO - PROCESS | 1991 | RSS: Main: 268611584 07:10:30 INFO - PROCESS | 1991 | 07:10:32 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-dft) 07:10:33 INFO - PROCESS | 1991 | RSS: Main: 276901888 07:10:33 INFO - PROCESS | 1991 | 07:10:36 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-fft) 07:10:37 INFO - PROCESS | 1991 | RSS: Main: 279330816 07:10:37 INFO - PROCESS | 1991 | 07:10:39 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator) 07:10:40 INFO - PROCESS | 1991 | RSS: Main: 281092096 07:10:40 INFO - PROCESS | 1991 | 07:10:42 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:10:42 INFO - PROCESS | 1991 | RSS: Main: 281972736 07:10:42 INFO - PROCESS | 1991 | 07:10:45 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom) 07:10:46 INFO - PROCESS | 1991 | RSS: Main: 282071040 07:10:46 INFO - PROCESS | 1991 | 07:10:49 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate) 07:10:49 INFO - PROCESS | 1991 | RSS: Main: 281858048 07:10:49 INFO - PROCESS | 1991 | 07:10:52 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial) 07:10:53 INFO - PROCESS | 1991 | RSS: Main: 281964544 07:10:53 INFO - PROCESS | 1991 | 07:10:54 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:10:55 INFO - PROCESS | 1991 | RSS: Main: 282619904 07:10:55 INFO - PROCESS | 1991 | 07:10:57 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:58 INFO - PROCESS | 1991 | RSS: Main: 281931776 07:10:58 INFO - PROCESS | 1991 | 07:11:00 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:00 INFO - PROCESS | 1991 | RSS: Main: 282714112 07:11:00 INFO - PROCESS | 1991 | 07:11:03 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:11:04 INFO - PROCESS | 1991 | RSS: Main: 282062848 07:11:04 INFO - PROCESS | 1991 | 07:11:06 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:11:07 INFO - PROCESS | 1991 | RSS: Main: 282664960 07:11:07 INFO - PROCESS | 1991 | 07:11:08 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:56228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56228/tests/kraken/driver.html?testName=ai-astar) 07:11:09 INFO - PROCESS | 1991 | RSS: Main: 284938240 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | __start_tp_report 07:11:09 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 07:11:09 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 07:11:09 INFO - PROCESS | 1991 | |i|pagename|runs| 07:11:09 INFO - PROCESS | 1991 | |0;ai-astar;115;110;115;114;114;127;124;165;166;107 07:11:09 INFO - PROCESS | 1991 | |1;audio-beat-detection;154;123;143;154;160;172;172;110;194;155 07:11:09 INFO - PROCESS | 1991 | |2;audio-dft;209;281;217;210;213;217;186;166;258;279 07:11:09 INFO - PROCESS | 1991 | |3;audio-fft;76;67;71;126;55;78;80;48;71;77 07:11:09 INFO - PROCESS | 1991 | |4;audio-oscillator;86;87;119;81;81;88;122;81;108;163 07:11:09 INFO - PROCESS | 1991 | |5;imaging-gaussian-blur;91;86;88;86;108;86;88;86;111;110 07:11:09 INFO - PROCESS | 1991 | |6;imaging-darkroom;153;94;94;95;94;105;94;95;92;135 07:11:09 INFO - PROCESS | 1991 | |7;imaging-desaturate;96;100;95;97;108;142;100;96;158;147 07:11:09 INFO - PROCESS | 1991 | |8;json-parse-financial;56;52;50;52;52;52;50;61;58;55 07:11:09 INFO - PROCESS | 1991 | |9;json-stringify-tinderbox;67;66;71;68;113;108;103;104;74;69 07:11:09 INFO - PROCESS | 1991 | |10;stanford-crypto-aes;88;84;87;78;85;86;75;103;111;110 07:11:09 INFO - PROCESS | 1991 | |11;stanford-crypto-ccm;123;128;137;141;131;139;134;133;126;126 07:11:09 INFO - PROCESS | 1991 | |12;stanford-crypto-pbkdf2;142;142;143;141;143;129;139;144;145;131 07:11:09 INFO - PROCESS | 1991 | |13;stanford-crypto-sha256-iterative;66;68;68;66;68;67;68;69;70;66 07:11:09 INFO - PROCESS | 1991 | __end_tp_report 07:11:09 INFO - PROCESS | 1991 | __start_cc_report 07:11:09 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,889 07:11:09 INFO - PROCESS | 1991 | __end_cc_report 07:11:09 INFO - PROCESS | 1991 | __startTimestamp1457017869092__endTimestamp 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | ------- Summary: start ------- 07:11:09 INFO - PROCESS | 1991 | Number of tests: 14 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#0] ai-astar Cycles:10 Average:125.70 Median:119.50 stddev:21.79 (18.2%) stddev-sans-first:22.76 07:11:09 INFO - PROCESS | 1991 | Values: 115.0 110.0 115.0 114.0 114.0 127.0 124.0 165.0 166.0 107.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:157.50 stddev:24.27 (15.4%) stddev-sans-first:25.74 07:11:09 INFO - PROCESS | 1991 | Values: 154.0 123.0 143.0 154.0 160.0 172.0 172.0 110.0 194.0 155.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#2] audio-dft Cycles:10 Average:223.60 Median:217.00 stddev:37.82 (17.4%) stddev-sans-first:39.75 07:11:09 INFO - PROCESS | 1991 | Values: 209.0 281.0 217.0 210.0 213.0 217.0 186.0 166.0 258.0 279.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#3] audio-fft Cycles:10 Average:74.90 Median:73.50 stddev:20.72 (28.2%) stddev-sans-first:21.98 07:11:09 INFO - PROCESS | 1991 | Values: 76.0 67.0 71.0 126.0 55.0 78.0 80.0 48.0 71.0 77.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:81.00 stddev:26.76 (33.0%) stddev-sans-first:27.78 07:11:09 INFO - PROCESS | 1991 | Values: 86.0 87.0 119.0 81.0 81.0 88.0 122.0 81.0 108.0 163.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:86.00 stddev:10.94 (12.7%) stddev-sans-first:11.55 07:11:09 INFO - PROCESS | 1991 | Values: 91.0 86.0 88.0 86.0 108.0 86.0 88.0 86.0 111.0 110.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#6] imaging-darkroom Cycles:10 Average:105.10 Median:94.00 stddev:21.23 (22.6%) stddev-sans-first:13.73 07:11:09 INFO - PROCESS | 1991 | Values: 153.0 94.0 94.0 95.0 94.0 105.0 94.0 95.0 92.0 135.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#7] imaging-desaturate Cycles:10 Average:113.90 Median:126.50 stddev:24.80 (19.6%) stddev-sans-first:25.44 07:11:09 INFO - PROCESS | 1991 | Values: 96.0 100.0 95.0 97.0 108.0 142.0 100.0 96.0 158.0 147.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:3.61 (6.8%) stddev-sans-first:3.75 07:11:09 INFO - PROCESS | 1991 | Values: 56.0 52.0 50.0 52.0 52.0 52.0 50.0 61.0 58.0 55.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#9] json-stringify-tinderbox Cycles:10 Average:84.30 Median:67.50 stddev:19.83 (29.4%) stddev-sans-first:20.02 07:11:09 INFO - PROCESS | 1991 | Values: 67.0 66.0 71.0 68.0 113.0 108.0 103.0 104.0 74.0 69.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:84.50 stddev:12.75 (15.1%) stddev-sans-first:13.49 07:11:09 INFO - PROCESS | 1991 | Values: 88.0 84.0 87.0 78.0 85.0 86.0 75.0 103.0 111.0 110.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:133.50 stddev:6.05 (4.5%) stddev-sans-first:5.52 07:11:09 INFO - PROCESS | 1991 | Values: 123.0 128.0 137.0 141.0 131.0 139.0 134.0 133.0 126.0 126.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.90 Median:142.50 stddev:5.49 (3.9%) stddev-sans-first:5.77 07:11:09 INFO - PROCESS | 1991 | Values: 142.0 142.0 143.0 141.0 143.0 129.0 139.0 144.0 145.0 131.0 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - PROCESS | 1991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.30 07:11:09 INFO - PROCESS | 1991 | Values: 66.0 68.0 68.0 66.0 68.0 67.0 68.0 69.0 70.0 66.0 07:11:09 INFO - PROCESS | 1991 | -------- Summary: end -------- 07:11:09 INFO - PROCESS | 1991 | 07:11:09 INFO - TEST-INFO | 1991: exit 0 07:11:09 INFO - TEST-OK | kraken | took 58311ms 07:11:09 INFO - SUITE-END | took 1169s 07:11:10 INFO - Completed test suite (00:19:29) 07:11:10 INFO - Working with test: dromaeo_css 07:11:10 INFO - Generating results file: dromaeo_css 07:11:10 INFO - Working with test: kraken 07:11:10 INFO - Generating results file: kraken 07:11:10 INFO - javascript benchmark 07:11:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 07:11:10 INFO - process_Request line: dromaeo_css 7361.21 graph.html#tests=[[72,1,61]] 07:11:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:11:10 INFO - process_Request line: kraken 1560.60 graph.html#tests=[[232,1,61]] 07:11:10 INFO - RETURN: dromaeo_css: 7361.21 07:11:10 INFO - RETURN: kraken: 1560.60 07:11:10 INFO - javascript benchmark 07:11:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3504.859805607776, 3505.3339865425583, 3565.768225065369, 3574.9642503574973, 3584.820758962052, 5714.428557144289, 5754.942450575498, 5759.222504961829, 5768.826935191951, 5770.538356931446, 5606.0, 5742.39704830993, 5785.768569257225, 5829.79595714149, 5857.707114644272, 5165.767540460679, 5241.371035475749, 5272.683638981654, 5298.576113910878, 5331.253624492574, 5269.683818970874, 5281.86795330116, 5300.814471493499, 5323.760430780605, 5350.384705758848, 5152.407473140581, 5176.327077479922, 5251.10731175701, 5273.789048438058, 5283.735813209324, 5233.162693968947, 5235.136202526579, 5242.370915490165, 5281.9207711884355, 5306.965141797351, 5144.56271216947, 5208.765605547759, 5209.791608335662, 5209.817656382046, 5247.422783493813, 5574.163875418679, 5591.860203494904, 5624.3813180550105, 5670.716464176775, 5674.744636491368, 6278.497720182374, 6278.780242691484, 6288.119663247149, 6290.685465726695, 6300.401461861115, 6130.856783744145, 6147.846303842395, 6230.345813689542, 6277.309495955441, 6325.778597749103, 4876.951230487721, 5860.120981852756, 5888.29340479141, 5892.057270836645, 5909.940900590982, 5266.947330526722, 6313.494920406449, 6315.747370105236, 6328.968355158195, 6339.366063393623, 6070.180525629072, 6120.9957324329725, 6169.722362493699, 6224.62652240867, 6234.470070044097, 6130.061839218087, 6145.893739127, 6256.906146407808, 6258.812235632939, 6302.212223472066, 5382.919256211082, 6111.816645500642, 6206.534509911775, 6281.089242059876, 6311.558190926683, 6099.8243298231955, 6180.072989051679, 6214.4407003369915, 6256.812295631047, 6289.119523266746, 4943.060818444484, 4963.652544321935, 4974.676646017997, 4975.278584605285, 4980.203167493184, 4471.776411179428, 4478.305862591304, 4489.304157855538, 4491.416115904912, 4521.84173553924, 4358.280883654225, 5665.405132461115, 5690.4025077367105, 5813.389594092644, 5843.970780146072, 6256.374362563798, 6271.43557079865, 6283.591566548251, 6286.591371560834, 6319.083732858801, 4978.477259887732, 5728.125825405299, 5730.398308177665, 5744.655320680772, 5750.568707346965, 5010.123228435009, 5170.922436163461, 5438.15708565173, 5443.972780136153, 5477.561795056386, 6326.49388048955, 6351.333110023474, 6360.0, 6366.5861718989045, 6384.074309225043, 6173.351798061139, 6210.534209934363, 6239.875202495834, 6279.183706118175, 6298.0867774171575, 6178.474829639351, 6245.156903817927, 6270.811875643738, 6292.937070629235, 6301.40136687014, 6213.347598502092, 6235.625862448268, 6240.656763878031, 6245.6252624842655, 6269.279032911091, 4957.859692270726, 6137.867325793431, 6279.089532017741, 6290.968545157245, 6323.557350985387, 6042.637441753509, 6116.731440059472, 6129.693515324305, 6150.876982460415, 6201.627902325875, 5396.568274538106, 6044.093385992136, 6125.0, 6135.110408990582, 6177.413145751147, 5266.97366513165, 5810.506106980785, 6000.189974353581, 6043.576949613484, 6044.90932636002, 6116.122740413202, 6186.969065154645, 6191.226096737908, 6197.938020619917, 6240.313565507881, 6052.6973651316375, 6060.999935010674, 6061.180603024483, 6094.512439004958, 6099.420555047263], "unit": "score", "name": "dojo.html", "value": 5700.218250305271}, {"lowerIsBetter": false, "replicates": [423.7139930546882, 551.2255281329731, 589.6638915817983, 592.8321207221777, 624.3257282135295, 29895.10314690563, 36733.63266367336, 37440.43839342408, 37460.43809342859, 37498.8125059375, 39928.401073983914, 40418.39372409409, 40418.7979060105, 40663.39004914929, 40677.0, 9353.204977576897, 9547.761305967371, 9590.328676992578, 9601.423914565148, 9646.37298575594, 9392.671256506024, 9461.621535138585, 9468.999999999965, 9537.856932146024, 9574.80850382992, 9488.573014214342, 9569.569369378394, 9579.61681532738, 9586.089321514444, 9604.471754053524, 9440.95279523598, 9479.668211612596, 9494.24046076319, 9495.477748723782, 9559.28305377096, 8682.652693892236, 9444.905550944472, 9549.522523873778, 9572.904270957271, 9581.520923953774, 37663.24673506542, 38073.80963095167, 38085.0, 38143.618563814285, 38225.0, 3106.7359274461473, 3114.1280441476424, 3436.8453419596176, 3742.139307959185, 3807.1433927366397, 28405.0, 28780.992665256614, 28909.843606255723, 28991.56512652291, 29474.410511789643, 2739.76711979482, 2764.7235276472393, 2775.736305051017, 2869.024531659246, 2902.100348891829, 460468.0, 462839.0, 465723.0, 465748.0, 466427.0, 57629.559261017974, 58461.41538584645, 58489.12266316009, 58565.0, 58676.70661646665, 63938.08185754342, 68174.31825681779, 68323.0, 69120.0, 69671.0, 15515.689686206439, 15697.764533531777, 15902.92048539773, 16050.357985680443, 16092.919535402249, 10070.69787906364, 10721.820599734023, 12116.030717542575, 12324.0, 12419.627411177678, 20623.381298561068, 20940.895295523424, 20942.057607407703, 21014.579708405745, 21015.369538913856, 7421.777346679608, 9159.038300978435, 9208.723738287728, 9241.584128714225, 9245.907540924505, 891.64334266294, 903.385697725553, 922.3589605224305, 1013.2957594471771, 1019.5412064570972, 28667.85666071698, 28711.856440718082, 28994.13017609475, 29202.415951680847, 29347.119586412442, 1042.0933787604831, 1059.9188827396013, 1087.8251488392516, 1106.5960924262747, 1176.5705517486226, 12431.0, 13771.449142034407, 13803.378847951866, 14049.227292498806, 14063.789043164361, 618393.0, 621316.0, 622603.0, 630050.0, 631691.0, 54747.905041898935, 55182.72408638011, 55458.72270638621, 55481.722591387595, 55529.0, 1393.7351903138372, 1406.0579411793917, 1414.2857856782464, 1430.9713805723827, 1445.7975883376337, 27311.0, 27375.315617108936, 27688.307792305353, 27734.890604376407, 27858.303542411602, 45889.311660324456, 46161.30758038565, 46488.0, 46695.83260418517, 46705.0, 449928.0, 451534.0, 456505.0, 456544.0, 457748.0, 31505.52741708922, 31947.68052319447, 32218.83890580532, 41755.7912210437, 42757.1448571033, 40947.7952610235, 41813.58186418097, 41982.950426239586, 42387.788061059495, 42532.1493570133, 34544.96365109051, 34618.0, 34818.0, 35492.82253588819, 35725.28549428945, 30214.69785302119, 34562.135946601535, 34672.653273466945, 34856.47715284323, 35334.46998294976, 33953.15117121993, 34805.0, 35929.64070359263, 36545.0, 36803.0, 30297.848510757307, 31975.840120799247, 32387.0, 32498.675013249565, 33223.0, 19215.90392048031, 19545.0, 23479.882600586887, 24166.75833241645, 24685.753142468344], "unit": "score", "name": "ext.html", "value": 19377.109710789522}, {"lowerIsBetter": false, "replicates": [351.10818520956786, 359.04494045838067, 359.9748017638765, 360.6267513123917, 361.16570721633025, 18930.24279028839, 18968.336108236213, 19762.90118549405, 19779.406617801455, 19995.60008799823, 18763.718544221847, 18809.905950470227, 19639.901800491014, 19647.705284420746, 19657.41027769169, 5507.669539827603, 5743.253377060976, 5753.424657534255, 5765.106408506688, 5778.8266352009505, 4142.917141657165, 5605.355384130837, 6055.182550355712, 6293.276273228592, 6331.303556608769, 6256.718447669843, 6258.749650013994, 6259.624422534663, 6267.185265915425, 6276.121343011982, 5354.785808567653, 6043.7280322385595, 6285.622862628257, 6289.559730818844, 6324.114623952651, 5394.838154855361, 5419.512243898029, 5448.482394172547, 5449.346078470569, 5468.535174510172, 10527.789304230035, 12752.936235318764, 13161.341932903317, 13240.0, 13276.336183190802, 1736.2967997960845, 2044.8568600197991, 2068.1830676882696, 2118.0, 2147.7744836792067, 8985.0, 9038.231750301233, 9980.700578982642, 10873.156429985222, 14199.006069575134, 1641.7537369394568, 1666.6583350413136, 1725.956851078733, 1729.0231019473956, 1751.1594434671301, 102159.48920255351, 111259.44370278259, 111378.88621113767, 111717.0, 113527.0, 11151.888481115247, 11166.106711463064, 11171.44142792857, 11188.272762270426, 11292.153088518395, 13135.146215495963, 13430.865691343157, 13439.664008399868, 13474.797878031837, 13476.191428514321, 6977.7208911642965, 8104.270615644502, 8214.83570328602, 8409.990801103906, 8481.872771908425, 8501.0, 8501.532415717194, 8536.74389768308, 8630.266427353745, 8646.2218400343, 4306.956930430718, 4404.559544045634, 4406.0, 4408.933865992013, 4494.213512635276, 1775.4496106207116, 1833.6882729935942, 1877.7183422486462, 1887.2168050259263, 1903.5812121333286, 385.6394271356291, 704.5490885833071, 711.8327193109615, 785.6582386661706, 930.0, 9841.852372214422, 11339.829902551468, 11951.282923024646, 12027.398630068461, 12247.142700011093, 427.8032105231566, 436.9388285640013, 442.05400443051894, 444.5465625062418, 452.31474316410663, 6031.668258245839, 6113.20528331323, 6168.228971378578, 6239.313675495692, 6241.968790156111, 583564.0, 619663.0, 621624.0, 625209.0, 638779.0, 102471.0, 125885.0, 126696.36651816682, 129727.0, 129868.0, 456.0855484753115, 460.9815607375667, 461.04563553444046, 464.13670572734685, 464.8256903661127, 10877.891221087688, 10926.56293748273, 10949.452527373758, 11079.5568177272, 11147.108231341635, 50235.24647130369, 50238.0, 50930.745346273034, 50988.49011509837, 53169.13908013201, 65212.36969075811, 75008.24991750013, 76561.0, 78965.60517197607, 79795.60102199452, 7785.805354865947, 7788.88316675239, 8106.39202059836, 8198.959005204935, 8364.581770911309, 11266.774664506827, 11455.427228638368, 12913.806292905427, 13453.529126480526, 13496.32518374097, 10106.595736170471, 11490.77018459643, 11549.711257218636, 11610.722820489907, 11823.231489953125, 11158.27471214401, 11480.024197943269, 11607.941960290145, 11609.709757256136, 11662.76674466489, 11727.237729547553, 11740.236884602473, 11769.117316201491, 12108.636740897788, 12122.878771212176, 8101.351891848756, 8106.79733006656, 8226.807112968705, 8231.917680823355, 8465.95767021161, 11086.556537738401, 11659.358735269641, 11749.76500470003, 11860.05119590448, 11992.340421276913], "unit": "score", "name": "jquery.html", "value": 8401.26574053372}, {"lowerIsBetter": false, "replicates": [1545.3509525999082, 1548.473519003539, 1785.401890366727, 1903.2672421117866, 1919.4241727481751, 7771.650275737591, 8314.41799074065, 8527.701530446435, 8716.259117974972, 8736.781580460492, 8428.873566896502, 8492.19324164205, 8540.74377768668, 8585.270252028586, 8593.95703021484, 2441.4994926040163, 2452.9509409811794, 2462.322861213163, 2466.8766561671932, 2468.395243165427, 2376.738558758535, 2380.4048987753063, 2385.105585405473, 2393.3179043972473, 2394.2705315939843, 2374.2667852467707, 2381.476075263448, 2400.303911865557, 2442.511497700458, 2454.0797201049604, 2425.599776036952, 2432.2338463384067, 2444.0346063304896, 2450.963235551468, 2465.9136930207537, 2417.818663600219, 2441.4506735984437, 2454.1901172612993, 2457.7665121813397, 2458.6926634170727, 8550.957245213796, 8569.957150214272, 8590.1839325264, 8601.182887625666, 8641.092685268082, 5218.034663587248, 5326.0, 5347.385050719178, 5352.304200453955, 5375.838724838261, 3564.9643503564894, 3617.7286703497343, 3670.4861319415304, 3671.6695497405094, 3697.907552311187, 840.64272684109, 1042.4006196437078, 1062.5474351533533, 1079.865016872891, 1082.658962426833, 11506.252093613888, 11682.182247242696, 11684.357360345177, 11689.415529223505, 11701.53193872244, 4781.995780886053, 4795.808167673324, 4804.42346918372, 4857.077155340474, 4867.148249056472, 9867.0, 9955.601775929026, 9970.45162516054, 10009.299349045497, 10027.849582256273, 5353.384360798558, 5362.570994320445, 5391.32608423947, 5409.7295135243085, 5421.512063914267, 4332.588404101605, 4694.953050469451, 4807.591354734886, 4862.027594481118, 4940.0, 3738.2336620992633, 3816.9427458588143, 3830.540335159799, 3832.7125465589634, 3854.3640299350295, 1288.0983311681673, 1290.1356091418772, 1295.6307452376216, 1300.6163181861373, 1316.0261406559077, 1314.1589382795019, 1324.1922427319328, 1328.1566205459603, 1329.7872340425486, 1338.9799153012711, 7936.007999000125, 8007.479513831582, 8108.918910810934, 8129.187081291823, 8131.837363252702, 422.566868959313, 494.3721473728345, 500.96743711658627, 507.36072548589044, 507.41393690287777, 6170.352113028157, 6179.721912513947, 6191.690415479208, 6192.969035154795, 6199.876002479925, 10173.338732982333, 10287.845682314772, 10302.175825933908, 10329.896701032894, 10364.896351036545, 9906.752331191778, 10047.799044019079, 10253.692389228336, 10314.226433017404, 10320.43237621923, 8108.5945702714625, 8175.550344731097, 8269.21442462965, 8304.460210086447, 8327.0, 7747.72882949094, 7916.564588947663, 7962.7213047543055, 7981.760547183594, 8196.713115040944, 8843.0, 9396.577154028222, 9407.294452915921, 9458.0, 9703.126718595078, 9500.762480937756, 9835.065668761743, 9868.802623947624, 9870.654527091518, 9987.25095617817, 6733.61960798045, 7145.1068616422945, 7382.114146302478, 7433.2195119513835, 7555.320021198118, 8007.919920800718, 8121.066077400938, 8152.225538573826, 8162.428629995843, 8230.135835737401, 7156.570605763671, 7221.0, 7243.818904527218, 7318.414526837947, 7382.446316526175, 7099.751508697171, 7260.4554658401885, 7268.164161121327, 7269.877870443899, 7282.927170728225, 7418.591977441292, 7667.194944530744, 7678.769636910902, 7686.192949740197, 7690.154083050972, 5890.646561206341, 6937.895931561132, 7013.859722805618, 7027.543209691558, 7034.613096279753, 6829.556078854858, 6911.861762764817, 7009.824754381181, 7038.894416583653, 7044.189918159273], "unit": "score", "name": "mootools.html", "value": 4780.395613210447}, {"lowerIsBetter": false, "replicates": [269.2863910636813, 318.82623969936384, 322.91119942015945, 328.26141182339734, 329.1212462724525, 5540.612157149001, 5632.493075623193, 6938.306169383065, 7045.823854403642, 7048.577085374868, 6888.690008949597, 6906.136732908387, 6926.134233220848, 6933.168019837614, 6938.548994315379, 4833.854984350475, 4945.208766597345, 5038.899222015558, 5045.268436076767, 5123.514180887548, 5013.924791128136, 5019.799208031674, 5041.420236672793, 5050.191969284915, 5066.670666406671, 4076.7961601919933, 4922.21244600864, 5002.674826136307, 5011.32347133136, 5026.52248036436, 4398.7243699327155, 4615.65382596305, 5008.12357837377, 5010.3737032870895, 5027.2207807789855, 4313.180495705806, 4316.546762589915, 4321.913561728779, 4323.005708686988, 4323.351497275403, 6377.489800815923, 6684.0, 6698.296678848699, 6704.631245281507, 6731.899021514681, 4797.880052998703, 5789.65262084272, 5840.912386314166, 5856.092305692625, 5856.736446859902, 7386.926130738678, 7391.852162956765, 7398.852022959511, 7424.55452672836, 7446.925530744732, 4076.9184616307803, 4492.0791237796175, 4692.131955588193, 4698.248280275174, 4702.1771190041945, 7774.766756997299, 7842.29419352261, 7862.68549258029, 7868.0951690555175, 7894.64474098667, 4551.95448045522, 4727.669063165614, 4733.455652599995, 4742.407199100113, 4755.144074066701, 4772.403449568804, 4829.396325459317, 4833.589144922651, 4837.4920633333695, 4844.4186697596515, 4888.364512613409, 5802.883942321215, 5861.531077513789, 5888.3228428731245, 5893.823185304362, 7369.115706115301, 7464.290892365217, 7473.51422157558, 7479.289467500579, 7486.737964171228, 1659.31138577489, 1676.9077700726334, 1678.8740844436472, 1679.2023788700515, 1680.0675625027982, 1023.4166525080782, 1065.8880817514205, 1067.3915867955345, 1075.4031512510633, 1075.7310672331917, 6687.398134167948, 6785.796426107225, 6790.0, 6795.932040679629, 6810.659467026728, 7446.515976461513, 7627.389808815282, 7647.847043059219, 7655.0, 7656.157822639505, 6014.8195554133445, 6613.702383392759, 6666.400023997863, 6873.793786186422, 6954.09596752429, 3854.9784307158625, 4049.5747946465785, 4104.8152833122585, 4105.261053010427, 4116.6912481564, 7032.824179395556, 8104.756857294291, 8106.270435660819, 8122.553259570662, 8125.95937020323, 7704.499207551491, 7976.122626511079, 8044.597770111588, 8073.515589064557, 8121.472104313319, 6471.741130354733, 7997.480163789452, 8016.919830801734, 8091.433599647969, 8135.616945119225, 6924.6537673117155, 7117.252688467636, 7747.18654541265, 7762.262585054411, 7765.301122898966, 7650.273224043707, 7651.426143039405, 7661.770146895602, 7678.846423071395, 7688.192739762245, 7859.921400785919, 8129.065157506962, 8131.349492040505, 8138.87791683137, 8148.388870834592, 4773.594244489257, 4790.233562629963, 4826.493218212037, 4834.758262086952, 4840.031993601364, 6203.286622038523, 7587.317141457074, 7750.302472777477, 7762.534247945141, 7816.7264145754625, 7436.479446438698, 7458.627068646438, 7473.252674732484, 7486.438517111347, 7489.325960663567, 7176.461765367514, 7235.131784185932, 7390.445716571171, 7396.186419493743, 7415.258474152542, 6686.0, 7227.313405226495, 7295.124585049828, 7296.671649775879, 7319.268073192851, 6733.831654208684, 7467.402607791472, 7475.738349157753, 7505.549667019996, 7518.849623007619, 7105.928940710527, 7219.350258476762, 7318.63406829667, 7328.706851725871, 7332.376747976482], "unit": "score", "name": "prototype.html", "value": 5322.181861114542}, {"lowerIsBetter": false, "replicates": [663.1975309875052, 680.4114441008526, 712.6543626341223, 722.9240929702385, 723.1683563901514, 14655.0, 14696.559103226893, 14822.851771482281, 14865.851341486581, 14884.181370024644, 13320.267385293804, 14014.78977815331, 14025.78961315581, 14040.508582199625, 14050.08674436161, 724.2467833453202, 859.3168431097262, 859.7549698335991, 864.5763575847852, 895.9686410975618, 871.1201686296822, 884.6196135661663, 886.9689560865371, 887.7603047177258, 889.7019498468021, 924.4915296586884, 927.8932922713873, 931.9394239374419, 934.9672761453351, 936.3071327217843, 884.385352180235, 889.6530353162271, 912.1380295620642, 926.0646746785727, 926.3237836379448, 657.2474516678424, 660.8480049588574, 674.7773234832493, 686.498855835243, 694.9861002779916, 14444.277786110653, 14543.400225975134, 14714.33785479656, 14748.778768318483, 14761.040532365361, 10118.747031324203, 12501.749965000648, 12637.74724505514, 12811.231326120462, 12820.230786152768, 8530.402871798977, 9830.311878168532, 9871.568622549761, 9934.801303973953, 9964.850527242097, 3288.293017001356, 3435.4159792835276, 3472.670096340869, 3485.8954231372845, 3488.1105318143964, 82078.0, 82135.0, 82776.0, 82977.75533367065, 83021.0, 9307.348485606079, 9520.190783783455, 9588.280878933969, 9700.0, 9793.314467987315, 20918.58162836765, 21322.0, 21355.572888542454, 21434.78565214328, 21453.356399308046, 7312.726785368564, 7348.52234604749, 7407.444441666897, 7472.17806041335, 7536.698532058656, 4025.677945764332, 4036.2734707752297, 4067.247559201557, 4076.103257283393, 4090.284200264942, 3445.3970555152746, 3484.9651503484642, 3485.302939412077, 3490.0402389343135, 3494.580650321978, 564.2467306146259, 656.3731636287334, 659.4164164714167, 659.4262991197593, 661.4014317043084, 545.4055079962859, 573.7590212110923, 581.0934941491287, 586.1647152807233, 603.3966033966034, 6315.905261421082, 7874.803129921684, 7948.761537153895, 7971.561564113914, 8162.632681529345, 483.3619622098866, 506.9366329208849, 518.5203686589889, 524.3079135541126, 550.620072150215, 3358.261182539837, 3725.9068523287133, 3844.500214972036, 3867.6398832936275, 3921.3529767588598, 84726.576367119, 86323.0, 86803.0, 86946.0, 87357.25285494255, 76171.61914190394, 76302.0, 77241.0, 77773.61113194398, 78122.60938695385, 65464.69070618561, 66001.0, 66239.0, 66800.6659966697, 67110.66444667746, 7711.961440192763, 7770.689172433039, 7792.2986931176465, 7854.136045035156, 7994.2805147537, 48071.03857922752, 48559.5144048555, 49124.0, 49376.75311623419, 50242.49757502378, 58634.0, 61797.691011546456, 70367.64816175886, 70909.6454517724, 71174.28825711677, 10632.41521716313, 10638.680839574825, 10733.195010374096, 10830.945845270724, 11090.778184436105, 11795.528178873092, 11869.5845645402, 12247.448864800926, 12329.815052774395, 12344.0, 10990.835137473105, 11239.325640461599, 11812.468438920441, 11869.347185904859, 12324.938375308066, 10893.128549715846, 11199.66401007971, 11301.660950171508, 11526.538938442369, 11613.825792612948, 10936.617218397318, 10992.945035274772, 11041.613543525938, 11414.429278535874, 11520.251183673034, 9261.351705380559, 9272.72181834546, 9315.72052838416, 9424.811503770023, 9743.805123897624, 9288.210502107397, 9343.205827504738, 9367.85948210791, 9400.95299523498, 9542.570584323583], "unit": "score", "name": "yui.html", "value": 6738.8115993876745}], "name": "dromaeo_css", "value": 7361.210063316356}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 115.0, 114.0, 114.0, 127.0, 124.0, 165.0, 166.0, 107.0], "unit": "score", "name": "ai-astar", "value": 125.7}, {"lowerIsBetter": true, "replicates": [154.0, 123.0, 143.0, 154.0, 160.0, 172.0, 172.0, 110.0, 194.0, 155.0], "unit": "score", "name": "audio-beat-detection", "value": 153.7}, {"lowerIsBetter": true, "replicates": [209.0, 281.0, 217.0, 210.0, 213.0, 217.0, 186.0, 166.0, 258.0, 279.0], "unit": "score", "name": "audio-dft", "value": 223.6}, {"lowerIsBetter": true, "replicates": [76.0, 67.0, 71.0, 126.0, 55.0, 78.0, 80.0, 48.0, 71.0, 77.0], "unit": "score", "name": "audio-fft", "value": 74.9}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 119.0, 81.0, 81.0, 88.0, 122.0, 81.0, 108.0, 163.0], "unit": "score", "name": "audio-oscillator", "value": 101.6}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 88.0, 86.0, 108.0, 86.0, 88.0, 86.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.0}, {"lowerIsBetter": true, "replicates": [153.0, 94.0, 94.0, 95.0, 94.0, 105.0, 94.0, 95.0, 92.0, 135.0], "unit": "score", "name": "imaging-darkroom", "value": 105.1}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 95.0, 97.0, 108.0, 142.0, 100.0, 96.0, 158.0, 147.0], "unit": "score", "name": "imaging-desaturate", "value": 113.9}, {"lowerIsBetter": true, "replicates": [56.0, 52.0, 50.0, 52.0, 52.0, 52.0, 50.0, 61.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 71.0, 68.0, 113.0, 108.0, 103.0, 104.0, 74.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 84.3}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 78.0, 85.0, 86.0, 75.0, 103.0, 111.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.7}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 137.0, 141.0, 131.0, 139.0, 134.0, 133.0, 126.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.8}, {"lowerIsBetter": true, "replicates": [142.0, 142.0, 143.0, 141.0, 143.0, 129.0, 139.0, 144.0, 145.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 66.0, 68.0, 67.0, 68.0, 69.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1560.6}]} 07:11:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1560.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7361.21"}}} 07:11:10 INFO - Return code: 0 07:11:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:11:10 ERROR - # TBPL SUCCESS # 07:11:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:11:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:11:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:11:10 INFO - 2016-03-03 07:11:10.817 screenresolution[1996:22354] starting screenresolution argv=screenresolution get 07:11:10 INFO - 2016-03-03 07:11:10.820 screenresolution[1996:22354] Display 0: 1600x1200x32@60 07:11:10 INFO - 2016-03-03 07:11:10.826 screenresolution[1997:22357] starting screenresolution argv=screenresolution list 07:11:10 INFO - Available Modes on Display 0 07:11:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:11:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:11:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:11:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:11:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:11:11 INFO - Intel Iris: 07:11:11 INFO - Chipset Model: Intel Iris 07:11:11 INFO - Type: GPU 07:11:11 INFO - Bus: Built-In 07:11:11 INFO - VRAM (Dynamic, Max): 1536 MB 07:11:11 INFO - Vendor: Intel (0x8086) 07:11:11 INFO - Device ID: 0x0a2e 07:11:11 INFO - Revision ID: 0x0009 07:11:11 INFO - Displays: 07:11:11 INFO - Display: 07:11:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:11:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:11:11 INFO - Display Serial Number: 1600x1200 60 07:11:11 INFO - Main Display: Yes 07:11:11 INFO - Mirror: Off 07:11:11 INFO - Online: Yes 07:11:11 INFO - Rotation: Supported 07:11:11 INFO - Return code: 0 07:11:11 INFO - Running post-action listener: _resource_record_post_action 07:11:11 INFO - Running post-run listener: _resource_record_post_run 07:11:12 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 12288; Write bytes: 707080192; Read time: 1; Write time: 1891 07:11:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401199616; Write bytes: 403052544; Read time: 30346; Write time: 727 07:11:12 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 12288; Write bytes: 302422016; Read time: 1; Write time: 1158 07:11:12 INFO - Running post-run listener: _upload_blobber_files 07:11:12 INFO - Blob upload gear active. 07:11:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:11:12 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 07:11:12 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'] 07:11:12 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 07:11:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:13 INFO - (blobuploader) - INFO - Done attempting. 07:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:11:14 INFO - (blobuploader) - INFO - Done attempting. 07:11:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:11:14 INFO - Return code: 0 07:11:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:11:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:11:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7beef6f6f95e57bb5f4675faee76042eb305a10ca64bad1d01d1c764400aa3d8065ea9df52991c76bc653dced68e2bcaa08ffbd0f66736a25f60d36754be6e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1b391beda12471d80625444c595d56ddfb86a0e78ff7756ca5c24ebaedc8a33a17e5d772a45323b0a448b7072fe0a82020294c5848c5f855dd636a7c1ca2d6"} 07:11:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:11:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:11:14 INFO - Contents: 07:11:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7beef6f6f95e57bb5f4675faee76042eb305a10ca64bad1d01d1c764400aa3d8065ea9df52991c76bc653dced68e2bcaa08ffbd0f66736a25f60d36754be6e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1b391beda12471d80625444c595d56ddfb86a0e78ff7756ca5c24ebaedc8a33a17e5d772a45323b0a448b7072fe0a82020294c5848c5f855dd636a7c1ca2d6"} 07:11:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:11:14 INFO - Copying logs to upload dir... 07:11:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:11:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.813330 ========= master_lag: 12.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-03-03 07:11:27.309627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-03 07:11:27.313467) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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/a7beef6f6f95e57bb5f4675faee76042eb305a10ca64bad1d01d1c764400aa3d8065ea9df52991c76bc653dced68e2bcaa08ffbd0f66736a25f60d36754be6e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1b391beda12471d80625444c595d56ddfb86a0e78ff7756ca5c24ebaedc8a33a17e5d772a45323b0a448b7072fe0a82020294c5848c5f855dd636a7c1ca2d6"} build_url:https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/TKFBNQyOQmeFyfc_W8BjlA/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/a7beef6f6f95e57bb5f4675faee76042eb305a10ca64bad1d01d1c764400aa3d8065ea9df52991c76bc653dced68e2bcaa08ffbd0f66736a25f60d36754be6e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f1b391beda12471d80625444c595d56ddfb86a0e78ff7756ca5c24ebaedc8a33a17e5d772a45323b0a448b7072fe0a82020294c5848c5f855dd636a7c1ca2d6"}' ========= master_lag: 4.95 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-03-03 07:11:32.271155) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:11:32.271435) ========= 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.0SloosmNjx/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.pmJa4Glx9c/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005246 ========= master_lag: 0.92 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 07:11:33.195491) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-03 07:11:33.195769) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-03 07:11:36.950669) ========= ========= Total master_lag: 18.92 =========