builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0147 starttime: 1460368109.76 results: success (0) buildid: 20160411004020 builduid: acce1ef911b64463972f6e8afefdcb0f revision: 29f1480e9931de5ef94055e97f74411aeddb16ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.762788) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.763239) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.763528) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005645 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.787592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.787938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.804296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.804615) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005663 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.852503) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.852810) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.855249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:29.855535) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-11 02:48:29-- 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% 50.8M=0s 2016-04-11 02:48:30 (50.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:30.069198) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:30.069520) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025160 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:30.117498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-11 02:48:30.119858) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29f1480e9931de5ef94055e97f74411aeddb16ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 29f1480e9931de5ef94055e97f74411aeddb16ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-11 02:48:30,195 truncating revision to first 12 chars 2016-04-11 02:48:30,196 Setting DEBUG logging. 2016-04-11 02:48:30,196 attempt 1/10 2016-04-11 02:48:30,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/29f1480e9931?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 02:48:30,805 unpacking tar archive at: mozilla-aurora-29f1480e9931/testing/mozharness/ program finished with exit code 0 elapsedTime=0.861473 ========= master_lag: 1.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-11 02:48:32.920747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:32.921130) ========= echo 29f1480e9931de5ef94055e97f74411aeddb16ad in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'29f1480e9931de5ef94055e97f74411aeddb16ad'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 29f1480e9931de5ef94055e97f74411aeddb16ad program finished with exit code 0 elapsedTime=0.005891 script_repo_revision: '29f1480e9931de5ef94055e97f74411aeddb16ad' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:32.965018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:32.965333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 02:48:32.990237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-11 02:48:32.990605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:48:33 INFO - MultiFileLogger online at 20160411 02:48:33 in /builds/slave/test 02:48:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:48:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:33 INFO - {'append_to_log': False, 02:48:33 INFO - 'base_work_dir': '/builds/slave/test', 02:48:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:33 INFO - 'branch': 'Mozilla-Aurora', 02:48:33 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:33 INFO - 'config_files': ('talos/mac_config.py',), 02:48:33 INFO - 'default_actions': ('clobber', 02:48:33 INFO - 'read-buildbot-config', 02:48:33 INFO - 'download-and-extract', 02:48:33 INFO - 'populate-webroot', 02:48:33 INFO - 'create-virtualenv', 02:48:33 INFO - 'install', 02:48:33 INFO - 'run-tests'), 02:48:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:33 INFO - 'download_minidump_stackwalk': True, 02:48:33 INFO - 'download_symbols': 'ondemand', 02:48:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:33 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:33 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:33 INFO - 'installer_path': 'installer.exe', 02:48:33 INFO - 'log_level': 'info', 02:48:33 INFO - 'log_name': 'talos', 02:48:33 INFO - 'log_to_console': True, 02:48:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:33 INFO - 'opt_config_files': (), 02:48:33 INFO - 'pip_index': False, 02:48:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:33 INFO - 'cmd': ('bash', 02:48:33 INFO - '-c', 02:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:33 INFO - 'enabled': True, 02:48:33 INFO - 'halt_on_failure': False, 02:48:33 INFO - 'name': 'check_screen_resolution'},), 02:48:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:33 INFO - 'cmd': ('bash', 02:48:33 INFO - '-c', 02:48:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:33 INFO - 'enabled': True, 02:48:33 INFO - 'halt_on_failure': False, 02:48:33 INFO - 'name': 'check_screen_resolution'},), 02:48:33 INFO - 'run_cmd_checks_enabled': True, 02:48:33 INFO - 'sps_profile': False, 02:48:33 INFO - 'sps_profile_interval': 0, 02:48:33 INFO - 'suite': 'dromaeojs', 02:48:33 INFO - 'system_bits': '32', 02:48:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:33 INFO - 'title': 't-yosemite-r7-0147', 02:48:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:33 INFO - 'use_talos_json': True, 02:48:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:33 INFO - 'work_dir': 'build'} 02:48:33 INFO - ##### 02:48:33 INFO - ##### Running clobber step. 02:48:33 INFO - ##### 02:48:33 INFO - Running pre-action listener: _resource_record_pre_action 02:48:33 INFO - Running main action method: clobber 02:48:33 INFO - rmtree: /builds/slave/test/build 02:48:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:34 INFO - Running post-action listener: _resource_record_post_action 02:48:34 INFO - ##### 02:48:34 INFO - ##### Running read-buildbot-config step. 02:48:34 INFO - ##### 02:48:34 INFO - Running pre-action listener: _resource_record_pre_action 02:48:34 INFO - Running main action method: read_buildbot_config 02:48:34 INFO - Using buildbot properties: 02:48:34 INFO - { 02:48:34 INFO - "project": "", 02:48:34 INFO - "product": "firefox", 02:48:34 INFO - "script_repo_revision": "production", 02:48:34 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:48:34 INFO - "repository": "", 02:48:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:48:34 INFO - "buildid": "20160411004020", 02:48:34 INFO - "stage_platform": "macosx64", 02:48:34 INFO - "basedir": "/builds/slave/test", 02:48:34 INFO - "nightly_build": "True", 02:48:34 INFO - "buildnumber": 269, 02:48:34 INFO - "slavename": "t-yosemite-r7-0147", 02:48:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:48:34 INFO - "platform": "yosemite_r7", 02:48:34 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:48:34 INFO - "branch": "mozilla-aurora", 02:48:34 INFO - "repo_path": "releases/mozilla-aurora", 02:48:34 INFO - "revision": "29f1480e9931de5ef94055e97f74411aeddb16ad", 02:48:34 INFO - "pgo_build": "False", 02:48:34 INFO - "builduid": "acce1ef911b64463972f6e8afefdcb0f", 02:48:34 INFO - "slavebuilddir": "test" 02:48:34 INFO - } 02:48:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:48:34 INFO - Running post-action listener: _resource_record_post_action 02:48:34 INFO - ##### 02:48:34 INFO - ##### Running download-and-extract step. 02:48:34 INFO - ##### 02:48:34 INFO - Running pre-action listener: _resource_record_pre_action 02:48:34 INFO - Running main action method: download_and_extract 02:48:34 INFO - mkdir: /builds/slave/test/build/tests 02:48: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')]} 02:48:34 INFO - https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:48:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:48:35 INFO - Downloaded 1277 bytes. 02:48:35 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:48:35 INFO - Using the following test package requirements: 02:48:35 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:35 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:48:35 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:48:35 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'jsshell-mac.zip'], 02:48:35 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:48:35 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:35 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:48:35 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:48:35 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:48:35 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:48:35 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:48:35 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:48:35 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:35 INFO - https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:36 INFO - Downloaded 17908756 bytes. 02:48:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:40 INFO - Return code: 0 02:48:40 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:40 INFO - https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:43 INFO - Downloaded 17908756 bytes. 02:48:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:48:46 INFO - Return code: 0 02:48: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')]} 02:48:46 INFO - https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:48:47 INFO - Downloaded 10845168 bytes. 02:48:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:48:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:48:48 INFO - Return code: 0 02:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:48 INFO - https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:48:51 INFO - Downloaded 115311943 bytes. 02:48:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:51 INFO - mkdir: /builds/slave/test/properties 02:48:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:51 INFO - Contents: 02:48:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:48:53 INFO - Running post-action listener: _resource_record_post_action 02:48:53 INFO - Running post-action listener: set_extra_try_arguments 02:48:53 INFO - ##### 02:48:53 INFO - ##### Running populate-webroot step. 02:48:53 INFO - ##### 02:48:53 INFO - Running pre-action listener: _resource_record_pre_action 02:48:53 INFO - Running main action method: populate_webroot 02:48:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:53 INFO - '--tppagecycles', 02:48:53 INFO - '7'], 02:48:53 INFO - 'tests': ['tsvgm']}}, 02:48:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:48:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:48:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'tests': ['damp', 'tps']}, 02:48:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['damp', 'tps']}, 02:48:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:48:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:53 INFO - 'other': {'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'other_l64': {'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'other_nol64': {'tests': ['a11yr', 02:48:53 INFO - 'ts_paint', 02:48:53 INFO - 'tpaint', 02:48:53 INFO - 'sessionrestore', 02:48:53 INFO - 'sessionrestore_no_auto_restore', 02:48:53 INFO - 'tabpaint']}, 02:48:53 INFO - 'svgr': {'tests': ['tsvgx', 02:48:53 INFO - 'tsvgr_opacity', 02:48:53 INFO - 'tart', 02:48:53 INFO - 'tscrollx', 02:48:53 INFO - 'cart']}, 02:48:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['tsvgx', 02:48:53 INFO - 'tsvgr_opacity', 02:48:53 INFO - 'tart', 02:48:53 INFO - 'tscrollx', 02:48:53 INFO - 'cart']}, 02:48:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'tests': ['tp5o']}, 02:48:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'talos_options': ['--e10s'], 02:48:53 INFO - 'tests': ['tp5o']}, 02:48:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'talos_options': ['--xperf_path', 02:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:53 INFO - 'tests': ['tp5n']}, 02:48:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:53 INFO - 'talos_options': ['--e10s', 02:48:53 INFO - '--xperf_path', 02:48:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:53 INFO - 'tests': ['tp5n']}}, 02:48:53 INFO - 'talos.zip': {'path': '', 02:48:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:53 INFO - Running post-action listener: _resource_record_post_action 02:48:53 INFO - ##### 02:48:53 INFO - ##### Running create-virtualenv step. 02:48:53 INFO - ##### 02:48:53 INFO - Running pre-action listener: _resource_record_pre_action 02:48:53 INFO - Running main action method: create_virtualenv 02:48:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:53 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 02:48:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:53 INFO - Using real prefix '/tools/python27' 02:48:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:56 INFO - Installing pip.................done. 02:48:56 INFO - Return code: 0 02:48:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48: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', 'pip>=1.5'] in /builds/slave/test/build 02:48: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 pip>=1.5 02:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:56 INFO - 'HOME': '/Users/cltbld', 02:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:56 INFO - 'LOGNAME': 'cltbld', 02:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:56 INFO - 'MOZ_NO_REMOTE': '1', 02:48:56 INFO - 'NO_EM_RESTART': '1', 02:48:56 INFO - 'PAGER': '/bin/cat', 02:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:56 INFO - 'PWD': '/builds/slave/test', 02:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:56 INFO - 'SHELL': '/bin/bash', 02:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:48:56 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:56 INFO - 'USER': 'cltbld', 02:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:56 INFO - 'XPC_FLAGS': '0x0', 02:48:56 INFO - 'XPC_SERVICE_NAME': '0', 02:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:57 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 02:48:57 INFO - Cleaning up... 02:48:57 INFO - Return code: 0 02:48:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:57 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:48:57 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 02:48:57 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 02:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:57 INFO - 'HOME': '/Users/cltbld', 02:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:57 INFO - 'LOGNAME': 'cltbld', 02:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:57 INFO - 'MOZ_NO_REMOTE': '1', 02:48:57 INFO - 'NO_EM_RESTART': '1', 02:48:57 INFO - 'PAGER': '/bin/cat', 02:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:57 INFO - 'PWD': '/builds/slave/test', 02:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:57 INFO - 'SHELL': '/bin/bash', 02:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:48:57 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:57 INFO - 'USER': 'cltbld', 02:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:57 INFO - 'XPC_FLAGS': '0x0', 02:48:57 INFO - 'XPC_SERVICE_NAME': '0', 02:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:57 INFO - Downloading/unpacking psutil>=0.7.1 02:48:57 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 02:48:57 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 02:48:57 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 02:48:57 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 02:48:57 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 02:48:57 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 02:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:49:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:00 INFO - Installing collected packages: psutil 02:49:00 INFO - Running setup.py install for psutil 02:49:00 INFO - building 'psutil._psutil_osx' extension 02:49:00 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 02:49:01 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 02:49:01 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 02:49:01 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 02:49:01 INFO - building 'psutil._psutil_posix' extension 02:49:01 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 02:49:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:49:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:49:01 INFO - ^ 02:49:01 INFO - 1 warning generated. 02:49:01 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 02:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:01 INFO - Successfully installed psutil 02:49:01 INFO - Cleaning up... 02:49:01 INFO - Return code: 0 02:49:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:01 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:01 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 02:49:01 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 02:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:01 INFO - 'HOME': '/Users/cltbld', 02:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:01 INFO - 'LOGNAME': 'cltbld', 02:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:01 INFO - 'MOZ_NO_REMOTE': '1', 02:49:01 INFO - 'NO_EM_RESTART': '1', 02:49:01 INFO - 'PAGER': '/bin/cat', 02:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:01 INFO - 'PWD': '/builds/slave/test', 02:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:01 INFO - 'SHELL': '/bin/bash', 02:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:01 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:01 INFO - 'USER': 'cltbld', 02:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:01 INFO - 'XPC_FLAGS': '0x0', 02:49:01 INFO - 'XPC_SERVICE_NAME': '0', 02:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:49:01 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 02:49:01 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 02:49:01 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 02:49:01 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 02:49:01 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 02:49:01 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 02:49:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:49:04 INFO - Installing collected packages: mozsystemmonitor 02:49:04 INFO - Running setup.py install for mozsystemmonitor 02:49:04 INFO - Successfully installed mozsystemmonitor 02:49:04 INFO - Cleaning up... 02:49:04 INFO - Return code: 0 02:49:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:49:04 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')]} 02:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 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')]} 02:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:04 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:04 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 02:49:04 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 02:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:04 INFO - 'HOME': '/Users/cltbld', 02:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:04 INFO - 'LOGNAME': 'cltbld', 02:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:04 INFO - 'MOZ_NO_REMOTE': '1', 02:49:04 INFO - 'NO_EM_RESTART': '1', 02:49:04 INFO - 'PAGER': '/bin/cat', 02:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:04 INFO - 'PWD': '/builds/slave/test', 02:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:04 INFO - 'SHELL': '/bin/bash', 02:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:04 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:04 INFO - 'USER': 'cltbld', 02:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:04 INFO - 'XPC_FLAGS': '0x0', 02:49:04 INFO - 'XPC_SERVICE_NAME': '0', 02:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:49:04 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 02:49:04 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 02:49:04 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 02:49:04 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 02:49:04 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 02:49:04 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 02:49:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:49:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:49:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 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 02:49:08 INFO - Downloading docopt-0.6.1.tar.gz 02:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:49:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:49:08 INFO - Running setup.py install for blobuploader 02:49:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:49:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:49:08 INFO - Running setup.py install for requests 02:49:09 INFO - Running setup.py install for docopt 02:49:09 INFO - Successfully installed blobuploader requests docopt 02:49:09 INFO - Cleaning up... 02:49:09 INFO - Return code: 0 02:49:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:09 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')]} 02:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:09 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')]} 02:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:09 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:09 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 02:49:09 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 02:49:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:09 INFO - 'HOME': '/Users/cltbld', 02:49:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:09 INFO - 'LOGNAME': 'cltbld', 02:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:09 INFO - 'MOZ_NO_REMOTE': '1', 02:49:09 INFO - 'NO_EM_RESTART': '1', 02:49:09 INFO - 'PAGER': '/bin/cat', 02:49:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:09 INFO - 'PWD': '/builds/slave/test', 02:49:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:09 INFO - 'SHELL': '/bin/bash', 02:49:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:09 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:09 INFO - 'USER': 'cltbld', 02:49:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:09 INFO - 'XPC_FLAGS': '0x0', 02:49:09 INFO - 'XPC_SERVICE_NAME': '0', 02:49:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:49:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-qmurou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:49:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-nbcz71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-TnuIA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Nq3Lwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-gqKwH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-T5MIRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-h5S90K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-aeVNcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-SYZLy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-6dlsFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-avrYuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:49:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-O1p6Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:49:11 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-FTcy1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:49:11 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-haAzk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:11 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-GmfQpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:49:11 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-bBr6s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:49:11 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MN3HpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:49:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:49:11 INFO - Running setup.py install for manifestparser 02:49:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:49:11 INFO - Running setup.py install for mozcrash 02:49:11 INFO - Running setup.py install for mozdebug 02:49:12 INFO - Running setup.py install for mozdevice 02:49:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Running setup.py install for mozfile 02:49:12 INFO - Running setup.py install for mozhttpd 02:49:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Running setup.py install for mozinfo 02:49:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Running setup.py install for mozInstall 02:49:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:49:12 INFO - Running setup.py install for mozleak 02:49:12 INFO - Running setup.py install for mozlog 02:49:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Running setup.py install for moznetwork 02:49:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Running setup.py install for mozprocess 02:49:13 INFO - Running setup.py install for mozprofile 02:49:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Running setup.py install for mozrunner 02:49:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:49:13 INFO - Running setup.py install for mozscreenshot 02:49:13 INFO - Running setup.py install for moztest 02:49:14 INFO - Running setup.py install for mozversion 02:49:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:49:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:49:14 INFO - Cleaning up... 02:49:14 INFO - Return code: 0 02:49:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:14 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:14 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 02:49:14 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 02:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:14 INFO - 'HOME': '/Users/cltbld', 02:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:14 INFO - 'LOGNAME': 'cltbld', 02:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:14 INFO - 'MOZ_NO_REMOTE': '1', 02:49:14 INFO - 'NO_EM_RESTART': '1', 02:49:14 INFO - 'PAGER': '/bin/cat', 02:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:14 INFO - 'PWD': '/builds/slave/test', 02:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:14 INFO - 'SHELL': '/bin/bash', 02:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:14 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:14 INFO - 'USER': 'cltbld', 02:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:14 INFO - 'XPC_FLAGS': '0x0', 02:49:14 INFO - 'XPC_SERVICE_NAME': '0', 02:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-dDaV1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:49:14 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)) 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-K_ybT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-24ntjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:49:14 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)) 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-rrBLzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:49:14 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)) 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-QxauqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:49:14 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)) 02:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:49:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WhN70w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-dwzza1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-yflbW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-JiAQxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-7nyjxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-yeyr0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-z9sYUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-dTIw30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-EIWtL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:49:15 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)) 02:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:15 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-3rLukV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:49:16 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-1phI0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:49:16 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)) 02:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:49:16 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KkXPi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:49:16 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)) 02:49:16 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:49:16 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:49:16 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)) 02:49:16 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)) 02:49:16 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)) 02:49:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:18 INFO - Downloading blessings-1.6.tar.gz 02:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:49:18 INFO - Installing collected packages: blessings 02:49:18 INFO - Running setup.py install for blessings 02:49:18 INFO - Successfully installed blessings 02:49:18 INFO - Cleaning up... 02:49:19 INFO - Return code: 0 02:49:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:19 INFO - Reading from file tmpfile_stdout 02:49:19 INFO - Current package versions: 02:49:19 INFO - blessings == 1.6 02:49:19 INFO - blobuploader == 1.2.4 02:49:19 INFO - docopt == 0.6.1 02:49:19 INFO - manifestparser == 1.1 02:49:19 INFO - mozInstall == 1.12 02:49:19 INFO - mozcrash == 0.17 02:49:19 INFO - mozdebug == 0.1 02:49:19 INFO - mozdevice == 0.48 02:49:19 INFO - mozfile == 1.2 02:49:19 INFO - mozhttpd == 0.7 02:49:19 INFO - mozinfo == 0.9 02:49:19 INFO - mozleak == 0.1 02:49:19 INFO - mozlog == 3.1 02:49:19 INFO - moznetwork == 0.27 02:49:19 INFO - mozprocess == 0.22 02:49:19 INFO - mozprofile == 0.28 02:49:19 INFO - mozrunner == 6.11 02:49:19 INFO - mozscreenshot == 0.1 02:49:19 INFO - mozsystemmonitor == 0.0 02:49:19 INFO - moztest == 0.7 02:49:19 INFO - mozversion == 1.4 02:49:19 INFO - psutil == 3.1.1 02:49:19 INFO - requests == 1.2.3 02:49:19 INFO - wsgiref == 0.1.2 02:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:19 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 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:19 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 02:49:19 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 02:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:19 INFO - 'HOME': '/Users/cltbld', 02:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:19 INFO - 'LOGNAME': 'cltbld', 02:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:19 INFO - 'MOZ_NO_REMOTE': '1', 02:49:19 INFO - 'NO_EM_RESTART': '1', 02:49:19 INFO - 'PAGER': '/bin/cat', 02:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:19 INFO - 'PWD': '/builds/slave/test', 02:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:19 INFO - 'SHELL': '/bin/bash', 02:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:19 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:19 INFO - 'USER': 'cltbld', 02:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:19 INFO - 'XPC_FLAGS': '0x0', 02:49:19 INFO - 'XPC_SERVICE_NAME': '0', 02:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 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)) 02:49:19 INFO - Cleaning up... 02:49:19 INFO - Return code: 0 02:49:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:19 INFO - 'HOME': '/Users/cltbld', 02:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:19 INFO - 'LOGNAME': 'cltbld', 02:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:19 INFO - 'MOZ_NO_REMOTE': '1', 02:49:19 INFO - 'NO_EM_RESTART': '1', 02:49:19 INFO - 'PAGER': '/bin/cat', 02:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:19 INFO - 'PWD': '/builds/slave/test', 02:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:19 INFO - 'SHELL': '/bin/bash', 02:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:19 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:19 INFO - 'USER': 'cltbld', 02:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:19 INFO - 'XPC_FLAGS': '0x0', 02:49:19 INFO - 'XPC_SERVICE_NAME': '0', 02:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:19 INFO - Downloading/unpacking jsonschema 02:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:49:22 INFO - Downloading/unpacking functools32 (from jsonschema) 02:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:49:22 INFO - warning: no files found matching '*.txt' 02:49:22 INFO - no previously-included directories found matching 'build' 02:49:22 INFO - no previously-included directories found matching 'dist' 02:49:22 INFO - no previously-included directories found matching '.git*' 02:49:22 INFO - Installing collected packages: jsonschema, functools32 02:49:22 INFO - Running setup.py install for functools32 02:49:22 INFO - warning: no files found matching '*.txt' 02:49:22 INFO - no previously-included directories found matching 'build' 02:49:22 INFO - no previously-included directories found matching 'dist' 02:49:22 INFO - no previously-included directories found matching '.git*' 02:49:22 INFO - Successfully installed jsonschema functools32 02:49:22 INFO - Cleaning up... 02:49:23 INFO - Return code: 0 02:49:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1086a9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086b04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad95af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, '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.amspOvKY5p/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.f7yHnqmiXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:23 INFO - 'HOME': '/Users/cltbld', 02:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:23 INFO - 'LOGNAME': 'cltbld', 02:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:23 INFO - 'MOZ_NO_REMOTE': '1', 02:49:23 INFO - 'NO_EM_RESTART': '1', 02:49:23 INFO - 'PAGER': '/bin/cat', 02:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:23 INFO - 'PWD': '/builds/slave/test', 02:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:23 INFO - 'SHELL': '/bin/bash', 02:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:49:23 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:23 INFO - 'USER': 'cltbld', 02:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:23 INFO - 'XPC_FLAGS': '0x0', 02:49:23 INFO - 'XPC_SERVICE_NAME': '0', 02:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:23 INFO - Downloading/unpacking flake8 02:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:49:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:49:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:49:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:49:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:49:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:49:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:49:26 INFO - no previously-included directories found matching 'docs/_build' 02:49:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:49:27 INFO - Running setup.py install for pep8 02:49:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:49:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:49:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:49:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:49:27 INFO - no previously-included directories found matching 'docs/_build' 02:49:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:49:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:49:27 INFO - Cleaning up... 02:49:27 INFO - Return code: 0 02:49:27 INFO - Running post-action listener: _resource_record_post_action 02:49:27 INFO - Running post-action listener: _start_resource_monitoring 02:49:27 INFO - Starting resource monitoring. 02:49:27 INFO - ##### 02:49:27 INFO - ##### Running install step. 02:49:27 INFO - ##### 02:49:27 INFO - Running pre-action listener: _resource_record_pre_action 02:49:27 INFO - Running main action method: install 02:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Output received: 02:49:27 INFO - Usage: mozinstall [options] installer 02:49:27 INFO - Options: 02:49:27 INFO - -h, --help show this help message and exit 02:49:27 INFO - -d DEST, --destination=DEST 02:49:27 INFO - Directory to install application into. [default: 02:49:27 INFO - "/builds/slave/test"] 02:49:27 INFO - --app=APP Application being installed. [default: firefox] 02:49:27 INFO - mkdir: /builds/slave/test/build/application 02:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:59 INFO - Reading from file tmpfile_stdout 02:49:59 INFO - Output received: 02:49:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:59 INFO - Running post-action listener: _resource_record_post_action 02:49:59 INFO - ##### 02:49:59 INFO - ##### Running run-tests step. 02:49:59 INFO - ##### 02:49:59 INFO - Running pre-action listener: _resource_record_pre_action 02:49:59 INFO - Running main action method: run_tests 02:49:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:59 INFO - 2016-04-11 02:49:59.622 screenresolution[1641:7341] starting screenresolution argv=screenresolution get 02:49:59 INFO - 2016-04-11 02:49:59.625 screenresolution[1641:7341] Display 0: 1600x1200x32@60 02:49:59 INFO - 2016-04-11 02:49:59.631 screenresolution[1642:7344] starting screenresolution argv=screenresolution list 02:49:59 INFO - Available Modes on Display 0 02:49:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:59 INFO - Intel Iris: 02:49:59 INFO - Chipset Model: Intel Iris 02:49:59 INFO - Type: GPU 02:49:59 INFO - Bus: Built-In 02:49:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:59 INFO - Vendor: Intel (0x8086) 02:49:59 INFO - Device ID: 0x0a2e 02:49:59 INFO - Revision ID: 0x0009 02:49:59 INFO - Displays: 02:49:59 INFO - Display: 02:49:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:59 INFO - Display Serial Number: 1600x1200 60 02:49:59 INFO - Main Display: Yes 02:49:59 INFO - Mirror: Off 02:49:59 INFO - Online: Yes 02:49:59 INFO - Rotation: Supported 02:49:59 INFO - Return code: 0 02:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:59 INFO - Python 2.7.3 02:49:59 INFO - Return code: 0 02:49:59 INFO - grabbing minidump binary from tooltool 02:49: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')]} 02:49:59 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 0x10854dd30>, '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 0x1083b1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108544b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:59 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 02:49:59 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 02:49:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:59 INFO - Return code: 0 02:49:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:50:01 INFO - Return code: 0 02:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.amspOvKY5p/Render', 02:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:50:01 INFO - 'HOME': '/Users/cltbld', 02:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:50:01 INFO - 'LOGNAME': 'cltbld', 02:50:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:01 INFO - 'MOZ_NO_REMOTE': '1', 02:50:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:01 INFO - 'NO_EM_RESTART': '1', 02:50:01 INFO - 'PAGER': '/bin/cat', 02:50:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:01 INFO - 'PWD': '/builds/slave/test', 02:50:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:50:01 INFO - 'SHELL': '/bin/bash', 02:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f7yHnqmiXN/Listeners', 02:50:01 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 02:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:50:01 INFO - 'USER': 'cltbld', 02:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:01 INFO - 'XPC_FLAGS': '0x0', 02:50:01 INFO - 'XPC_SERVICE_NAME': '0', 02:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:50:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:50:01 INFO - mozversion application_buildid: 20160411004020 02:50:01 INFO - mozversion application_changeset: 29f1480e9931de5ef94055e97f74411aeddb16ad 02:50:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:50:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:01 INFO - mozversion application_name: Firefox 02:50:01 INFO - mozversion application_remotingname: firefox-dev 02:50:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:50:01 INFO - mozversion application_vendor: Mozilla 02:50:01 INFO - mozversion application_version: 47.0a2 02:50:01 INFO - mozversion platform_buildid: 20160411004020 02:50:01 INFO - mozversion platform_changeset: 29f1480e9931de5ef94055e97f74411aeddb16ad 02:50:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:50:01 INFO - mozversion platform_version: 47.0a2 02:50:01 INFO - using testdate: 1460368201 02:50:01 INFO - actual date: 1460368201 02:50:01 INFO - starting webserver on 'localhost:49276' 02:50:01 INFO - SUITE-START | Running 2 tests 02:50:01 INFO - TEST-START | dromaeo_css 02:50:01 INFO - operating with platform_type : mac_ 02:50:01 INFO - Initialising browser for dromaeo_css test... 02:50:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpdnQTFv/profile http://localhost:49276/getInfo.html) 02:50:03 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:50:03 INFO - PROCESS | 1660 | colorDepth:24 02:50:03 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:50:03 INFO - PROCESS | 1660 | __metrics 02:50:03 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:50:03 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:04 INFO - TEST-INFO | 1660: exit 0 02:50:04 INFO - Browser initialized. 02:50:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:50:04 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpdnQTFv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:16 INFO - PROCESS | 1663 | RSS: Main: 207540224 02:50:16 INFO - PROCESS | 1663 | 02:51:07 INFO - PROCESS | 1663 | 1460368267685 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] 02:53:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 02:53:19 INFO - PROCESS | 1663 | RSS: Main: 349982720 02:53:19 INFO - PROCESS | 1663 | 02:56:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 02:56:22 INFO - PROCESS | 1663 | RSS: Main: 342450176 02:56:22 INFO - PROCESS | 1663 | 02:59:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 02:59:24 INFO - PROCESS | 1663 | RSS: Main: 350130176 02:59:24 INFO - PROCESS | 1663 | 03:02:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 03:02:27 INFO - PROCESS | 1663 | RSS: Main: 306286592 03:02:27 INFO - PROCESS | 1663 | 03:05:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 03:05:31 INFO - PROCESS | 1663 | RSS: Main: 306585600 03:05:31 INFO - PROCESS | 1663 | 03:08:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 03:08:34 INFO - PROCESS | 1663 | RSS: Main: 354312192 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | __start_tp_report 03:08:34 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 03:08:34 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 03:08:34 INFO - PROCESS | 1663 | |i|pagename|runs| 03:08:34 INFO - PROCESS | 1663 | |0;dojo.html;3401.081707938856;3529.0118766745322;3538.769979951302;3539.433690609503;3594.370985077612;5779.508741756945;5814.186013958044;5815.156802263669;5817.01110811162;5849.064149736043;5748.367679555246;5808.2158908547335;5811.6803575803315;5811.98290299197;5826.796062137826;5118.411382691001;5184.11869982104;5201.427842937273;5227.607929405291;5271.683698978073;5174.404943431516;5190.429052804188;5192.71440070796;5199.038177937094;5199.168133098705;4507.391502147218;5193.792248310063;5234.528892399683;5285;5304.336957880265;4407.735535867826;5230.163173892178;5330.1205301125265;5333.413324534298;5355.705436201008;5015.272785446126;5173.068847607429;5198.870028249286;5212.635115541913;5245.554127899133;5653.265075540195;5693.402192769782;5710.086386178192;5719.428057194289;5727.770889164429;6141.731496609858;6336.58812177207;6338.429541341256;6340.587861788969;6342.334054924213;6224.595401298901;6273.215848018997;6279.466245369149;6297.307296197415;6304.1804565406665;5805.216295800055;5816.447437493473;5818.185454036438;5829.970850145722;5935.940640593625;6364.49084073273;6398.648074355862;6408.51936104794;6414.102025716404;6419.293877673452;6169.383061693885;6210.223722034746;6227.06594010893;6272.874542509216;6280.246370435486;6157.507399408037;6252.437280644764;6291.653959032297;6307.306196318401;6318.6524741138755;6278.780242691484;6312.621242725451;6316.9368306317265;6320.936790632127;6324.083007963912;6278.277998030285;6316.589421687576;6340.3342649022115;6340.492760579143;6349.650769207646;4857.975710121426;4910.337104490919;4943.184374578226;4944.283078953532;4950.653454258239;4391.538888416734;4420.933685994648;4429.82280708768;4432.3794668746405;4450.910981780346;5821.243238378984;5835.270591176103;5843.094320380348;5848.766049358063;5850.619709718854;6223.471004964629;6262.812115636538;6305.621662700252;6310.842228944313;6323.841903952438;5788.5369170466265;5793.797217097465;5805.129230615442;5815.069588865846;5836.037053886146;5382.085045542267;5397.7571009304675;5399.055165346049;5412.56699464042;5415.620906536505;5989;6289.622622642656;6381.1066450696935;6436.645984470899;6486.254080780582;5199.870003249949;6301.3657765335265;6323.241211054703;6334.588251763621;6349.714262858275;6220.626762394271;6359.777407790705;6383.680815959091;6410.45511131559;6413.903791443226;6145.66198859067;6237.064440333987;6245.5628106033955;6270;6272.372762723691;6284.088807123033;6311.936880631135;6319.178506794087;6319.494440444845;6321.051842223703;6038.426349496791;6038.9396106038375;6216;6226.097215903759;6234.812955611157;6153.876922461615;6198.163247961648;6208.503319734501;6218.595791273553;6230.563860529719;6040.75836966534;6064.666443345482;6075.362086980804;6086.6652334122045;6116.602420842631;5957;6053.545984051302;6131.754729810936;6171.84570385744;6173.475254603409;5805.448482394166;5933.881322373615;5982.46157845796;6071.119687645355;6097.2683278006925 03:08:34 INFO - PROCESS | 1663 | |1;ext.html;466.5357968821024;548.9520634058055;562.4572287742328;598.4344794169509;664.1664710787959;31388.529172062408;31898.521522177158;31905.04284871452;39830;40481;43300.78349608248;43500.3474947876;43665;43706.12587748243;43717;9500.429974201536;9731.708048758514;9740;9743.123118919295;9752.65865694701;9469.621215151386;9621.470819104947;9628.037196280351;9628.22974162069;9667.806643867154;9575.42547447152;9663.468509231989;9678.419294842297;9811.607535698564;9813.362131461468;9728.513574321256;9815.705528834074;9815.705528834147;9825.70522884311;9826.80346393068;9594.90405095947;9690.75773105678;9710.271729620306;9711.854322185172;9724;42011.73964781062;42682;42693.1461370774;42733.931651708954;42839.357409638884;3200;3347.8493467794005;3395.7962522248745;3454.5336379588935;3756.323861704892;29515.85242073776;29556.26109347262;29909;30000.8499957501;30180.94366697177;2735.8084934054623;2746.533089374811;2781.415902660444;2784.8050636455455;2827.2507785436874;481862;488093;488922;489164;490525;60397;73163;73610.63194683992;73692.26307736961;73740;65659.68680626457;72777.54444911072;76647;77192;77211.43702785326;18434.262629494937;18587;18686.906565467085;18723.438296851116;18744.81255187458;13849;13968.301584920713;13971.650708732363;13998.650033749238;14048.648783780283;22180.778192218193;22663.433414164447;22690.43273918165;22692.546149076927;22700.545989080456;8972.237359824489;9180.036096209802;9183.311251656152;9200.30997675177;9230.769230769285;877.3332267476763;1003.1924300937669;1014.3102690170755;1082.1613249731522;1201.627495476405;28335.008274710286;28385.57421638677;28731.56902646462;28784.42431151407;28967.56548651772;780.679921232292;1200.8378868852592;1212.7877621416217;1232.9704696578278;1249.9125061245625;13628.591142265748;15975.920120399556;16781.328746849988;16914.323427063027;16933.238004289837;648387.7580612067;661090;661188;661190;662420;56388;64993.350066499675;65038.34961650417;65049.67475162594;65060;1437.4896911596443;1519.118911031599;1560.6722588256594;1589.6582234819568;1591.9761203581957;24709.752902470744;28558.286042849097;29736;29979.250518737204;30332.54501182528;47400;47784.04431911412;47967.28049079336;48050.27924581064;48241.75879120723;337817;339490;339865.5033624179;340157;340768.29615852755;29840;32371.838140810087;34556.30887382288;35064.29871402609;35192.472112917814;33828;42679.14641707211;42687.93280168021;44110;44383.55616443794;35832.64167358293;35910.92267231987;36021.63978360183;36059.63940360563;36782.44826327554;35649;35747.57009719582;36020.919372418866;36412.635873640924;37680.43479347867;36215.27569448543;36799.44800828043;37154.07114822151;37769.244615108095;37810.43284350792;33345.49981750227;34847.9545613632;35356.64643353534;35695.64304356923;35796.284074317846;20697.58604827865;24699;24725.50548989046;25156.496870062863;25534.744652553236 03:08:34 INFO - PROCESS | 1663 | |2;jquery.html;369.5731430198121;377.57145639698945;377.6072884200432;379.20556434270196;384.4291227527124;20613.484662883435;20889;21060.789392106075;21331.25340613079;21353.679694804552;12170.269783812955;12670.366481675925;12746.553870614507;12755.298458584797;12785;4781.593564547018;6179.907301390483;6185.536084793636;6192.0402337637515;6195.721192546323;6051.727672254759;6073.058675905242;6137.9079313810325;6170.167027451282;6172.1667574877265;5831.708414579275;6006.609570377911;6020.819375418744;6027.698615069251;6087.360827113133;5501.587380946445;5986.97006514969;5994.790182343619;6005.459508644221;6005.789797357093;4487.259602165639;5163.432022477525;5323.813666521692;5324.148136298212;5336;13921.30393480332;14205.857941420556;14207.289635518286;14304.57086287413;14523.419063237458;1983.464464594566;2102.9579408411746;2223;2356.929292121239;2357.26924653358;9881.357711748786;9934.900650993543;10425.947870260676;10653.307535010199;10683.252172347939;1740.5735594779233;1748.589081565831;1774.645070985808;1828.698264786322;1893.9621207575772;71293;108637.45681271622;110939;111349;112229.43885280521;11695;11735.295882247092;11741.119416043832;11746.060315174765;11850.940745296391;13252.73494530104;14634;14780.48268310604;14794.408223670933;14796.260186990607;8511.616977236039;8971.147740964598;8977;9018.278537716968;9096.454212747256;7096.858062838817;9212.723618291462;9225.40034897743;9304.488253146143;9325.300602454843;4627.930581041287;4638.907221855544;4639.9536004640195;4642.51253618372;4700.9059818803435;1644.0957473389587;1718.518814731877;1882.3223639489772;1906.428071578521;1962.3818497173345;942.8868535775614;1022.9897701023043;1040.1314902056868;1078.4176544665793;1094.7865166292656;20325.89837050835;21132;21196.576068478545;21456.678149827763;21488.78511214868;962.7208109648263;1000.2298230362726;1001.1240164855751;1005.1757558801859;1013.5894962540183;11195.888041119648;11250.423585225386;11336.206465547497;11356.716082098013;11531.1351648625;623884;631661;633162;643558;645295;113836;114300.85593152694;115969.42015289869;120881;123622;1031.2420371027438;1032.2722480651273;1042.890496497872;1044.216837371971;1068.7381591509975;18120.199050665997;18450.169742361893;18647.44057678272;18742.34401795985;18840.52898677544;51234;52236.55419784811;52862;53095;55003.724981374835;74531;74779.25220747941;74920.87618685832;76971.61514192393;78731;8020.558869262247;8353.95823020881;8499.447535910145;8502.149785021697;8515.74452766418;8113.959430202811;10438.642976413017;12138.878611213775;13296;13729.931350343184;11340.829887551528;11571.6528504145;11914.463849126636;11948.283103013848;11954.940225299166;11198.776024479628;11295.265807722471;11419.429028548373;11743.530258789895;11900.76198476043;11515.5969541069;11781.646550603497;12019.21875078117;12051.51793928233;12145.45345459474;8263.256306932404;8272.296854767412;8414.410991230556;8483.575821208791;8551.047570623128;8669.176428239307;11057.834132487858;11765;11991.280523168638;12073.879261207276 03:08:34 INFO - PROCESS | 1663 | |3;mootools.html;1472.4331132513978;1621.6189195539046;1640.6144556029335;1954.0425191656084;2052.3124753207667;8144.470609410391;8636.956815215923;8767.16711912369;8777.956110219457;8779.868301975475;8138.470999385051;8853.645854165825;8856.911430885706;8867.201951824334;8884.777880552989;2142.453674313048;2212.811910987568;2276.0781883337277;2278.7493375728654;2401.5470640262606;2324.418895276181;2483.205374280231;2544.096845619806;2544.8345857519294;2547.630593563932;2444.3889027743066;2474.3319303787966;2525.4696513732138;2540.834845735021;2544.134994102005;2258.864468131901;2423.4183795889035;2428.672129262545;2428.8178386620984;2434.7808697217333;2480.516299321633;2506.9749302507107;2513.54756143894;2517.710463296726;2522.8864701088496;8885.155910188521;8944.01615822259;8950.910490895072;8961.865572016424;8976.640934362618;5526.447355264481;5619.9603073431135;5623.775048998035;5672.4611161939965;5680.517156041741;3167.952480712791;3554.928901421957;3634.254977729559;3734.159814041846;3742.176721121376;1049.6326285799985;1052.847337136111;1069.6416700405373;1082.5020490574345;1092.1153865369076;12041.976432003377;12109.39453027354;12143.93928030363;12155.453004614814;12187.51249950001;4854.975725121351;4968.701877887338;4999.825006124841;5017.347744793226;5048.343715316985;10144.934781847947;10232.437215953045;10250.897491024994;10261.179105671677;10272.33229840058;5590.5248053915875;5618.550515958714;5632.831015069554;5635.718214089279;5635.746391412396;4481.932771008437;4518.909621807546;5070.4929507049;5073.594112470993;5088.669236499616;3343.36476069546;3918.4122381642983;4001.599840015975;4017.879463616096;4042.8989275268355;1064.4890452582804;1224.7611715715527;1226.8466441694789;1240.8821161989597;1243.0614885761192;956.2875657635107;1143.2168964259508;1145.8395824584566;1301.1412467771227;1429.814124163852;8285.792855178548;8347.749567512985;8373.958130209432;8383.874241886255;8462.957685211535;518.7561845932406;519.7583123847429;522.3575002746567;523.657004661947;532.3585079978617;6239.968800156061;6249.406306400884;6275;6313.96843015782;6322.683865806691;10360.274780765274;10747.462626868626;10804;10815.945920270347;10815.945920270506;10357.171426285879;10550.261481696361;10618.36289822613;10681.62614308511;10774.299670521392;8366.414350995372;8448.57757112142;8455.66177352899;8505.404621676424;8535.615897284637;7948.443608947318;8034.196580341919;8034.397420193626;8056.476329038594;8094.433389662667;8812.603432845666;9379.577918993526;9759;9832.115109640166;9843.507824608883;9915.355501892354;10103.989601039837;10197.388156710622;10333.793324133625;10360.378377297386;6664.50016248793;6859.622720750406;7520.398368130646;7694.461387703031;7766.728164514215;8346.833063338821;8365.330773538224;8386.832263354576;8391.874121888055;8396.538190399586;7353.485256032026;7399.48203625741;7414.221506741715;7542.132654744774;7568.697252110074;7273.054502914587;7299.124105107421;7323.414126869731;7370.926290737239;7421.8144546386775;7799.376049916106;7831.84336313282;7853.882191767242;7859.646315915683;7873.25204105609;6767.492438067066;6940.548864323803;7047.260037696173;7103.183133939457;7115.857682846417;7174.533655312388;7252.854942901007;7257.310555497219;7261.3101755333155;7262.491625586158 03:08:34 INFO - PROCESS | 1663 | |4;prototype.html;332.8485539079719;335.44651325313237;344.2753004924635;345.2542508182326;349.20555735701294;6448.45188159007;6500.447461965733;6575.243846957601;6592.044153597725;6624.436922861562;6552.803415897519;6556.606603603787;6559.21289445266;6578.934210657892;6584.473242140629;4621.676482646216;4695.929561056587;4709.387779588648;4713.740744259065;4915.655904086707;4716.646251531131;4718.7168769873915;4722.929156062662;4798.640101992347;4842.539958703917;4830.299606557047;4832.71003739775;4832.855014349558;4833;4848.812041049948;4820.035992801454;4824.517548245182;4834.806607735686;4844.709317440965;4845.951540484603;3942.467766851467;4050.6151915567975;4153.605407486284;4208.473940757405;4211.936820947688;4976.552110310089;6305.68471576424;6305.779297724604;6351.460125889305;6371.108044873721;5707.086866101446;5741.3110426748635;5749.453801888856;5749.482546570787;5754.108113242454;6970;6994.930050699479;6998.580085194853;7019.82450438738;7023.52505973741;4538.1377538267625;4692.507286734912;4709.152352576535;4718.693284936468;4724.078804633098;7369.336759691653;7404.444666649969;7408.407327413848;7411.88882166768;7420;4800.231962885991;4845.370101886732;4854.514548545118;4854.951450485521;4863.2461968394955;4935.988122434892;4938.765308672831;4944.480829512921;4944.678595891256;4952.20764677657;5579.191017302468;5649.745761440745;5756.5682573807135;5766.798162064308;5783.161441590946;6787.93212067873;7020.192677842011;7046.224915259318;7048.753293634698;7050.365467107985;1648.5054483654856;1686.6626674665115;1700.2773821125973;1703.335699077361;1703.7274036154156;916.757059379265;1088.5972190289644;1102.8014957307762;1104.9779004419865;1126.3467189030343;5177.249298851645;5329.653572517774;6100;6541.803745887631;6544.116544266463;7173.748918787817;7185.281471852877;7194.028806111212;7197.568145911262;7342.669579868919;6623.337666233435;6625.7680981166395;6629.9337006630285;6633.701483433257;6635.933640663531;3817.866374676873;3852.6339997700175;3866.7293289469467;3876.4960555127655;3887.552931412867;7281;7644.120926093459;7644.388448924073;7668.118166410823;7673.808154796175;7438.702451901863;7469.9831045617375;7528.021357223526;7531.133919599316;7531.472796904164;7601.619919003917;7611.2769286917655;7618.809529761689;7626.275503827128;7643.121041080236;7273.781786546412;7288.708451661874;7301;7308.780736577911;7318.938753880551;6838.794836154724;7166;7172.820679483055;7173.497855150298;7176.210616832249;7563.621818909142;7602.46782725204;7615.086189657277;7617.9619101906355;7623.618819058914;4639.420072490939;4689.507601701908;4700.177468942853;4705.64707646921;4707.105649926503;7292.234315396807;7294.307040831112;7304.160021597584;7317.341439270278;7323.963380183065;6678.599284042973;6944.270851560514;6948.722051117898;7055.753048643272;7073.186583542958;6958.130233720785;7002.334778196063;7009.334113259232;7010.789676309719;7015.123109611299;5205.297284866495;5701.287339082614;6816.522843400914;6819.420349270367;6847.62338071391;6977.581345119309;6997.545159564612;6998.965005174941;7013.438924885895;7022.54353467023;6565.606063636197;6580.670966451563;6858.3827455529245;6877.931220687929;6907.654617269016 03:08:34 INFO - PROCESS | 1663 | |5;yui.html;692.8926016467447;751.3913729878799;752.1350446985965;761.4821921093654;762.8893810397489;15107.773383399257;15372.154531500762;15398;15403.691926161484;18337.724934126;16914.915425422885;16924.576885577837;16989.405370812023;17002.82997170028;17009.744853827204;798.9400794940374;814.287498438866;964.6237967192783;998.7103739915416;999.9800003999916;853.1894700034992;982.1798798003675;982.8329184038695;983.0022527134963;988.6737376665719;1035.404642330659;1047.08903254169;1047.9266451348408;1048.7378155461136;1049.3022140276707;830.6345208108443;994.6866736977829;1021.2442792333694;1022.3456987527989;1031.6079889641962;768.9577073261024;770.0682174568778;770.6609091999502;771.3405038691893;773.2924374197603;15758.606034849106;15854.365825366971;15885.523434296989;15893.761593576106;15913.681726365408;12726.618201453972;12751.42618582166;12810.80783788244;13020.47918083285;13053.086283960127;10252.128569071638;10276.588936442533;10340.069393754598;10464.42445665488;10664.946675266652;3427.9143021424666;3527.753057285991;3530.9646903531147;3534.8762793302367;3617.222297206113;90654.09345906522;91669.54165229198;91714.16571668597;92105.07894921032;92132.53933730355;9556.283278754121;9592.280578956606;9613.615455381847;9680.080392362714;10030.799384012278;21598.24406145809;21880.23419180321;21882.78117218839;21898.89050554769;22377.888110559343;7572.129205141479;7730.690772369155;7757.069151701719;7964.402669799672;8007.439479236397;4044.656204222615;4054.5337286211875;4108.055147316134;4157.97921010399;4159.085001299709;3722;3751.3435148848844;3768.246350729865;3776.2825063237897;3780.1872597391143;596.4214711729616;654.509118161379;669.6885948034187;676.2594958520413;696.0637941968045;460.5555638808499;537.3444397834636;568.766805609698;603.9124326972652;631.538976547114;7842.215778422112;8186.959065204635;8306.460080094774;8388.8741668875;8396.496210227406;593.1636392686291;604.6281536854802;609.2780055634088;618.5484596244677;624.1636207481905;3870.4774855394726;3939.330313846653;3940.310445671996;3971.0866500704424;4014.6186112319283;91490.54254728684;92727;93013.60479592811;93249.60125598121;95876;83687.5815620918;83853.58073209594;83905.58047209847;86194.56902715571;88429;64831;65971;67128.32871671318;67369.66315168393;67459;8568.57157142153;8653.437526560754;8766.561671916506;8837.911620883966;8968.955155224183;43844.90387740332;46640.7667961658;46977.76511117422;47571.28643070287;49749.502504975935;51890.48109518857;62058.75882482415;65950.67024664846;65987.34012659812;67353.32646673471;9821.57587149845;10807.405592692163;11075.113990880549;11295.604653837076;11459.31244125355;11206.775864482828;11723.472443740222;11769.764604708029;12062.939685301517;12471.5011399543;11649.59226427071;11696.590619328283;11723.120765942418;11867.397901283217;12013.519459221534;10404.947975260075;10690.89309106899;10824;11293.71765705864;11466.2546934449;10670.860266796213;10987.39569323695;11235.494402751732;11391.145664075393;11628.6511404658;9501.667441639509;9829.4102353859;9848.852267215854;9966;10231.976802319708;9425.481598512148;9838.311318207656;9868;9889.357191782512;10042.447665378475 03:08:34 INFO - PROCESS | 1663 | __end_tp_report 03:08:34 INFO - PROCESS | 1663 | __start_cc_report 03:08:34 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1231 03:08:34 INFO - PROCESS | 1663 | __end_cc_report 03:08:34 INFO - PROCESS | 1663 | __startTimestamp1460369314128__endTimestamp 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | ------- Summary: start ------- 03:08:34 INFO - PROCESS | 1663 | Number of tests: 6 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5790.70 Median:6038.94 stddev:658.58 (10.9%) stddev-sans-first:633.36 03:08:34 INFO - PROCESS | 1663 | Values: 3401.1 3529.0 3538.8 3539.4 3594.4 5779.5 5814.2 5815.2 5817.0 5849.1 5748.4 5808.2 5811.7 5812.0 5826.8 5118.4 5184.1 5201.4 5227.6 5271.7 5174.4 5190.4 5192.7 5199.0 5199.2 4507.4 5193.8 5234.5 5285.0 5304.3 4407.7 5230.2 5330.1 5333.4 5355.7 5015.3 5173.1 5198.9 5212.6 5245.6 5653.3 5693.4 5710.1 5719.4 5727.8 6141.7 6336.6 6338.4 6340.6 6342.3 6224.6 6273.2 6279.5 6297.3 6304.2 5805.2 5816.4 5818.2 5830.0 5935.9 6364.5 6398.6 6408.5 6414.1 6419.3 6169.4 6210.2 6227.1 6272.9 6280.2 6157.5 6252.4 6291.7 6307.3 6318.7 6278.8 6312.6 6316.9 6320.9 6324.1 6278.3 6316.6 6340.3 6340.5 6349.7 4858.0 4910.3 4943.2 4944.3 4950.7 4391.5 4420.9 4429.8 4432.4 4450.9 5821.2 5835.3 5843.1 5848.8 5850.6 6223.5 6262.8 6305.6 6310.8 6323.8 5788.5 5793.8 5805.1 5815.1 5836.0 5382.1 5397.8 5399.1 5412.6 5415.6 5989.0 6289.6 6381.1 6436.6 6486.3 5199.9 6301.4 6323.2 6334.6 6349.7 6220.6 6359.8 6383.7 6410.5 6413.9 6145.7 6237.1 6245.6 6270.0 6272.4 6284.1 6311.9 6319.2 6319.5 6321.1 6038.4 6038.9 6216.0 6226.1 6234.8 6153.9 6198.2 6208.5 6218.6 6230.6 6040.8 6064.7 6075.4 6086.7 6116.6 5957.0 6053.5 6131.8 6171.8 6173.5 5805.4 5933.9 5982.5 6071.1 6097.3 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64823.94 Median:36790.95 stddev:136902.51 (372.1%) stddev-sans-first:137201.29 03:08:34 INFO - PROCESS | 1663 | Values: 466.5 549.0 562.5 598.4 664.2 31388.5 31898.5 31905.0 39830.0 40481.0 43300.8 43500.3 43665.0 43706.1 43717.0 9500.4 9731.7 9740.0 9743.1 9752.7 9469.6 9621.5 9628.0 9628.2 9667.8 9575.4 9663.5 9678.4 9811.6 9813.4 9728.5 9815.7 9815.7 9825.7 9826.8 9594.9 9690.8 9710.3 9711.9 9724.0 42011.7 42682.0 42693.1 42733.9 42839.4 3200.0 3347.8 3395.8 3454.5 3756.3 29515.9 29556.3 29909.0 30000.8 30180.9 2735.8 2746.5 2781.4 2784.8 2827.3 481862.0 488093.0 488922.0 489164.0 490525.0 60397.0 73163.0 73610.6 73692.3 73740.0 65659.7 72777.5 76647.0 77192.0 77211.4 18434.3 18587.0 18686.9 18723.4 18744.8 13849.0 13968.3 13971.7 13998.7 14048.6 22180.8 22663.4 22690.4 22692.5 22700.5 8972.2 9180.0 9183.3 9200.3 9230.8 877.3 1003.2 1014.3 1082.2 1201.6 28335.0 28385.6 28731.6 28784.4 28967.6 780.7 1200.8 1212.8 1233.0 1249.9 13628.6 15975.9 16781.3 16914.3 16933.2 648387.8 661090.0 661188.0 661190.0 662420.0 56388.0 64993.4 65038.3 65049.7 65060.0 1437.5 1519.1 1560.7 1589.7 1592.0 24709.8 28558.3 29736.0 29979.3 30332.5 47400.0 47784.0 47967.3 48050.3 48241.8 337817.0 339490.0 339865.5 340157.0 340768.3 29840.0 32371.8 34556.3 35064.3 35192.5 33828.0 42679.1 42687.9 44110.0 44383.6 35832.6 35910.9 36021.6 36059.6 36782.4 35649.0 35747.6 36020.9 36412.6 37680.4 36215.3 36799.4 37154.1 37769.2 37810.4 33345.5 34848.0 35356.6 35695.6 35796.3 20697.6 24699.0 24725.5 25156.5 25534.7 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34882.08 Median:20751.24 stddev:105276.92 (507.3%) stddev-sans-first:105540.36 03:08:34 INFO - PROCESS | 1663 | Values: 369.6 377.6 377.6 379.2 384.4 20613.5 20889.0 21060.8 21331.3 21353.7 12170.3 12670.4 12746.6 12755.3 12785.0 4781.6 6179.9 6185.5 6192.0 6195.7 6051.7 6073.1 6137.9 6170.2 6172.2 5831.7 6006.6 6020.8 6027.7 6087.4 5501.6 5987.0 5994.8 6005.5 6005.8 4487.3 5163.4 5323.8 5324.1 5336.0 13921.3 14205.9 14207.3 14304.6 14523.4 1983.5 2103.0 2223.0 2356.9 2357.3 9881.4 9934.9 10425.9 10653.3 10683.3 1740.6 1748.6 1774.6 1828.7 1894.0 71293.0 108637.5 110939.0 111349.0 112229.4 11695.0 11735.3 11741.1 11746.1 11850.9 13252.7 14634.0 14780.5 14794.4 14796.3 8511.6 8971.1 8977.0 9018.3 9096.5 7096.9 9212.7 9225.4 9304.5 9325.3 4627.9 4638.9 4640.0 4642.5 4700.9 1644.1 1718.5 1882.3 1906.4 1962.4 942.9 1023.0 1040.1 1078.4 1094.8 20325.9 21132.0 21196.6 21456.7 21488.8 962.7 1000.2 1001.1 1005.2 1013.6 11195.9 11250.4 11336.2 11356.7 11531.1 623884.0 631661.0 633162.0 643558.0 645295.0 113836.0 114300.9 115969.4 120881.0 123622.0 1031.2 1032.3 1042.9 1044.2 1068.7 18120.2 18450.2 18647.4 18742.3 18840.5 51234.0 52236.6 52862.0 53095.0 55003.7 74531.0 74779.3 74920.9 76971.6 78731.0 8020.6 8354.0 8499.4 8502.1 8515.7 8114.0 10438.6 12138.9 13296.0 13729.9 11340.8 11571.7 11914.5 11948.3 11954.9 11198.8 11295.3 11419.4 11743.5 11900.8 11515.6 11781.6 12019.2 12051.5 12145.5 8263.3 8272.3 8414.4 8483.6 8551.0 8669.2 11057.8 11765.0 11991.3 12073.9 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6104.35 Median:523.01 stddev:3260.45 (623.4%) stddev-sans-first:3251.01 03:08:34 INFO - PROCESS | 1663 | Values: 1472.4 1621.6 1640.6 1954.0 2052.3 8144.5 8637.0 8767.2 8778.0 8779.9 8138.5 8853.6 8856.9 8867.2 8884.8 2142.5 2212.8 2276.1 2278.7 2401.5 2324.4 2483.2 2544.1 2544.8 2547.6 2444.4 2474.3 2525.5 2540.8 2544.1 2258.9 2423.4 2428.7 2428.8 2434.8 2480.5 2507.0 2513.5 2517.7 2522.9 8885.2 8944.0 8950.9 8961.9 8976.6 5526.4 5620.0 5623.8 5672.5 5680.5 3168.0 3554.9 3634.3 3734.2 3742.2 1049.6 1052.8 1069.6 1082.5 1092.1 12042.0 12109.4 12143.9 12155.5 12187.5 4855.0 4968.7 4999.8 5017.3 5048.3 10144.9 10232.4 10250.9 10261.2 10272.3 5590.5 5618.6 5632.8 5635.7 5635.7 4481.9 4518.9 5070.5 5073.6 5088.7 3343.4 3918.4 4001.6 4017.9 4042.9 1064.5 1224.8 1226.8 1240.9 1243.1 956.3 1143.2 1145.8 1301.1 1429.8 8285.8 8347.7 8374.0 8383.9 8463.0 518.8 519.8 522.4 523.7 532.4 6240.0 6249.4 6275.0 6314.0 6322.7 10360.3 10747.5 10804.0 10815.9 10815.9 10357.2 10550.3 10618.4 10681.6 10774.3 8366.4 8448.6 8455.7 8505.4 8535.6 7948.4 8034.2 8034.4 8056.5 8094.4 8812.6 9379.6 9759.0 9832.1 9843.5 9915.4 10104.0 10197.4 10333.8 10360.4 6664.5 6859.6 7520.4 7694.5 7766.7 8346.8 8365.3 8386.8 8391.9 8396.5 7353.5 7399.5 7414.2 7542.1 7568.7 7273.1 7299.1 7323.4 7370.9 7421.8 7799.4 7831.8 7853.9 7859.6 7873.3 6767.5 6940.5 7047.3 7103.2 7115.9 7174.5 7252.9 7257.3 7261.3 7262.5 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5755.12 Median:6562.41 stddev:1820.79 (27.7%) stddev-sans-first:1779.83 03:08:34 INFO - PROCESS | 1663 | Values: 332.8 335.4 344.3 345.3 349.2 6448.5 6500.4 6575.2 6592.0 6624.4 6552.8 6556.6 6559.2 6578.9 6584.5 4621.7 4695.9 4709.4 4713.7 4915.7 4716.6 4718.7 4722.9 4798.6 4842.5 4830.3 4832.7 4832.9 4833.0 4848.8 4820.0 4824.5 4834.8 4844.7 4846.0 3942.5 4050.6 4153.6 4208.5 4211.9 4976.6 6305.7 6305.8 6351.5 6371.1 5707.1 5741.3 5749.5 5749.5 5754.1 6970.0 6994.9 6998.6 7019.8 7023.5 4538.1 4692.5 4709.2 4718.7 4724.1 7369.3 7404.4 7408.4 7411.9 7420.0 4800.2 4845.4 4854.5 4855.0 4863.2 4936.0 4938.8 4944.5 4944.7 4952.2 5579.2 5649.7 5756.6 5766.8 5783.2 6787.9 7020.2 7046.2 7048.8 7050.4 1648.5 1686.7 1700.3 1703.3 1703.7 916.8 1088.6 1102.8 1105.0 1126.3 5177.2 5329.7 6100.0 6541.8 6544.1 7173.7 7185.3 7194.0 7197.6 7342.7 6623.3 6625.8 6629.9 6633.7 6635.9 3817.9 3852.6 3866.7 3876.5 3887.6 7281.0 7644.1 7644.4 7668.1 7673.8 7438.7 7470.0 7528.0 7531.1 7531.5 7601.6 7611.3 7618.8 7626.3 7643.1 7273.8 7288.7 7301.0 7308.8 7318.9 6838.8 7166.0 7172.8 7173.5 7176.2 7563.6 7602.5 7615.1 7618.0 7623.6 4639.4 4689.5 4700.2 4705.6 4707.1 7292.2 7294.3 7304.2 7317.3 7324.0 6678.6 6944.3 6948.7 7055.8 7073.2 6958.1 7002.3 7009.3 7010.8 7015.1 5205.3 5701.3 6816.5 6819.4 6847.6 6977.6 6997.5 6999.0 7013.4 7022.5 6565.6 6580.7 6858.4 6877.9 6907.7 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18712.58 Median:50819.99 stddev:26483.03 (52.1%) stddev-sans-first:26522.76 03:08:34 INFO - PROCESS | 1663 | Values: 692.9 751.4 752.1 761.5 762.9 15107.8 15372.2 15398.0 15403.7 18337.7 16914.9 16924.6 16989.4 17002.8 17009.7 798.9 814.3 964.6 998.7 1000.0 853.2 982.2 982.8 983.0 988.7 1035.4 1047.1 1047.9 1048.7 1049.3 830.6 994.7 1021.2 1022.3 1031.6 769.0 770.1 770.7 771.3 773.3 15758.6 15854.4 15885.5 15893.8 15913.7 12726.6 12751.4 12810.8 13020.5 13053.1 10252.1 10276.6 10340.1 10464.4 10664.9 3427.9 3527.8 3531.0 3534.9 3617.2 90654.1 91669.5 91714.2 92105.1 92132.5 9556.3 9592.3 9613.6 9680.1 10030.8 21598.2 21880.2 21882.8 21898.9 22377.9 7572.1 7730.7 7757.1 7964.4 8007.4 4044.7 4054.5 4108.1 4158.0 4159.1 3722.0 3751.3 3768.2 3776.3 3780.2 596.4 654.5 669.7 676.3 696.1 460.6 537.3 568.8 603.9 631.5 7842.2 8187.0 8306.5 8388.9 8396.5 593.2 604.6 609.3 618.5 624.2 3870.5 3939.3 3940.3 3971.1 4014.6 91490.5 92727.0 93013.6 93249.6 95876.0 83687.6 83853.6 83905.6 86194.6 88429.0 64831.0 65971.0 67128.3 67369.7 67459.0 8568.6 8653.4 8766.6 8837.9 8969.0 43844.9 46640.8 46977.8 47571.3 49749.5 51890.5 62058.8 65950.7 65987.3 67353.3 9821.6 10807.4 11075.1 11295.6 11459.3 11206.8 11723.5 11769.8 12062.9 12471.5 11649.6 11696.6 11723.1 11867.4 12013.5 10404.9 10690.9 10824.0 11293.7 11466.3 10670.9 10987.4 11235.5 11391.1 11628.7 9501.7 9829.4 9848.9 9966.0 10232.0 9425.5 9838.3 9868.0 9889.4 10042.4 03:08:34 INFO - PROCESS | 1663 | -------- Summary: end -------- 03:08:34 INFO - PROCESS | 1663 | 03:08:34 INFO - TEST-INFO | 1663: exit 0 03:08:34 INFO - TEST-OK | dromaeo_css | took 1113308ms 03:08:34 INFO - TEST-START | kraken 03:08:34 INFO - operating with platform_type : mac_ 03:08:34 INFO - Initialising browser for kraken test... 03:08:34 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpLdJ0kW/profile http://localhost:49276/getInfo.html) 03:08:36 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 03:08:36 INFO - PROCESS | 1674 | colorDepth:24 03:08:36 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 03:08:36 INFO - PROCESS | 1674 | __metrics 03:08:36 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:08:36 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:08:37 INFO - TEST-INFO | 1674: exit 0 03:08:37 INFO - Browser initialized. 03:08:37 INFO - Running cycle 1/1 for kraken test... 03:08:37 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpLdJ0kW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:49 INFO - PROCESS | 1677 | RSS: Main: 207794176 03:08:49 INFO - PROCESS | 1677 | 03:08:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:52 INFO - PROCESS | 1677 | RSS: Main: 262696960 03:08:52 INFO - PROCESS | 1677 | 03:08:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 03:08:55 INFO - PROCESS | 1677 | RSS: Main: 273199104 03:08:55 INFO - PROCESS | 1677 | 03:08:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 03:08:59 INFO - PROCESS | 1677 | RSS: Main: 263147520 03:08:59 INFO - PROCESS | 1677 | 03:09:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 03:09:02 INFO - PROCESS | 1677 | RSS: Main: 265195520 03:09:02 INFO - PROCESS | 1677 | 03:09:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:09:05 INFO - PROCESS | 1677 | RSS: Main: 264642560 03:09:05 INFO - PROCESS | 1677 | 03:09:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 03:09:08 INFO - PROCESS | 1677 | RSS: Main: 265117696 03:09:08 INFO - PROCESS | 1677 | 03:09:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 03:09:11 INFO - PROCESS | 1677 | RSS: Main: 265109504 03:09:11 INFO - PROCESS | 1677 | 03:09:14 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 03:09:15 INFO - PROCESS | 1677 | RSS: Main: 265715712 03:09:15 INFO - PROCESS | 1677 | 03:09:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:09:17 INFO - PROCESS | 1677 | RSS: Main: 299806720 03:09:17 INFO - PROCESS | 1677 | 03:09:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:09:19 INFO - PROCESS | 1677 | RSS: Main: 300752896 03:09:19 INFO - PROCESS | 1677 | 03:09:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:22 INFO - PROCESS | 1677 | RSS: Main: 306106368 03:09:22 INFO - PROCESS | 1677 | 03:09:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:25 INFO - PROCESS | 1677 | RSS: Main: 307757056 03:09:25 INFO - PROCESS | 1677 | 03:09:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:28 INFO - PROCESS | 1677 | RSS: Main: 307494912 03:09:28 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 03:09:30 INFO - PROCESS | 1677 | RSS: Main: 370601984 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | __start_tp_report 03:09:30 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 03:09:30 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 03:09:30 INFO - PROCESS | 1677 | |i|pagename|runs| 03:09:30 INFO - PROCESS | 1677 | |0;ai-astar;111;111;113;111;111;113;119;111;111;111 03:09:30 INFO - PROCESS | 1677 | |1;audio-beat-detection;157;142;169;192;147;137;117;149;149;118 03:09:30 INFO - PROCESS | 1677 | |2;audio-dft;186;183;183;198;264;199;186;185;188;222 03:09:30 INFO - PROCESS | 1677 | |3;audio-fft;74;75;75;115;56;57;59;58;126;57 03:09:30 INFO - PROCESS | 1677 | |4;audio-oscillator;90;95;127;81;78;83;116;78;105;158 03:09:30 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;83;88;84;87;85;88;84;86;83 03:09:30 INFO - PROCESS | 1677 | |6;imaging-darkroom;132;150;93;93;92;92;92;93;92;92 03:09:30 INFO - PROCESS | 1677 | |7;imaging-desaturate;84;85;86;90;87;84;85;84;85;80 03:09:30 INFO - PROCESS | 1677 | |8;json-parse-financial;56;59;58;58;59;58;58;70;52;54 03:09:30 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;64;61;69;70;74;70;66;65;66;67 03:09:30 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;81;81;80;82;93;104;99;80;80;85 03:09:30 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;130;118;121;125;127;131;113;133;131;140 03:09:30 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;133;119;135;134;134;123;134;131;133;136 03:09:30 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;65;65;66;67;65;65;66;64;64 03:09:30 INFO - PROCESS | 1677 | __end_tp_report 03:09:30 INFO - PROCESS | 1677 | __start_cc_report 03:09:30 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1223 03:09:30 INFO - PROCESS | 1677 | __end_cc_report 03:09:30 INFO - PROCESS | 1677 | __startTimestamp1460369370545__endTimestamp 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | ------- Summary: start ------- 03:09:30 INFO - PROCESS | 1677 | Number of tests: 14 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.00 stddev:2.53 (2.3%) stddev-sans-first:2.65 03:09:30 INFO - PROCESS | 1677 | Values: 111.0 111.0 113.0 111.0 111.0 113.0 119.0 111.0 111.0 111.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:149.00 stddev:22.31 (15.0%) stddev-sans-first:23.40 03:09:30 INFO - PROCESS | 1677 | Values: 157.0 142.0 169.0 192.0 147.0 137.0 117.0 149.0 149.0 118.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:199.40 Median:193.00 stddev:25.65 (13.3%) stddev-sans-first:26.74 03:09:30 INFO - PROCESS | 1677 | Values: 186.0 183.0 183.0 198.0 264.0 199.0 186.0 185.0 188.0 222.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:75.20 Median:58.50 stddev:25.29 (43.2%) stddev-sans-first:26.82 03:09:30 INFO - PROCESS | 1677 | Values: 74.0 75.0 75.0 115.0 56.0 57.0 59.0 58.0 126.0 57.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:79.50 stddev:26.04 (32.8%) stddev-sans-first:27.31 03:09:30 INFO - PROCESS | 1677 | Values: 90.0 95.0 127.0 81.0 78.0 83.0 116.0 78.0 105.0 158.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.96 (2.3%) stddev-sans-first:2.00 03:09:30 INFO - PROCESS | 1677 | Values: 87.0 83.0 88.0 84.0 87.0 85.0 88.0 84.0 86.0 83.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:92.00 stddev:20.94 (22.8%) stddev-sans-first:19.21 03:09:30 INFO - PROCESS | 1677 | Values: 132.0 150.0 93.0 93.0 92.0 92.0 92.0 93.0 92.0 92.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:2.54 (3.0%) stddev-sans-first:2.67 03:09:30 INFO - PROCESS | 1677 | Values: 84.0 85.0 86.0 90.0 87.0 84.0 85.0 84.0 85.0 80.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:4.73 (8.2%) stddev-sans-first:4.95 03:09:30 INFO - PROCESS | 1677 | Values: 56.0 59.0 58.0 58.0 59.0 58.0 58.0 70.0 52.0 54.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:68.00 stddev:3.68 (5.4%) stddev-sans-first:3.71 03:09:30 INFO - PROCESS | 1677 | Values: 64.0 61.0 69.0 70.0 74.0 70.0 66.0 65.0 66.0 67.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:81.50 stddev:8.91 (10.9%) stddev-sans-first:9.23 03:09:30 INFO - PROCESS | 1677 | Values: 81.0 81.0 80.0 82.0 93.0 104.0 99.0 80.0 80.0 85.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:130.50 stddev:7.91 (6.1%) stddev-sans-first:8.31 03:09:30 INFO - PROCESS | 1677 | Values: 130.0 118.0 121.0 125.0 127.0 131.0 113.0 133.0 131.0 140.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.20 Median:134.00 stddev:5.61 (4.2%) stddev-sans-first:5.92 03:09:30 INFO - PROCESS | 1677 | Values: 133.0 119.0 135.0 134.0 134.0 123.0 134.0 131.0 133.0 136.0 03:09:30 INFO - PROCESS | 1677 | 03:09:30 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.27 (1.9%) stddev-sans-first:0.97 03:09:30 INFO - PROCESS | 1677 | Values: 68.0 65.0 65.0 66.0 67.0 65.0 65.0 66.0 64.0 64.0 03:09:30 INFO - PROCESS | 1677 | -------- Summary: end -------- 03:09:30 INFO - PROCESS | 1677 | 03:09:31 INFO - TEST-INFO | 1677: exit 0 03:09:31 INFO - TEST-OK | kraken | took 56629ms 03:09:31 INFO - SUITE-END | took 1169s 03:09:31 INFO - Completed test suite (00:19:30) 03:09:31 INFO - javascript benchmark 03:09:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.081707938856, 3529.0118766745322, 3538.769979951302, 3539.433690609503, 3594.370985077612, 5779.508741756945, 5814.186013958044, 5815.156802263669, 5817.01110811162, 5849.064149736043, 5748.367679555246, 5808.2158908547335, 5811.6803575803315, 5811.98290299197, 5826.796062137826, 5118.411382691001, 5184.11869982104, 5201.427842937273, 5227.607929405291, 5271.683698978073, 5174.404943431516, 5190.429052804188, 5192.71440070796, 5199.038177937094, 5199.168133098705, 4507.391502147218, 5193.792248310063, 5234.528892399683, 5285.0, 5304.336957880265, 4407.735535867826, 5230.163173892178, 5330.1205301125265, 5333.413324534298, 5355.705436201008, 5015.272785446126, 5173.068847607429, 5198.870028249286, 5212.635115541913, 5245.554127899133, 5653.265075540195, 5693.402192769782, 5710.086386178192, 5719.428057194289, 5727.770889164429, 6141.731496609858, 6336.58812177207, 6338.429541341256, 6340.587861788969, 6342.334054924213, 6224.595401298901, 6273.215848018997, 6279.466245369149, 6297.307296197415, 6304.1804565406665, 5805.216295800055, 5816.447437493473, 5818.185454036438, 5829.970850145722, 5935.940640593625, 6364.49084073273, 6398.648074355862, 6408.51936104794, 6414.102025716404, 6419.293877673452, 6169.383061693885, 6210.223722034746, 6227.06594010893, 6272.874542509216, 6280.246370435486, 6157.507399408037, 6252.437280644764, 6291.653959032297, 6307.306196318401, 6318.6524741138755, 6278.780242691484, 6312.621242725451, 6316.9368306317265, 6320.936790632127, 6324.083007963912, 6278.277998030285, 6316.589421687576, 6340.3342649022115, 6340.492760579143, 6349.650769207646, 4857.975710121426, 4910.337104490919, 4943.184374578226, 4944.283078953532, 4950.653454258239, 4391.538888416734, 4420.933685994648, 4429.82280708768, 4432.3794668746405, 4450.910981780346, 5821.243238378984, 5835.270591176103, 5843.094320380348, 5848.766049358063, 5850.619709718854, 6223.471004964629, 6262.812115636538, 6305.621662700252, 6310.842228944313, 6323.841903952438, 5788.5369170466265, 5793.797217097465, 5805.129230615442, 5815.069588865846, 5836.037053886146, 5382.085045542267, 5397.7571009304675, 5399.055165346049, 5412.56699464042, 5415.620906536505, 5989.0, 6289.622622642656, 6381.1066450696935, 6436.645984470899, 6486.254080780582, 5199.870003249949, 6301.3657765335265, 6323.241211054703, 6334.588251763621, 6349.714262858275, 6220.626762394271, 6359.777407790705, 6383.680815959091, 6410.45511131559, 6413.903791443226, 6145.66198859067, 6237.064440333987, 6245.5628106033955, 6270.0, 6272.372762723691, 6284.088807123033, 6311.936880631135, 6319.178506794087, 6319.494440444845, 6321.051842223703, 6038.426349496791, 6038.9396106038375, 6216.0, 6226.097215903759, 6234.812955611157, 6153.876922461615, 6198.163247961648, 6208.503319734501, 6218.595791273553, 6230.563860529719, 6040.75836966534, 6064.666443345482, 6075.362086980804, 6086.6652334122045, 6116.602420842631, 5957.0, 6053.545984051302, 6131.754729810936, 6171.84570385744, 6173.475254603409, 5805.448482394166, 5933.881322373615, 5982.46157845796, 6071.119687645355, 6097.2683278006925], "unit": "score", "name": "dojo.html", "value": 5748.899948004931}, {"lowerIsBetter": false, "replicates": [466.5357968821024, 548.9520634058055, 562.4572287742328, 598.4344794169509, 664.1664710787959, 31388.529172062408, 31898.521522177158, 31905.04284871452, 39830.0, 40481.0, 43300.78349608248, 43500.3474947876, 43665.0, 43706.12587748243, 43717.0, 9500.429974201536, 9731.708048758514, 9740.0, 9743.123118919295, 9752.65865694701, 9469.621215151386, 9621.470819104947, 9628.037196280351, 9628.22974162069, 9667.806643867154, 9575.42547447152, 9663.468509231989, 9678.419294842297, 9811.607535698564, 9813.362131461468, 9728.513574321256, 9815.705528834074, 9815.705528834147, 9825.70522884311, 9826.80346393068, 9594.90405095947, 9690.75773105678, 9710.271729620306, 9711.854322185172, 9724.0, 42011.73964781062, 42682.0, 42693.1461370774, 42733.931651708954, 42839.357409638884, 3200.0, 3347.8493467794005, 3395.7962522248745, 3454.5336379588935, 3756.323861704892, 29515.85242073776, 29556.26109347262, 29909.0, 30000.8499957501, 30180.94366697177, 2735.8084934054623, 2746.533089374811, 2781.415902660444, 2784.8050636455455, 2827.2507785436874, 481862.0, 488093.0, 488922.0, 489164.0, 490525.0, 60397.0, 73163.0, 73610.63194683992, 73692.26307736961, 73740.0, 65659.68680626457, 72777.54444911072, 76647.0, 77192.0, 77211.43702785326, 18434.262629494937, 18587.0, 18686.906565467085, 18723.438296851116, 18744.81255187458, 13849.0, 13968.301584920713, 13971.650708732363, 13998.650033749238, 14048.648783780283, 22180.778192218193, 22663.433414164447, 22690.43273918165, 22692.546149076927, 22700.545989080456, 8972.237359824489, 9180.036096209802, 9183.311251656152, 9200.30997675177, 9230.769230769285, 877.3332267476763, 1003.1924300937669, 1014.3102690170755, 1082.1613249731522, 1201.627495476405, 28335.008274710286, 28385.57421638677, 28731.56902646462, 28784.42431151407, 28967.56548651772, 780.679921232292, 1200.8378868852592, 1212.7877621416217, 1232.9704696578278, 1249.9125061245625, 13628.591142265748, 15975.920120399556, 16781.328746849988, 16914.323427063027, 16933.238004289837, 648387.7580612067, 661090.0, 661188.0, 661190.0, 662420.0, 56388.0, 64993.350066499675, 65038.34961650417, 65049.67475162594, 65060.0, 1437.4896911596443, 1519.118911031599, 1560.6722588256594, 1589.6582234819568, 1591.9761203581957, 24709.752902470744, 28558.286042849097, 29736.0, 29979.250518737204, 30332.54501182528, 47400.0, 47784.04431911412, 47967.28049079336, 48050.27924581064, 48241.75879120723, 337817.0, 339490.0, 339865.5033624179, 340157.0, 340768.29615852755, 29840.0, 32371.838140810087, 34556.30887382288, 35064.29871402609, 35192.472112917814, 33828.0, 42679.14641707211, 42687.93280168021, 44110.0, 44383.55616443794, 35832.64167358293, 35910.92267231987, 36021.63978360183, 36059.63940360563, 36782.44826327554, 35649.0, 35747.57009719582, 36020.919372418866, 36412.635873640924, 37680.43479347867, 36215.27569448543, 36799.44800828043, 37154.07114822151, 37769.244615108095, 37810.43284350792, 33345.49981750227, 34847.9545613632, 35356.64643353534, 35695.64304356923, 35796.284074317846, 20697.58604827865, 24699.0, 24725.50548989046, 25156.496870062863, 25534.744652553236], "unit": "score", "name": "ext.html", "value": 20289.626824011873}, {"lowerIsBetter": false, "replicates": [369.5731430198121, 377.57145639698945, 377.6072884200432, 379.20556434270196, 384.4291227527124, 20613.484662883435, 20889.0, 21060.789392106075, 21331.25340613079, 21353.679694804552, 12170.269783812955, 12670.366481675925, 12746.553870614507, 12755.298458584797, 12785.0, 4781.593564547018, 6179.907301390483, 6185.536084793636, 6192.0402337637515, 6195.721192546323, 6051.727672254759, 6073.058675905242, 6137.9079313810325, 6170.167027451282, 6172.1667574877265, 5831.708414579275, 6006.609570377911, 6020.819375418744, 6027.698615069251, 6087.360827113133, 5501.587380946445, 5986.97006514969, 5994.790182343619, 6005.459508644221, 6005.789797357093, 4487.259602165639, 5163.432022477525, 5323.813666521692, 5324.148136298212, 5336.0, 13921.30393480332, 14205.857941420556, 14207.289635518286, 14304.57086287413, 14523.419063237458, 1983.464464594566, 2102.9579408411746, 2223.0, 2356.929292121239, 2357.26924653358, 9881.357711748786, 9934.900650993543, 10425.947870260676, 10653.307535010199, 10683.252172347939, 1740.5735594779233, 1748.589081565831, 1774.645070985808, 1828.698264786322, 1893.9621207575772, 71293.0, 108637.45681271622, 110939.0, 111349.0, 112229.43885280521, 11695.0, 11735.295882247092, 11741.119416043832, 11746.060315174765, 11850.940745296391, 13252.73494530104, 14634.0, 14780.48268310604, 14794.408223670933, 14796.260186990607, 8511.616977236039, 8971.147740964598, 8977.0, 9018.278537716968, 9096.454212747256, 7096.858062838817, 9212.723618291462, 9225.40034897743, 9304.488253146143, 9325.300602454843, 4627.930581041287, 4638.907221855544, 4639.9536004640195, 4642.51253618372, 4700.9059818803435, 1644.0957473389587, 1718.518814731877, 1882.3223639489772, 1906.428071578521, 1962.3818497173345, 942.8868535775614, 1022.9897701023043, 1040.1314902056868, 1078.4176544665793, 1094.7865166292656, 20325.89837050835, 21132.0, 21196.576068478545, 21456.678149827763, 21488.78511214868, 962.7208109648263, 1000.2298230362726, 1001.1240164855751, 1005.1757558801859, 1013.5894962540183, 11195.888041119648, 11250.423585225386, 11336.206465547497, 11356.716082098013, 11531.1351648625, 623884.0, 631661.0, 633162.0, 643558.0, 645295.0, 113836.0, 114300.85593152694, 115969.42015289869, 120881.0, 123622.0, 1031.2420371027438, 1032.2722480651273, 1042.890496497872, 1044.216837371971, 1068.7381591509975, 18120.199050665997, 18450.169742361893, 18647.44057678272, 18742.34401795985, 18840.52898677544, 51234.0, 52236.55419784811, 52862.0, 53095.0, 55003.724981374835, 74531.0, 74779.25220747941, 74920.87618685832, 76971.61514192393, 78731.0, 8020.558869262247, 8353.95823020881, 8499.447535910145, 8502.149785021697, 8515.74452766418, 8113.959430202811, 10438.642976413017, 12138.878611213775, 13296.0, 13729.931350343184, 11340.829887551528, 11571.6528504145, 11914.463849126636, 11948.283103013848, 11954.940225299166, 11198.776024479628, 11295.265807722471, 11419.429028548373, 11743.530258789895, 11900.76198476043, 11515.5969541069, 11781.646550603497, 12019.21875078117, 12051.51793928233, 12145.45345459474, 8263.256306932404, 8272.296854767412, 8414.410991230556, 8483.575821208791, 8551.047570623128, 8669.176428239307, 11057.834132487858, 11765.0, 11991.280523168638, 12073.879261207276], "unit": "score", "name": "jquery.html", "value": 9364.017970005401}, {"lowerIsBetter": false, "replicates": [1472.4331132513978, 1621.6189195539046, 1640.6144556029335, 1954.0425191656084, 2052.3124753207667, 8144.470609410391, 8636.956815215923, 8767.16711912369, 8777.956110219457, 8779.868301975475, 8138.470999385051, 8853.645854165825, 8856.911430885706, 8867.201951824334, 8884.777880552989, 2142.453674313048, 2212.811910987568, 2276.0781883337277, 2278.7493375728654, 2401.5470640262606, 2324.418895276181, 2483.205374280231, 2544.096845619806, 2544.8345857519294, 2547.630593563932, 2444.3889027743066, 2474.3319303787966, 2525.4696513732138, 2540.834845735021, 2544.134994102005, 2258.864468131901, 2423.4183795889035, 2428.672129262545, 2428.8178386620984, 2434.7808697217333, 2480.516299321633, 2506.9749302507107, 2513.54756143894, 2517.710463296726, 2522.8864701088496, 8885.155910188521, 8944.01615822259, 8950.910490895072, 8961.865572016424, 8976.640934362618, 5526.447355264481, 5619.9603073431135, 5623.775048998035, 5672.4611161939965, 5680.517156041741, 3167.952480712791, 3554.928901421957, 3634.254977729559, 3734.159814041846, 3742.176721121376, 1049.6326285799985, 1052.847337136111, 1069.6416700405373, 1082.5020490574345, 1092.1153865369076, 12041.976432003377, 12109.39453027354, 12143.93928030363, 12155.453004614814, 12187.51249950001, 4854.975725121351, 4968.701877887338, 4999.825006124841, 5017.347744793226, 5048.343715316985, 10144.934781847947, 10232.437215953045, 10250.897491024994, 10261.179105671677, 10272.33229840058, 5590.5248053915875, 5618.550515958714, 5632.831015069554, 5635.718214089279, 5635.746391412396, 4481.932771008437, 4518.909621807546, 5070.4929507049, 5073.594112470993, 5088.669236499616, 3343.36476069546, 3918.4122381642983, 4001.599840015975, 4017.879463616096, 4042.8989275268355, 1064.4890452582804, 1224.7611715715527, 1226.8466441694789, 1240.8821161989597, 1243.0614885761192, 956.2875657635107, 1143.2168964259508, 1145.8395824584566, 1301.1412467771227, 1429.814124163852, 8285.792855178548, 8347.749567512985, 8373.958130209432, 8383.874241886255, 8462.957685211535, 518.7561845932406, 519.7583123847429, 522.3575002746567, 523.657004661947, 532.3585079978617, 6239.968800156061, 6249.406306400884, 6275.0, 6313.96843015782, 6322.683865806691, 10360.274780765274, 10747.462626868626, 10804.0, 10815.945920270347, 10815.945920270506, 10357.171426285879, 10550.261481696361, 10618.36289822613, 10681.62614308511, 10774.299670521392, 8366.414350995372, 8448.57757112142, 8455.66177352899, 8505.404621676424, 8535.615897284637, 7948.443608947318, 8034.196580341919, 8034.397420193626, 8056.476329038594, 8094.433389662667, 8812.603432845666, 9379.577918993526, 9759.0, 9832.115109640166, 9843.507824608883, 9915.355501892354, 10103.989601039837, 10197.388156710622, 10333.793324133625, 10360.378377297386, 6664.50016248793, 6859.622720750406, 7520.398368130646, 7694.461387703031, 7766.728164514215, 8346.833063338821, 8365.330773538224, 8386.832263354576, 8391.874121888055, 8396.538190399586, 7353.485256032026, 7399.48203625741, 7414.221506741715, 7542.132654744774, 7568.697252110074, 7273.054502914587, 7299.124105107421, 7323.414126869731, 7370.926290737239, 7421.8144546386775, 7799.376049916106, 7831.84336313282, 7853.882191767242, 7859.646315915683, 7873.25204105609, 6767.492438067066, 6940.548864323803, 7047.260037696173, 7103.183133939457, 7115.857682846417, 7174.533655312388, 7252.854942901007, 7257.310555497219, 7261.3101755333155, 7262.491625586158], "unit": "score", "name": "mootools.html", "value": 4866.11547456175}, {"lowerIsBetter": false, "replicates": [332.8485539079719, 335.44651325313237, 344.2753004924635, 345.2542508182326, 349.20555735701294, 6448.45188159007, 6500.447461965733, 6575.243846957601, 6592.044153597725, 6624.436922861562, 6552.803415897519, 6556.606603603787, 6559.21289445266, 6578.934210657892, 6584.473242140629, 4621.676482646216, 4695.929561056587, 4709.387779588648, 4713.740744259065, 4915.655904086707, 4716.646251531131, 4718.7168769873915, 4722.929156062662, 4798.640101992347, 4842.539958703917, 4830.299606557047, 4832.71003739775, 4832.855014349558, 4833.0, 4848.812041049948, 4820.035992801454, 4824.517548245182, 4834.806607735686, 4844.709317440965, 4845.951540484603, 3942.467766851467, 4050.6151915567975, 4153.605407486284, 4208.473940757405, 4211.936820947688, 4976.552110310089, 6305.68471576424, 6305.779297724604, 6351.460125889305, 6371.108044873721, 5707.086866101446, 5741.3110426748635, 5749.453801888856, 5749.482546570787, 5754.108113242454, 6970.0, 6994.930050699479, 6998.580085194853, 7019.82450438738, 7023.52505973741, 4538.1377538267625, 4692.507286734912, 4709.152352576535, 4718.693284936468, 4724.078804633098, 7369.336759691653, 7404.444666649969, 7408.407327413848, 7411.88882166768, 7420.0, 4800.231962885991, 4845.370101886732, 4854.514548545118, 4854.951450485521, 4863.2461968394955, 4935.988122434892, 4938.765308672831, 4944.480829512921, 4944.678595891256, 4952.20764677657, 5579.191017302468, 5649.745761440745, 5756.5682573807135, 5766.798162064308, 5783.161441590946, 6787.93212067873, 7020.192677842011, 7046.224915259318, 7048.753293634698, 7050.365467107985, 1648.5054483654856, 1686.6626674665115, 1700.2773821125973, 1703.335699077361, 1703.7274036154156, 916.757059379265, 1088.5972190289644, 1102.8014957307762, 1104.9779004419865, 1126.3467189030343, 5177.249298851645, 5329.653572517774, 6100.0, 6541.803745887631, 6544.116544266463, 7173.748918787817, 7185.281471852877, 7194.028806111212, 7197.568145911262, 7342.669579868919, 6623.337666233435, 6625.7680981166395, 6629.9337006630285, 6633.701483433257, 6635.933640663531, 3817.866374676873, 3852.6339997700175, 3866.7293289469467, 3876.4960555127655, 3887.552931412867, 7281.0, 7644.120926093459, 7644.388448924073, 7668.118166410823, 7673.808154796175, 7438.702451901863, 7469.9831045617375, 7528.021357223526, 7531.133919599316, 7531.472796904164, 7601.619919003917, 7611.2769286917655, 7618.809529761689, 7626.275503827128, 7643.121041080236, 7273.781786546412, 7288.708451661874, 7301.0, 7308.780736577911, 7318.938753880551, 6838.794836154724, 7166.0, 7172.820679483055, 7173.497855150298, 7176.210616832249, 7563.621818909142, 7602.46782725204, 7615.086189657277, 7617.9619101906355, 7623.618819058914, 4639.420072490939, 4689.507601701908, 4700.177468942853, 4705.64707646921, 4707.105649926503, 7292.234315396807, 7294.307040831112, 7304.160021597584, 7317.341439270278, 7323.963380183065, 6678.599284042973, 6944.270851560514, 6948.722051117898, 7055.753048643272, 7073.186583542958, 6958.130233720785, 7002.334778196063, 7009.334113259232, 7010.789676309719, 7015.123109611299, 5205.297284866495, 5701.287339082614, 6816.522843400914, 6819.420349270367, 6847.62338071391, 6977.581345119309, 6997.545159564612, 6998.965005174941, 7013.438924885895, 7022.54353467023, 6565.606063636197, 6580.670966451563, 6858.3827455529245, 6877.931220687929, 6907.654617269016], "unit": "score", "name": "prototype.html", "value": 5152.52596725833}, {"lowerIsBetter": false, "replicates": [692.8926016467447, 751.3913729878799, 752.1350446985965, 761.4821921093654, 762.8893810397489, 15107.773383399257, 15372.154531500762, 15398.0, 15403.691926161484, 18337.724934126, 16914.915425422885, 16924.576885577837, 16989.405370812023, 17002.82997170028, 17009.744853827204, 798.9400794940374, 814.287498438866, 964.6237967192783, 998.7103739915416, 999.9800003999916, 853.1894700034992, 982.1798798003675, 982.8329184038695, 983.0022527134963, 988.6737376665719, 1035.404642330659, 1047.08903254169, 1047.9266451348408, 1048.7378155461136, 1049.3022140276707, 830.6345208108443, 994.6866736977829, 1021.2442792333694, 1022.3456987527989, 1031.6079889641962, 768.9577073261024, 770.0682174568778, 770.6609091999502, 771.3405038691893, 773.2924374197603, 15758.606034849106, 15854.365825366971, 15885.523434296989, 15893.761593576106, 15913.681726365408, 12726.618201453972, 12751.42618582166, 12810.80783788244, 13020.47918083285, 13053.086283960127, 10252.128569071638, 10276.588936442533, 10340.069393754598, 10464.42445665488, 10664.946675266652, 3427.9143021424666, 3527.753057285991, 3530.9646903531147, 3534.8762793302367, 3617.222297206113, 90654.09345906522, 91669.54165229198, 91714.16571668597, 92105.07894921032, 92132.53933730355, 9556.283278754121, 9592.280578956606, 9613.615455381847, 9680.080392362714, 10030.799384012278, 21598.24406145809, 21880.23419180321, 21882.78117218839, 21898.89050554769, 22377.888110559343, 7572.129205141479, 7730.690772369155, 7757.069151701719, 7964.402669799672, 8007.439479236397, 4044.656204222615, 4054.5337286211875, 4108.055147316134, 4157.97921010399, 4159.085001299709, 3722.0, 3751.3435148848844, 3768.246350729865, 3776.2825063237897, 3780.1872597391143, 596.4214711729616, 654.509118161379, 669.6885948034187, 676.2594958520413, 696.0637941968045, 460.5555638808499, 537.3444397834636, 568.766805609698, 603.9124326972652, 631.538976547114, 7842.215778422112, 8186.959065204635, 8306.460080094774, 8388.8741668875, 8396.496210227406, 593.1636392686291, 604.6281536854802, 609.2780055634088, 618.5484596244677, 624.1636207481905, 3870.4774855394726, 3939.330313846653, 3940.310445671996, 3971.0866500704424, 4014.6186112319283, 91490.54254728684, 92727.0, 93013.60479592811, 93249.60125598121, 95876.0, 83687.5815620918, 83853.58073209594, 83905.58047209847, 86194.56902715571, 88429.0, 64831.0, 65971.0, 67128.32871671318, 67369.66315168393, 67459.0, 8568.57157142153, 8653.437526560754, 8766.561671916506, 8837.911620883966, 8968.955155224183, 43844.90387740332, 46640.7667961658, 46977.76511117422, 47571.28643070287, 49749.502504975935, 51890.48109518857, 62058.75882482415, 65950.67024664846, 65987.34012659812, 67353.32646673471, 9821.57587149845, 10807.405592692163, 11075.113990880549, 11295.604653837076, 11459.31244125355, 11206.775864482828, 11723.472443740222, 11769.764604708029, 12062.939685301517, 12471.5011399543, 11649.59226427071, 11696.590619328283, 11723.120765942418, 11867.397901283217, 12013.519459221534, 10404.947975260075, 10690.89309106899, 10824.0, 11293.71765705864, 11466.2546934449, 10670.860266796213, 10987.39569323695, 11235.494402751732, 11391.145664075393, 11628.6511404658, 9501.667441639509, 9829.4102353859, 9848.852267215854, 9966.0, 10231.976802319708, 9425.481598512148, 9838.311318207656, 9868.0, 9889.357191782512, 10042.447665378475], "unit": "score", "name": "yui.html", "value": 7100.909075685433}], "name": "dromaeo_css", "value": 7611.651211237652}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 113.0, 111.0, 111.0, 113.0, 119.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [157.0, 142.0, 169.0, 192.0, 147.0, 137.0, 117.0, 149.0, 149.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 183.0, 198.0, 264.0, 199.0, 186.0, 185.0, 188.0, 222.0], "unit": "score", "name": "audio-dft", "value": 199.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 75.0, 115.0, 56.0, 57.0, 59.0, 58.0, 126.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.2}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 127.0, 81.0, 78.0, 83.0, 116.0, 78.0, 105.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 101.1}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 88.0, 84.0, 87.0, 85.0, 88.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.5}, {"lowerIsBetter": true, "replicates": [132.0, 150.0, 93.0, 93.0, 92.0, 92.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 102.1}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 90.0, 87.0, 84.0, 85.0, 84.0, 85.0, 80.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 70.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 69.0, 70.0, 74.0, 70.0, 66.0, 65.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 80.0, 82.0, 93.0, 104.0, 99.0, 80.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [130.0, 118.0, 121.0, 125.0, 127.0, 131.0, 113.0, 133.0, 131.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [133.0, 119.0, 135.0, 134.0, 134.0, 123.0, 134.0, 131.0, 133.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.2}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0, 66.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1443.7000000000003}]} 03:09:31 INFO - Return code: 0 03:09:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:09:31 INFO - # TBPL SUCCESS # 03:09:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:31 INFO - 2016-04-11 03:09:31.842 screenresolution[1681:9692] starting screenresolution argv=screenresolution get 03:09:31 INFO - 2016-04-11 03:09:31.844 screenresolution[1681:9692] Display 0: 1600x1200x32@60 03:09:31 INFO - 2016-04-11 03:09:31.850 screenresolution[1682:9695] starting screenresolution argv=screenresolution list 03:09:31 INFO - Available Modes on Display 0 03:09:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:32 INFO - Intel Iris: 03:09:32 INFO - Chipset Model: Intel Iris 03:09:32 INFO - Type: GPU 03:09:32 INFO - Bus: Built-In 03:09:32 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:32 INFO - Vendor: Intel (0x8086) 03:09:32 INFO - Device ID: 0x0a2e 03:09:32 INFO - Revision ID: 0x0009 03:09:32 INFO - Displays: 03:09:32 INFO - Display: 03:09:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:32 INFO - Display Serial Number: 1600x1200 60 03:09:32 INFO - Main Display: Yes 03:09:32 INFO - Mirror: Off 03:09:32 INFO - Online: Yes 03:09:32 INFO - Rotation: Supported 03:09:32 INFO - Return code: 0 03:09:32 INFO - Running post-action listener: _resource_record_post_action 03:09:32 INFO - Running post-run listener: _resource_record_post_run 03:09:33 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 37541376; Write bytes: 663452160; Read time: 395; Write time: 1871 03:09:33 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361720320; Write bytes: 361719296; Read time: 28175; Write time: 642 03:09:33 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35718656; Write bytes: 298951680; Read time: 375; Write time: 1220 03:09:33 INFO - Running post-run listener: _upload_blobber_files 03:09:33 INFO - Blob upload gear active. 03:09:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:33 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 03:09:33 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:33 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:35 INFO - (blobuploader) - INFO - Done attempting. 03:09:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:09:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:36 INFO - (blobuploader) - INFO - Done attempting. 03:09:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:36 INFO - Return code: 0 03:09:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a987505dbdc2b177c56ad6439709a94200e4a897534142b2d248cb5fbdb29741e172b89fc8ba73aaca5e6132db0f297098439be2076aab5c2e826848e7f6f69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ff7b4a0e8f940503ee83b4e3eaf1d71aa234ade2f3eace3486e78929aca200ac1efc2d2b6813fce3e11b4d9b9ac97df16b045e131999a7cb24f168e37e47ee"} 03:09:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:36 INFO - Contents: 03:09:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a987505dbdc2b177c56ad6439709a94200e4a897534142b2d248cb5fbdb29741e172b89fc8ba73aaca5e6132db0f297098439be2076aab5c2e826848e7f6f69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ff7b4a0e8f940503ee83b4e3eaf1d71aa234ade2f3eace3486e78929aca200ac1efc2d2b6813fce3e11b4d9b9ac97df16b045e131999a7cb24f168e37e47ee"} 03:09:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:36 INFO - Copying logs to upload dir... 03:09:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.271080 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-11 03:09:36.318682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 03:09:36.322348) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a987505dbdc2b177c56ad6439709a94200e4a897534142b2d248cb5fbdb29741e172b89fc8ba73aaca5e6132db0f297098439be2076aab5c2e826848e7f6f69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ff7b4a0e8f940503ee83b4e3eaf1d71aa234ade2f3eace3486e78929aca200ac1efc2d2b6813fce3e11b4d9b9ac97df16b045e131999a7cb24f168e37e47ee"} build_url:https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/Cng_83zORk6s7iRh9ESgnQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a987505dbdc2b177c56ad6439709a94200e4a897534142b2d248cb5fbdb29741e172b89fc8ba73aaca5e6132db0f297098439be2076aab5c2e826848e7f6f69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3ff7b4a0e8f940503ee83b4e3eaf1d71aa234ade2f3eace3486e78929aca200ac1efc2d2b6813fce3e11b4d9b9ac97df16b045e131999a7cb24f168e37e47ee"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 03:09:36.785459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 03:09:36.785773) ========= 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.amspOvKY5p/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.f7yHnqmiXN/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 03:09:36.834331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 03:09:36.834626) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 03:09:36.834964) ========= ========= Total master_lag: 2.63 =========