builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0151 starttime: 1457743437.03 results: success (0) buildid: 20160311133331 builduid: 9d6c27f94a3e4ce08033b04189df27f9 revision: 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:57.028996) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:57.029421) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:57.029724) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005490 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:57.111458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-11 16:43:57.111778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-11 16:43:58.629969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.630366) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.006006 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.657112) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.657374) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.660716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.660997) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-11 16:43:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2016-03-11 16:43:58 (16.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.799308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.799616) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.025852 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 16:43:58.850993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 16:43:58.851300) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-11 16:43:58,929 truncating revision to first 12 chars 2016-03-11 16:43:58,929 Setting DEBUG logging. 2016-03-11 16:43:58,929 attempt 1/10 2016-03-11 16:43:58,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8c4c8f3f6379?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 16:44:00,142 unpacking tar archive at: fx-team-8c4c8f3f6379/testing/mozharness/ program finished with exit code 0 elapsedTime=1.462416 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 16:44:00.518371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 16:44:00.521722) ========= echo 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 program finished with exit code 0 elapsedTime=0.006320 script_repo_revision: '8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 16:44:00.547646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 16:44:00.547934) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 16:44:00.561541) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 16:44:00.561856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:00 INFO - MultiFileLogger online at 20160311 16:44:00 in /builds/slave/test 16:44:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:44:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:44:00 INFO - {'append_to_log': False, 16:44:00 INFO - 'base_work_dir': '/builds/slave/test', 16:44:00 INFO - 'blob_upload_branch': 'Fx-Team', 16:44:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:44:00 INFO - 'branch': 'Fx-Team', 16:44:00 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:00 INFO - 'config_files': ('talos/mac_config.py',), 16:44:00 INFO - 'default_actions': ('clobber', 16:44:00 INFO - 'read-buildbot-config', 16:44:00 INFO - 'download-and-extract', 16:44:00 INFO - 'populate-webroot', 16:44:00 INFO - 'create-virtualenv', 16:44:00 INFO - 'install', 16:44:00 INFO - 'run-tests'), 16:44:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:00 INFO - 'download_minidump_stackwalk': True, 16:44:00 INFO - 'download_symbols': 'ondemand', 16:44:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:00 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:00 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:00 INFO - 'installer_path': 'installer.exe', 16:44:00 INFO - 'log_level': 'info', 16:44:00 INFO - 'log_name': 'talos', 16:44:00 INFO - 'log_to_console': True, 16:44:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:44:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:44:00 INFO - 'opt_config_files': (), 16:44:00 INFO - 'pip_index': False, 16:44:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:44:00 INFO - 'cmd': ('bash', 16:44:00 INFO - '-c', 16:44:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:44:00 INFO - 'enabled': True, 16:44:00 INFO - 'halt_on_failure': False, 16:44:00 INFO - 'name': 'check_screen_resolution'},), 16:44:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:44:00 INFO - 'cmd': ('bash', 16:44:00 INFO - '-c', 16:44:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:44:00 INFO - 'enabled': True, 16:44:00 INFO - 'halt_on_failure': False, 16:44:00 INFO - 'name': 'check_screen_resolution'},), 16:44:00 INFO - 'run_cmd_checks_enabled': True, 16:44:00 INFO - 'sps_profile': False, 16:44:00 INFO - 'sps_profile_interval': 0, 16:44:00 INFO - 'suite': 'dromaeojs-e10s', 16:44:00 INFO - 'system_bits': '32', 16:44:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:00 INFO - 'title': 't-yosemite-r7-0151', 16:44:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:00 INFO - 'use_talos_json': True, 16:44:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:44:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:00 INFO - 'work_dir': 'build'} 16:44:00 INFO - ##### 16:44:00 INFO - ##### Running clobber step. 16:44:00 INFO - ##### 16:44:00 INFO - Running pre-action listener: _resource_record_pre_action 16:44:00 INFO - Running main action method: clobber 16:44:00 INFO - rmtree: /builds/slave/test/build 16:44:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:44:02 INFO - Running post-action listener: _resource_record_post_action 16:44:02 INFO - ##### 16:44:02 INFO - ##### Running read-buildbot-config step. 16:44:02 INFO - ##### 16:44:02 INFO - Running pre-action listener: _resource_record_pre_action 16:44:02 INFO - Running main action method: read_buildbot_config 16:44:02 INFO - Using buildbot properties: 16:44:02 INFO - { 16:44:02 INFO - "project": "", 16:44:02 INFO - "product": "firefox", 16:44:02 INFO - "script_repo_revision": "production", 16:44:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:44:02 INFO - "repository": "", 16:44:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:44:02 INFO - "buildid": "20160311133331", 16:44:02 INFO - "pgo_build": "False", 16:44:02 INFO - "basedir": "/builds/slave/test", 16:44:02 INFO - "buildnumber": 617, 16:44:02 INFO - "slavename": "t-yosemite-r7-0151", 16:44:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:44:02 INFO - "platform": "yosemite_r7", 16:44:02 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:44:02 INFO - "branch": "fx-team", 16:44:02 INFO - "repo_path": "integration/fx-team", 16:44:02 INFO - "revision": "8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78", 16:44:02 INFO - "stage_platform": "macosx64", 16:44:02 INFO - "builduid": "9d6c27f94a3e4ce08033b04189df27f9", 16:44:02 INFO - "slavebuilddir": "test" 16:44:02 INFO - } 16:44:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:44:02 INFO - Running post-action listener: _resource_record_post_action 16:44:02 INFO - ##### 16:44:02 INFO - ##### Running download-and-extract step. 16:44:02 INFO - ##### 16:44:02 INFO - Running pre-action listener: _resource_record_pre_action 16:44:02 INFO - Running main action method: download_and_extract 16:44:02 INFO - mkdir: /builds/slave/test/build/tests 16:44:02 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')]} 16:44:02 INFO - https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 16:44:03 INFO - Downloaded 1199 bytes. 16:44:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:44:03 INFO - Using the following test package requirements: 16:44:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:44:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:44:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:44:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'jsshell-mac.zip'], 16:44:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:44:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:44:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:44:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:44:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:44:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:44:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:44:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:44:03 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')]} 16:44:03 INFO - https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:44:04 INFO - Downloaded 17865099 bytes. 16:44:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:44:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:44:07 INFO - Return code: 0 16:44:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:07 INFO - https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:44:08 INFO - Downloaded 17865099 bytes. 16:44:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:44:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:44:12 INFO - Return code: 0 16:44:12 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')]} 16:44:12 INFO - https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:44:13 INFO - Downloaded 10845263 bytes. 16:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:44:14 INFO - Return code: 0 16:44: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')]} 16:44:14 INFO - https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 16:44:18 INFO - Downloaded 110999481 bytes. 16:44:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:44:18 INFO - mkdir: /builds/slave/test/properties 16:44:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:44:18 INFO - Writing to file /builds/slave/test/properties/build_url 16:44:18 INFO - Contents: 16:44:18 INFO - build_url:https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:44:18 INFO - Running post-action listener: _resource_record_post_action 16:44:18 INFO - Running post-action listener: set_extra_try_arguments 16:44:18 INFO - ##### 16:44:18 INFO - ##### Running populate-webroot step. 16:44:18 INFO - ##### 16:44:18 INFO - Running pre-action listener: _resource_record_pre_action 16:44:18 INFO - Running main action method: populate_webroot 16:44:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:18 INFO - '--tppagecycles', 16:44:18 INFO - '7'], 16:44:18 INFO - 'tests': ['tsvgm']}}, 16:44:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:44:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:44:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:44:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'tests': ['damp', 'tps']}, 16:44:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['damp', 'tps']}, 16:44:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:44:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:18 INFO - 'other': {'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'other_l64': {'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'other_nol64': {'tests': ['a11yr', 16:44:18 INFO - 'ts_paint', 16:44:18 INFO - 'tpaint', 16:44:18 INFO - 'sessionrestore', 16:44:18 INFO - 'sessionrestore_no_auto_restore', 16:44:18 INFO - 'tabpaint']}, 16:44:18 INFO - 'svgr': {'tests': ['tsvgx', 16:44:18 INFO - 'tsvgr_opacity', 16:44:18 INFO - 'tart', 16:44:18 INFO - 'tscrollx', 16:44:18 INFO - 'cart']}, 16:44:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['tsvgx', 16:44:18 INFO - 'tsvgr_opacity', 16:44:18 INFO - 'tart', 16:44:18 INFO - 'tscrollx', 16:44:18 INFO - 'cart']}, 16:44:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'tests': ['tp5o']}, 16:44:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'talos_options': ['--e10s'], 16:44:18 INFO - 'tests': ['tp5o']}, 16:44:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'talos_options': ['--xperf_path', 16:44:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:18 INFO - 'tests': ['tp5n']}, 16:44:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:18 INFO - 'talos_options': ['--e10s', 16:44:18 INFO - '--xperf_path', 16:44:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:18 INFO - 'tests': ['tp5n']}}, 16:44:18 INFO - 'talos.zip': {'path': '', 16:44:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:18 INFO - Running post-action listener: _resource_record_post_action 16:44:18 INFO - ##### 16:44:18 INFO - ##### Running create-virtualenv step. 16:44:18 INFO - ##### 16:44:18 INFO - Running pre-action listener: _resource_record_pre_action 16:44:18 INFO - Running main action method: create_virtualenv 16:44:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:44:18 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 16:44:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:44:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:18 INFO - Using real prefix '/tools/python27' 16:44:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:44:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:22 INFO - Installing pip.................done. 16:44:22 INFO - Return code: 0 16:44:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:22 INFO - 'HOME': '/Users/cltbld', 16:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:22 INFO - 'LOGNAME': 'cltbld', 16:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:22 INFO - 'MOZ_NO_REMOTE': '1', 16:44:22 INFO - 'NO_EM_RESTART': '1', 16:44:22 INFO - 'PAGER': '/bin/cat', 16:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:22 INFO - 'PWD': '/builds/slave/test', 16:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:22 INFO - 'SHELL': '/bin/bash', 16:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:22 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:22 INFO - 'USER': 'cltbld', 16:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:22 INFO - 'XPC_FLAGS': '0x0', 16:44:22 INFO - 'XPC_SERVICE_NAME': '0', 16:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:22 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 16:44:22 INFO - Cleaning up... 16:44:22 INFO - Return code: 0 16:44:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:44:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:22 INFO - 'HOME': '/Users/cltbld', 16:44:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:22 INFO - 'LOGNAME': 'cltbld', 16:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:22 INFO - 'MOZ_NO_REMOTE': '1', 16:44:22 INFO - 'NO_EM_RESTART': '1', 16:44:22 INFO - 'PAGER': '/bin/cat', 16:44:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:22 INFO - 'PWD': '/builds/slave/test', 16:44:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:22 INFO - 'SHELL': '/bin/bash', 16:44:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:22 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:22 INFO - 'USER': 'cltbld', 16:44:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:22 INFO - 'XPC_FLAGS': '0x0', 16:44:22 INFO - 'XPC_SERVICE_NAME': '0', 16:44:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:22 INFO - Downloading/unpacking psutil>=0.7.1 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:25 INFO - Installing collected packages: psutil 16:44:25 INFO - Running setup.py install for psutil 16:44:25 INFO - building 'psutil._psutil_osx' extension 16:44:25 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 16:44:26 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 16:44:26 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 16:44:26 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 16:44:26 INFO - building 'psutil._psutil_posix' extension 16:44:26 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 16:44:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:44:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:44:26 INFO - ^ 16:44:26 INFO - 1 warning generated. 16:44:26 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 16:44:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:26 INFO - Successfully installed psutil 16:44:26 INFO - Cleaning up... 16:44:26 INFO - Return code: 0 16:44:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:26 INFO - 'HOME': '/Users/cltbld', 16:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:26 INFO - 'LOGNAME': 'cltbld', 16:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:26 INFO - 'MOZ_NO_REMOTE': '1', 16:44:26 INFO - 'NO_EM_RESTART': '1', 16:44:26 INFO - 'PAGER': '/bin/cat', 16:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:26 INFO - 'PWD': '/builds/slave/test', 16:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:26 INFO - 'SHELL': '/bin/bash', 16:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:26 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:26 INFO - 'USER': 'cltbld', 16:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:26 INFO - 'XPC_FLAGS': '0x0', 16:44:26 INFO - 'XPC_SERVICE_NAME': '0', 16:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:44:29 INFO - Installing collected packages: mozsystemmonitor 16:44:29 INFO - Running setup.py install for mozsystemmonitor 16:44:29 INFO - Successfully installed mozsystemmonitor 16:44:29 INFO - Cleaning up... 16:44:29 INFO - Return code: 0 16:44:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:29 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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:29 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 16:44:29 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 16:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:29 INFO - 'HOME': '/Users/cltbld', 16:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:29 INFO - 'LOGNAME': 'cltbld', 16:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:29 INFO - 'MOZ_NO_REMOTE': '1', 16:44:29 INFO - 'NO_EM_RESTART': '1', 16:44:29 INFO - 'PAGER': '/bin/cat', 16:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:29 INFO - 'PWD': '/builds/slave/test', 16:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:29 INFO - 'SHELL': '/bin/bash', 16:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:29 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:29 INFO - 'USER': 'cltbld', 16:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:29 INFO - 'XPC_FLAGS': '0x0', 16:44:29 INFO - 'XPC_SERVICE_NAME': '0', 16:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:44:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:44:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:32 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 16:44:33 INFO - Downloading docopt-0.6.1.tar.gz 16:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:44:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:44:33 INFO - Running setup.py install for blobuploader 16:44:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:44:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:44:33 INFO - Running setup.py install for requests 16:44:34 INFO - Running setup.py install for docopt 16:44:34 INFO - Successfully installed blobuploader requests docopt 16:44:34 INFO - Cleaning up... 16:44:34 INFO - Return code: 0 16:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44: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')]} 16:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:34 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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:34 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 16:44:34 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 16:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:34 INFO - 'HOME': '/Users/cltbld', 16:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:34 INFO - 'LOGNAME': 'cltbld', 16:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:34 INFO - 'MOZ_NO_REMOTE': '1', 16:44:34 INFO - 'NO_EM_RESTART': '1', 16:44:34 INFO - 'PAGER': '/bin/cat', 16:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:34 INFO - 'PWD': '/builds/slave/test', 16:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:34 INFO - 'SHELL': '/bin/bash', 16:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:34 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:34 INFO - 'USER': 'cltbld', 16:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:34 INFO - 'XPC_FLAGS': '0x0', 16:44:34 INFO - 'XPC_SERVICE_NAME': '0', 16:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uZ5lD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-pZkRGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-SxvLi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-MBaqiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PebYUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-rpf0o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-cDOJnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-M1zrvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-oM91Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-a8CWh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ICLrNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-7ySqjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-giBETP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-McqhdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:36 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-f_2L8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:36 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-DpKgSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:36 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-7e_3Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:44:36 INFO - Running setup.py install for manifestparser 16:44:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:44:36 INFO - Running setup.py install for mozcrash 16:44:36 INFO - Running setup.py install for mozdebug 16:44:36 INFO - Running setup.py install for mozdevice 16:44:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:44:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:44:36 INFO - Running setup.py install for mozfile 16:44:37 INFO - Running setup.py install for mozhttpd 16:44:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Running setup.py install for mozinfo 16:44:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Running setup.py install for mozInstall 16:44:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Running setup.py install for mozleak 16:44:37 INFO - Running setup.py install for mozlog 16:44:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Running setup.py install for moznetwork 16:44:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:44:37 INFO - Running setup.py install for mozprocess 16:44:38 INFO - Running setup.py install for mozprofile 16:44:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:44:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:44:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:44:38 INFO - Running setup.py install for mozrunner 16:44:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:44:38 INFO - Running setup.py install for mozscreenshot 16:44:38 INFO - Running setup.py install for moztest 16:44:38 INFO - Running setup.py install for mozversion 16:44:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:44:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:44:38 INFO - Cleaning up... 16:44:38 INFO - Return code: 0 16:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:38 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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:38 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 16:44:38 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 16:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:38 INFO - 'HOME': '/Users/cltbld', 16:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:38 INFO - 'LOGNAME': 'cltbld', 16:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:38 INFO - 'MOZ_NO_REMOTE': '1', 16:44:38 INFO - 'NO_EM_RESTART': '1', 16:44:38 INFO - 'PAGER': '/bin/cat', 16:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:38 INFO - 'PWD': '/builds/slave/test', 16:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:38 INFO - 'SHELL': '/bin/bash', 16:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:38 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:38 INFO - 'USER': 'cltbld', 16:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:38 INFO - 'XPC_FLAGS': '0x0', 16:44:38 INFO - 'XPC_SERVICE_NAME': '0', 16:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-5kHKbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Ha88qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-kBlqB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-6gnhMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GrLOW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-2PIIxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Bm8dUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:44:39 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)) 16:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:44:39 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-aYPTAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-yU5uxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-o8Nh76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-KE0OPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-iL2wtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-NvEsiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-tpvnuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Bk0Fzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-WsggTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:40 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)) 16:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:40 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Qb4xxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:40 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)) 16:44:40 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)) 16:44:40 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)) 16:44:40 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)) 16:44:40 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)) 16:44:40 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)) 16:44:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:43 INFO - Downloading blessings-1.6.tar.gz 16:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:43 INFO - Installing collected packages: blessings 16:44:43 INFO - Running setup.py install for blessings 16:44:43 INFO - Successfully installed blessings 16:44:43 INFO - Cleaning up... 16:44:43 INFO - Return code: 0 16:44:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:44 INFO - Reading from file tmpfile_stdout 16:44:44 INFO - Current package versions: 16:44:44 INFO - blessings == 1.6 16:44:44 INFO - blobuploader == 1.2.4 16:44:44 INFO - docopt == 0.6.1 16:44:44 INFO - manifestparser == 1.1 16:44:44 INFO - mozInstall == 1.12 16:44:44 INFO - mozcrash == 0.17 16:44:44 INFO - mozdebug == 0.1 16:44:44 INFO - mozdevice == 0.48 16:44:44 INFO - mozfile == 1.2 16:44:44 INFO - mozhttpd == 0.7 16:44:44 INFO - mozinfo == 0.9 16:44:44 INFO - mozleak == 0.1 16:44:44 INFO - mozlog == 3.1 16:44:44 INFO - moznetwork == 0.27 16:44:44 INFO - mozprocess == 0.22 16:44:44 INFO - mozprofile == 0.28 16:44:44 INFO - mozrunner == 6.11 16:44:44 INFO - mozscreenshot == 0.1 16:44:44 INFO - mozsystemmonitor == 0.0 16:44:44 INFO - moztest == 0.7 16:44:44 INFO - mozversion == 1.4 16:44:44 INFO - psutil == 3.1.1 16:44:44 INFO - requests == 1.2.3 16:44:44 INFO - wsgiref == 0.1.2 16:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:44 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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:44 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 16:44:44 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 16:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:44 INFO - 'HOME': '/Users/cltbld', 16:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:44 INFO - 'LOGNAME': 'cltbld', 16:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:44 INFO - 'MOZ_NO_REMOTE': '1', 16:44:44 INFO - 'NO_EM_RESTART': '1', 16:44:44 INFO - 'PAGER': '/bin/cat', 16:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:44 INFO - 'PWD': '/builds/slave/test', 16:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:44 INFO - 'SHELL': '/bin/bash', 16:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:44 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:44 INFO - 'USER': 'cltbld', 16:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:44 INFO - 'XPC_FLAGS': '0x0', 16:44:44 INFO - 'XPC_SERVICE_NAME': '0', 16:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 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)) 16:44:44 INFO - Cleaning up... 16:44:44 INFO - Return code: 0 16:44:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:44 INFO - 'HOME': '/Users/cltbld', 16:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:44 INFO - 'LOGNAME': 'cltbld', 16:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:44 INFO - 'MOZ_NO_REMOTE': '1', 16:44:44 INFO - 'NO_EM_RESTART': '1', 16:44:44 INFO - 'PAGER': '/bin/cat', 16:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:44 INFO - 'PWD': '/builds/slave/test', 16:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:44 INFO - 'SHELL': '/bin/bash', 16:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:44 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:44 INFO - 'USER': 'cltbld', 16:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:44 INFO - 'XPC_FLAGS': '0x0', 16:44:44 INFO - 'XPC_SERVICE_NAME': '0', 16:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:44 INFO - Downloading/unpacking jsonschema 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:44:46 INFO - Downloading/unpacking functools32 (from jsonschema) 16:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:44:47 INFO - warning: no files found matching '*.txt' 16:44:47 INFO - no previously-included directories found matching 'build' 16:44:47 INFO - no previously-included directories found matching 'dist' 16:44:47 INFO - no previously-included directories found matching '.git*' 16:44:47 INFO - Installing collected packages: jsonschema, functools32 16:44:47 INFO - Running setup.py install for functools32 16:44:47 INFO - warning: no files found matching '*.txt' 16:44:47 INFO - no previously-included directories found matching 'build' 16:44:47 INFO - no previously-included directories found matching 'dist' 16:44:47 INFO - no previously-included directories found matching '.git*' 16:44:47 INFO - Successfully installed jsonschema functools32 16:44:47 INFO - Cleaning up... 16:44:47 INFO - Return code: 0 16:44:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:44:47 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')]} 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:47 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')]} 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:47 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 0x10cd09a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd104c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdbd95f00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, '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.9o84hIWGQc/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.xpNA1nM1c3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 16:44:47 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 16:44:47 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 16:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:44:47 INFO - 'HOME': '/Users/cltbld', 16:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:44:47 INFO - 'LOGNAME': 'cltbld', 16:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:47 INFO - 'MOZ_NO_REMOTE': '1', 16:44:47 INFO - 'NO_EM_RESTART': '1', 16:44:47 INFO - 'PAGER': '/bin/cat', 16:44:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:47 INFO - 'PWD': '/builds/slave/test', 16:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:44:47 INFO - 'SHELL': '/bin/bash', 16:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:44:47 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:44:47 INFO - 'USER': 'cltbld', 16:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:47 INFO - 'XPC_FLAGS': '0x0', 16:44:47 INFO - 'XPC_SERVICE_NAME': '0', 16:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:47 INFO - Downloading/unpacking flake8 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:44:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:44:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:50 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 16:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:51 INFO - no previously-included directories found matching 'docs/_build' 16:44:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:44:51 INFO - Running setup.py install for pep8 16:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:51 INFO - no previously-included directories found matching 'docs/_build' 16:44:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:44:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:44:51 INFO - Cleaning up... 16:44:51 INFO - Return code: 0 16:44:51 INFO - Running post-action listener: _resource_record_post_action 16:44:51 INFO - Running post-action listener: _start_resource_monitoring 16:44:51 INFO - Starting resource monitoring. 16:44:51 INFO - ##### 16:44:51 INFO - ##### Running install step. 16:44:51 INFO - ##### 16:44:51 INFO - Running pre-action listener: _resource_record_pre_action 16:44:51 INFO - Running main action method: install 16:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:52 INFO - Reading from file tmpfile_stdout 16:44:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:52 INFO - Reading from file tmpfile_stdout 16:44:52 INFO - Output received: 16:44:52 INFO - Usage: mozinstall [options] installer 16:44:52 INFO - Options: 16:44:52 INFO - -h, --help show this help message and exit 16:44:52 INFO - -d DEST, --destination=DEST 16:44:52 INFO - Directory to install application into. [default: 16:44:52 INFO - "/builds/slave/test"] 16:44:52 INFO - --app=APP Application being installed. [default: firefox] 16:44:52 INFO - mkdir: /builds/slave/test/build/application 16:44:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:45:26 INFO - Reading from file tmpfile_stdout 16:45:26 INFO - Output received: 16:45:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:45:26 INFO - Running post-action listener: _resource_record_post_action 16:45:26 INFO - ##### 16:45:26 INFO - ##### Running run-tests step. 16:45:26 INFO - ##### 16:45:26 INFO - Running pre-action listener: _resource_record_pre_action 16:45:26 INFO - Running main action method: run_tests 16:45:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:45:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:45:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:45:26 INFO - 2016-03-11 16:45:26.111 screenresolution[1646:7544] starting screenresolution argv=screenresolution get 16:45:26 INFO - 2016-03-11 16:45:26.114 screenresolution[1646:7544] Display 0: 1600x1200x32@60 16:45:26 INFO - 2016-03-11 16:45:26.120 screenresolution[1647:7546] starting screenresolution argv=screenresolution list 16:45:26 INFO - Available Modes on Display 0 16:45:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:45:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:45:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:45:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:45:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:45:26 INFO - Intel Iris: 16:45:26 INFO - Chipset Model: Intel Iris 16:45:26 INFO - Type: GPU 16:45:26 INFO - Bus: Built-In 16:45:26 INFO - VRAM (Dynamic, Max): 1536 MB 16:45:26 INFO - Vendor: Intel (0x8086) 16:45:26 INFO - Device ID: 0x0a2e 16:45:26 INFO - Revision ID: 0x0009 16:45:26 INFO - Displays: 16:45:26 INFO - Display: 16:45:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:45:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:45:26 INFO - Display Serial Number: 1600x1200 60 16:45:26 INFO - Main Display: Yes 16:45:26 INFO - Mirror: Off 16:45:26 INFO - Online: Yes 16:45:26 INFO - Rotation: Supported 16:45:26 INFO - Return code: 0 16:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:45:26 INFO - Python 2.7.3 16:45:26 INFO - Return code: 0 16:45:26 INFO - grabbing minidump binary from tooltool 16:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:26 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 0x10cbadd30>, '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 0x10c9d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cba4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:45:26 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 16:45:26 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 16:45:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:26 INFO - Return code: 0 16:45:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:45:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:45:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:45:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:45:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:45:27 INFO - Return code: 0 16:45:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9o84hIWGQc/Render', 16:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:45:27 INFO - 'HOME': '/Users/cltbld', 16:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:45:27 INFO - 'LOGNAME': 'cltbld', 16:45:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:45:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:27 INFO - 'MOZ_NO_REMOTE': '1', 16:45:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:45:27 INFO - 'NO_EM_RESTART': '1', 16:45:27 INFO - 'PAGER': '/bin/cat', 16:45:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:27 INFO - 'PWD': '/builds/slave/test', 16:45:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:45:27 INFO - 'SHELL': '/bin/bash', 16:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xpNA1nM1c3/Listeners', 16:45:27 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 16:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:45:27 INFO - 'USER': 'cltbld', 16:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:27 INFO - 'XPC_FLAGS': '0x0', 16:45:27 INFO - 'XPC_SERVICE_NAME': '0', 16:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:45:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:45:27 INFO - mozversion application_buildid: 20160311133331 16:45:27 INFO - mozversion application_changeset: 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 16:45:27 INFO - mozversion application_display_name: Nightly 16:45:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:27 INFO - mozversion application_name: Firefox 16:45:27 INFO - mozversion application_remotingname: firefox 16:45:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:45:27 INFO - mozversion application_vendor: Mozilla 16:45:27 INFO - mozversion application_version: 48.0a1 16:45:27 INFO - mozversion platform_buildid: 20160311133331 16:45:27 INFO - mozversion platform_changeset: 8c4c8f3f6379bffa017bc6ddc66af45d3f6c6b78 16:45:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:45:27 INFO - mozversion platform_version: 48.0a1 16:45:27 INFO - using testdate: 1457743527 16:45:27 INFO - actual date: 1457743527 16:45:27 INFO - starting webserver on 'localhost:49276' 16:45:27 INFO - SUITE-START | Running 2 tests 16:45:27 INFO - TEST-START | dromaeo_css 16:45:27 INFO - operating with platform_type : mac_ 16:45:27 INFO - Initialising browser for dromaeo_css test... 16:45:27 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp7NM0ZL/profile http://localhost:49276/getInfo.html) 16:45:30 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 16:45:30 INFO - PROCESS | 1665 | colorDepth:24 16:45:30 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 16:45:30 INFO - PROCESS | 1665 | __metrics 16:45:30 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 16:45:31 INFO - TEST-INFO | 1665: exit 0 16:45:31 INFO - Browser initialized. 16:45:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:31 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp7NM0ZL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:43 INFO - PROCESS | 1669 | RSS: Main: 256806912 16:45:43 INFO - PROCESS | 1669 | 16:46:33 INFO - PROCESS | 1669 | 1457743593527 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] 16:48:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 16:48:46 INFO - PROCESS | 1669 | RSS: Main: 269975552 16:48:46 INFO - PROCESS | 1669 | 16:51:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 16:51:48 INFO - PROCESS | 1669 | RSS: Main: 281059328 16:51:48 INFO - PROCESS | 1669 | 16:54:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 16:54:51 INFO - PROCESS | 1669 | RSS: Main: 282300416 16:54:51 INFO - PROCESS | 1669 | 16:57:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 16:57:53 INFO - PROCESS | 1669 | RSS: Main: 284782592 16:57:53 INFO - PROCESS | 1669 | 17:00:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 17:00:56 INFO - PROCESS | 1669 | RSS: Main: 287145984 17:00:56 INFO - PROCESS | 1669 | 17:03:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 17:03:59 INFO - PROCESS | 1669 | RSS: Main: 288903168 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | __start_tp_report 17:03:59 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 17:03:59 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 17:03:59 INFO - PROCESS | 1669 | |i|pagename|runs| 17:03:59 INFO - PROCESS | 1669 | |0;dojo.html;3527.453244747065;3539.7876127432355;3560.8397622107004;3578.2485678007633;3606.296772129436;5698.316202055748;5769.596128271022;5778.739956701948;5786.681732504716;5795.130730390443;5654.123610840326;5681.460261275182;5817.331006934204;5823.06830907055;5924.081767326072;5223.660462069973;5246.1606143017125;5280.735963201843;5290;5308.654937429054;5302.708351040691;5308.814191503298;5310.38930522989;5334.866628334284;5347.46525347466;5241.895162096775;5243.659162154467;5319.281896943901;5320.095583750772;5323.866903327409;5238.580913526908;5270.683758974474;5273.050850846846;5273.525382715536;5344.118220493614;5140.820071297487;5228.215767634847;5255.789768409259;5298.178782288752;5301.01931142736;4211.452511173558;5657.830265092054;5761.654300741969;5770.480656740913;5793.362730099686;5209.322788037569;6286.9056964145575;6339.270983836872;6340.904886426707;6341.302456729756;5296.867578310535;6242.500599951993;6272.811815645492;6294.370562943669;6316.589421687576;5306.177542480922;6008.128821320884;6012.969935150296;6016.368281330441;6064.545159113084;5496.148097044965;6390.360963903572;6396.392342727433;6400.167978162902;6409.807705768834;6100.369238099044;6159.938400615936;6197.101420294032;6265.8120256392385;6284.37156284377;6105.338445949952;6187.133801267826;6266.780662676784;6296.968515157395;6300.401461861115;6274.372562743689;6292.087647291117;6325.399087086719;6332.430081292706;6340.334264902119;5995.640261584232;6181.907271390933;6248.75004999804;6307.274663413675;6322.399372059647;4916.360873086547;4920.434150072716;4948.0103979204305;4978.8755281118265;4980.028894365564;4479.59683628475;4483.417155769729;4492.685512014193;4507.549245075466;4534.274516077412;5677.83604361105;5889;5925.081612350093;5940.287165540163;5985.730642121115;6265.337956661236;6317.052442133625;6349.46029587481;6352.650604216812;6358.872822543616;5934.910976335358;5962.34414214436;5963.850903727442;5979.01346277868;6000.0999850022845;5374.435684253175;5444.210589464506;5453.64551304164;5477.4796394342475;5531.3362396512675;5314.574834013192;6397.7440902364315;6399.64801935898;6419.45434638061;6437.93774027299;5867.354590995073;6149.354317796746;6314.652694101868;6325.367463253638;6327;6360.681965901779;6393.904091438539;6430.807075787734;6436.8390790230615;6445.484361250995;6204.503639708722;6221.440070393686;6221.9377806221355;6241.469475094668;6246.9062964054665;6119.441623354484;6226.719797609209;6262.4990000800735;6289.559730818799;6306.243250809749;6072.9372359837735;6092.543059270661;6154.78458253959;6156.015037593964;6226.688665566794;4794.4486384064885;5483.341998960151;6170.259568851767;6185.257769067741;6214.5960512566535;5777.3933736957015;5858.531317494675;6017.037274036134;6067.302260239952;6132.478739307209;6163.137160797402;6189.288231853395;6199.597026193283;6204.472619827185;6211.751529938932;6077.48341390969;6101.84745381369;6103.176071230327;6112.786052488142;6125.816225513242 17:03:59 INFO - PROCESS | 1669 | |1;ext.html;461.3633186203039;537.4544836990455;547.7206624621442;586.6157666728293;602.7137109872814;37797.055073623174;38553.22893542134;38569.614303856986;38607.42088868669;38636;39876.202475950464;40060;40368.79815600918;40370.19259614813;40373.59626403735;9439.103285187895;9593.184579310768;9593.47235902025;9645.807083858319;9666.951665241664;9480.383775054634;9696.46669433181;9722.125008749212;9755.658551950683;9762;9682.12860842524;9708.41749495029;9708.854367184462;9752.268579856503;9772.511374431286;9672.70981870545;9703.369280996712;9709.029097090304;9717.028297170227;9735.902640973605;9613.951930240373;9700.320977531575;9714.417134971854;9751.0736480035;9754.219662426989;39261.411078833844;39455.60544394548;39603.20793584112;39762.80711578657;39779.602203977876;3356.647552007053;3465.324261768956;3788.981055094707;3831.907906246734;3849.8075096245075;24846.37884052913;28888.855555722297;30047.849760751276;30090.54864177039;30759.38481230363;2716.171567671859;2731.1260396673074;2766.1286694691307;2803.523401021831;2839.7870159738104;496680;501626.491867542;501789;501953;504844;40437;45107.64677059693;45238.095238095055;46188;66427.66786166039;45208.86977825581;45376.865578360805;45457.54542454533;45612.543874561496;45809.31286030712;13299.80301772845;15793.21033948298;15911.522654320388;15945.20273986296;16107.919460402858;9624.66313679032;11813.645590632295;12004.799520047925;12830.935845320713;13072.803907941197;14856.480023199136;14894.03188792725;14924.701505970037;15034.924825375803;15119.470818521298;5315.229291752674;5549.639273447213;6472.223333200046;6561.179852518435;6610.4050635443045;948.3266880514774;1011.691434112588;1075.3010543147018;1080.6649938519083;1155.8324043013884;29272.24366537972;29543.26141846471;29587.546076226103;30154;30198;1133.6712353417581;1134.744682446443;1143.5311522275827;1184.5261895241972;1188.0614314691297;15087.47193848232;15111;15215.467458638894;15328.540143795704;15349.693006139814;518230;526097;530242;530430.6956930459;530779;58001.41998580044;59142.70428647829;60035;60059.69970150121;60190.69904650449;1416.221078406872;1433.0470237292293;1444.8266208055102;1461.4008256614736;1463.597510684549;29081.563776542946;29181.854090729412;29639.703602964557;29791.85104074466;29900.85049574825;51883;51912.74043629758;51989;52351;52377.7381113092;493272;493764;497093;497307;498358;33525.16187095342;33548.496772547944;34052.489212661334;34472.655273446944;34542.82728586341;44687.10625787531;44974;45165.64503064913;45780.084398312516;45965.310520341554;37502.43746343862;37954.2409151821;37974.62025379711;38497.87176978409;39000.6099938997;37264.813675931444;37404.25191496209;37917.86246412612;38061.61938380581;38288.23423531569;28240;36488.635113648525;36791.63208367882;37525.62474375221;37623.623763762014;30455.84772076214;31144.377112457172;31187.220319492193;31238.531422028234;31855.6814431862;23127;24499.38751531226;24592.754072459764;24667.061334341503;24793.256202313958 17:03:59 INFO - PROCESS | 1669 | |2;jquery.html;351.3833222694173;361.8299399282337;369.76704676054084;370.5201763715988;370.5979012771143;19621;20233.39299821004;21066.36800895972;21407.892960535177;21678;20447.591048179027;20524.589508209865;20795.16819327225;20889.895550522226;20987;5818.272715910512;6055.485283750886;6074.240719910012;6078.240219972504;6090.147379366892;5699.2590963174725;5754.625949313281;5911.142884281777;5977;5980.132880732292;4970.856702958322;5502.119660854264;5871.412858714137;5900.970495147519;5931.051031834907;5069.7972081116895;5644.125160600113;5854.882902341972;5896.5872388933;5917.230760001173;5496.422875598045;5497.670139791625;5614.410486898899;5631.915521267184;5638.85902852432;13028.218306901616;13236.86763132366;17081.316747330093;23455.765442345528;24008.519829603483;1587.7116286463665;1991.4623051775939;2000.1599328282157;2049.7437820272467;2220.4448887778058;9373.812523749555;9714.805703885953;10031.89968100317;10059.497025148714;10101.393916365041;1715.0395778364157;1728.1013872786082;1734.670412621598;1775.849052830511;1775.8934463932205;102638;113800.43099784531;113925;116667.41666291615;116707;11165.66503004895;11261.831072533918;11493.138014648935;11523.07815374768;11612.361320127306;13897.444102235999;13923.23422211788;13945.233012184224;13954.651133721534;13977.930110349384;8539.274161696201;8633.136686331316;8644.011877268138;8675.609597568124;8707.346948978726;8679.17547832955;8754.21212090915;8774.912250877409;8858.689945851993;8888.911110888937;4523.592876641118;4542.136993971135;4544.227481328182;4546.158960592301;4601.953980460153;1877.755891734066;1903.4955736729778;1905.2188602673116;1905.7808352039692;1954.6286205620886;778.9143194248628;957.7988622389237;961.2550273537925;1005.215931573374;1039.3296323871211;14957.626059348604;17317;19579.706304405445;20014.89992550028;20027.799722002594;808.401782680812;821.3347188776991;919.5907821019582;970.4565443351604;975.2734213011352;8904;10745.731356716145;10854.294470859526;10881.673549793519;11011.724706882393;605865.9706701438;612763;612892;618084;623042;92360.0763992365;93406;112691.50652633347;113460.43269783599;115814;1046.3460337289193;1055.9260851740457;1092.9234953553175;1110.3337997201777;1110.3559935237704;16806.411775587796;17902.731459027866;17953.371631992817;18150;18297.908510457364;43639.34540981824;46090.30864537102;49602.503974959785;51105.74447127741;53549.73225133849;68545.31454685389;71259;71563;72276.63861680658;93398.53300733452;5562.527185189304;7805.375569954504;7846.293833555007;7860.3318717909615;8123.5532045738055;7223.674934628059;8677.1756683115;11348.602798901999;11765.294032365431;12682.429290681757;10484.213683973885;10797.514111865143;10983.176261780558;11007.669769906915;11020.393878336768;10572;10579.36523808574;10832.133429325477;10911.83632245501;11126.332420054823;11020.50407731638;11154.609588664358;11276.210665253353;11336.886631133582;11470.483828227916;7566.281203285899;7898.763037108896;7924;8141.674333026849;8183.63173657175;10554.525046372779;10832.350058996486;10922.19580398665;11105.222634415837;11111.999920006914 17:03:59 INFO - PROCESS | 1669 | |3;mootools.html;1557.4237532113116;1586.3575252022931;1670.9498715038553;1727.7646482764821;1963.1558429875165;7931.8413631727335;8466.830663386743;8543.871841922368;8781.999999999993;8802.339824513163;8525.531095789729;8555.743327700164;8647.827043459143;8661.35039872009;8666.696665616704;2470.3700556358103;2502.5245203411296;2504.874756262189;2505.1732928133674;2526.393665520271;2446.1438496526252;2507.0723832182025;2517.3958250020046;2520.1179587144443;2523.785478234343;2478.950420991579;2497.8001759859258;2519.962200566993;2529.84820910745;2530.8861101250486;2501.17461237792;2513.3716570857287;2514.094925826701;2524.545581795276;2534.6958364996135;2247.763984781591;2439.2804122783823;2491.576432006545;2515.72327044025;2540.9364765880814;8736.51949142797;8821.779455513599;8849.336299777478;8854.645814167425;8862.556872156367;5408.648437851527;5497.642653227567;5535.806246781343;5541.612087153901;5562.749676264578;3620.2759448110482;3685.68671662909;3742.176721121349;3780.4518344839844;3782.6406491383273;950.8668786369914;1028.331584470093;1035.4667346316653;1072.5495291977388;1075.5643964194514;10957.780844383067;11801.232919860182;11825.64523064301;11829.881701182963;11859.169858109935;4837.032593481318;4848.854534363974;4964.776585053682;4967.5032496750755;4972.65191436596;10044.397336159855;10073.1437827784;10080.344777589433;10096.949515252376;10119.089281964658;4761.952380476151;5345.904089661688;5518.2826232589505;5522.2544956431175;5559.082751345983;3789.6020917803785;4679.742614156254;4885.926711099336;4920.75396230187;4996.175631020841;3907.9804600976813;3944.2505923874373;3986.7807270599815;3997.060690737674;4036.6367026967714;1123.5225029362489;1347.2926713475504;1356.5319964612193;1364.0519838712198;1364.6315494816345;1323.4706117553055;1342.4026308292716;1370.465518447806;1385.058160450883;1390.450771945076;8031.598420078973;8158.184181581794;8173.141820108803;8180.5909704515725;8197.385196110316;498.8229178641603;501.2906736967151;506.3973871093387;512.7692538357754;513.9049275883973;6259.374062593704;6262.091996660459;6291.339409361951;6291.9685401573615;6292.685365731695;10436.63471778484;10609.628662996758;10629.149668026539;10719.678409647722;10779.568817247378;10426.322289051188;10575.259731818698;10580.994805493467;10587.84118238227;10592.841107383396;8291.756236564564;8336.24973752353;8375.120612335739;8420.663173473115;8459.492430454193;7804.414668899742;7873.488223265469;7879.84240315179;7903.960480197562;7921.762347129596;9215.815683686424;9562.856557151508;9567.712968610953;9568.4737339447;9671.951640241754;9415.529223538933;9748.951255243679;9906.950465247915;10001.899981000097;10013.497975303762;6532.706028228836;7311.780646580611;7356;7453.329200371993;7523.172451030492;8111.1888811118415;8111.716089936824;8137.104918458846;8137.8372432552205;8173.509589424653;7226.168990566152;7322.524035937647;7329.780106596811;7470;7510.586917719578;7049.894251586128;7181.35367816899;7193.676284567103;7203.991441198132;7213.1704853942465;6285.779997700059;7646.31183193493;7668.846623067396;7673.577953212627;7683.385329173541;6913.3777959983845;6937.098177236927;6948.305169483011;6982.1272340957385;7035.085438892911;6998.16022077354;7058.71765129389;7073.115860517435;7080.681369338289;7091.397231235403 17:03:59 INFO - PROCESS | 1669 | |4;prototype.html;304.36387949186195;331.16381137627485;332.14804027669044;336.8282176090195;338.97288216942655;6334.429901308881;6794.4224740897025;6873.450123990081;6878.552894061895;6940.652967351625;6811.182658081025;6848.554843935153;6868.6565671716335;6887.242403335629;6896.79309620711;4810.97594512027;4939.135651261033;5064.594832413398;5082.085224659569;5097.5921926246;5057.937833055063;5080.720560369178;5087.414947281054;5091.7708703108265;5129.333186685744;5025.3969523657215;5028.346314979048;5031.886607624788;5044.899102017957;5045.066662667418;5042.924356134661;5050.520200580957;5051.646384753032;5053.949460505403;5059.089363914494;4326.891827704332;4329.264025115738;4330.978345108286;4340.197063543254;4344.174606824693;6458.6770661466735;6479.319671434479;6599.1091202687985;6679.632620205887;6695.531312808105;4850.563449289581;5952.494038006775;6020.819375418744;6026.5178785697035;6053.576249662526;7316.743913962986;7334.046573945407;7343.706251749977;7348.301911318416;7382.593957332345;4116.526599441043;4121.91756164875;4636.235021221528;4808.8797780055775;4890.682105663156;7753.643112455354;7756.185600511978;7762.107357653942;7774.689012439496;7806.765797026042;4007.3788562772816;4798.184308667535;4807.351007613997;4814.903701926012;4825.9034819304115;4029.49631296088;4835.540623640749;4899.608031357554;4906.460289368167;4910.386201724785;5836.970815145982;5840.912386314209;5898.882022359615;5911.290645122527;5918.201042859245;5974.581779275496;7028.824279392954;7417.184109747924;7418.888716669254;7425.108986921496;1676.069781271406;1700.0819557439092;1700.523853321072;1702.208473060033;1705.2667353038312;1046.0585473074293;1081.7944590527932;1082;1085.625459216569;1104.2325583719237;5552.555795536347;6742.224644165984;6769.898451523231;6812.284710105368;6835.043093966849;6027.849303767441;7433.959245705605;7553.32020118181;7567.243275672388;7568.5458872467825;6695.12963314766;6905.37851593359;6922.861542769117;6944.687489063004;6956.513044086865;3246.6915643013876;4054;4062.878113656595;4080.224757296104;4087.080406908422;7955.4033447491665;7966.28303452692;7975.680972761141;7976.162502937224;8005;7668.463207575528;7830.491018083806;7864.449488535747;7924.841503169904;7928.5996272068405;6379.170707807955;7010.719571217196;7388;7941.761747147595;7953.960230198812;5512.751926163252;5879.059350503899;6484.28672845996;6858.794236172923;7674.501157424749;7496.325330720261;7505;7537.660805263667;7541.20817314196;7547.962260188664;6588.7364505421165;7176.641167941686;7503.536810321935;7941.841163176588;7952.681892724458;3897.7466464679705;4786.808527658994;4809.831655892027;4809.831655892027;4831.468538460696;7588.279113484431;7636.007319048488;7642.617869106633;7649.426293028157;7650.65572049248;7306.159791624032;7332.743353982585;7334;7341.77974660761;7363.926360736324;7132.964335178499;7263.418926485762;7328.926710732824;7384.298491643285;7405.740799072007;7121.074260346122;7170.569765814068;7185.101862267216;7202.567845929261;7213.639318033972;7351.66917488725;7354;7357.632118394166;7358.1538123116525;7371.520851144658;5829.76680932758;7151.141862976476;7158.713651453883;7166.856662866818;7195.352418282379 17:03:59 INFO - PROCESS | 1669 | |5;yui.html;648.0764910003244;665.1519312876082;687.1650944102914;732.4301019851927;766.5247546521158;14654.047486913356;15042.323095460702;17067.14664266785;17441.30234790607;17567.385141520048;16216.83783162168;16295;16313.51059468215;16338.01971881685;16339.918300408512;748.9363404110657;914.6981496106303;950.2493030505892;950.9239260859115;951.1914872358475;925.676013395313;938.9812203755921;945.2013048973606;946.4888959961612;946.7585765629755;986.595495846703;990.128686755654;992.5880759484805;993.0913214408844;993.3046867192994;969.142309056483;969.3408482232079;973.4597298499366;974.9463779492125;980.4950450517989;725.0972539188743;728.7522242437597;729.6716477585055;729.8868675355276;731.5756861020595;15291.311890964822;15418.614534636612;15614.843851561453;15616.063036217864;15630.905836591442;12646.367681615975;12681.36593170347;12813.10308278421;12865.742685146339;13007.349632518431;10025.298229123964;10096.899031009669;10142.18862490999;10182.28723989321;10239.53922073501;3168.621649582439;3288.8684452621865;3350.279689866666;3470.8091054991964;3483.3207524532727;84900;84996.57501712452;85496;85699.28601427999;85905;9258.398204116846;9303.116203960613;9313.580888860017;9318.906810931803;10134.746631334128;21579.460513487287;21580.784192158193;21594.136234550442;21649;21697;7240.348368646847;7383.556986580822;7453.2546745325035;7582.658780354897;7601.809954751065;4091.774952377648;4125.195586860534;4129.483814523184;4138.13099249155;4138.565450627701;3556.4309710446205;3560.4481305397703;3568.6252943441086;3574.4459608760685;3588.784672919633;645.2643985856128;655.9868802623921;660.2934859700075;660.3693472733528;662.4303099334569;434.9608535231844;504.45518839653084;585.519873703559;587.9559033072537;632.4813652804656;7773.261540153676;7799.649015794303;7855.567943763148;8079.111297757242;8186.959065204755;449.33722758930315;503.61221859168967;562.5274769193896;623.0716232813076;635.369569980282;3729.9627003730157;3866.6167103784187;3873.1479074603544;3893.727439079294;3922.921541569153;87383;96371.51814241025;96445.51777241069;99102.50448747854;99365;71712;72509.63745181345;74435;75032.62483687655;75261;65748.01377979238;66593.66812663816;67247.99999999903;67471;69178.30821691718;7003.509754317352;8286.295664868312;8500.872486912578;8566.143385661633;8776.868346974928;48017.27974080462;48281.5171848277;48352.758236208596;48524.514754851996;49346.75326623344;62886;63746.04380934197;64079.03881441689;65052.67473662602;65154;10796;10812.135029197803;10868.945655271673;10878.347299162075;11146.108311334912;11654.766904662029;11784.116191285517;11813.350265735124;11865;11889.048876089719;10909.727256818644;11105;11134.220604557604;11278.097752179641;11506.30962142274;11128.387938663127;11225.943870280596;11386.715332116763;11614.941925290319;11995.580154694544;10830.458477075957;11048.502817373077;11079.889201107886;11329.263597866113;11391;9109;9339.953300233727;9427.62289508412;9555.474448905377;9614.086661767122;7219.448471743232;9293.767655808659;9430.575624096795;9441.480718560546;9456.479893605918 17:03:59 INFO - PROCESS | 1669 | __end_tp_report 17:03:59 INFO - PROCESS | 1669 | __start_cc_report 17:03:59 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,379 17:03:59 INFO - PROCESS | 1669 | __end_cc_report 17:03:59 INFO - PROCESS | 1669 | __startTimestamp1457744639211__endTimestamp 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | ------- Summary: start ------- 17:03:59 INFO - PROCESS | 1669 | Number of tests: 6 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5779.80 Median:6012.97 stddev:641.35 (10.7%) stddev-sans-first:618.50 17:03:59 INFO - PROCESS | 1669 | Values: 3527.5 3539.8 3560.8 3578.2 3606.3 5698.3 5769.6 5778.7 5786.7 5795.1 5654.1 5681.5 5817.3 5823.1 5924.1 5223.7 5246.2 5280.7 5290.0 5308.7 5302.7 5308.8 5310.4 5334.9 5347.5 5241.9 5243.7 5319.3 5320.1 5323.9 5238.6 5270.7 5273.1 5273.5 5344.1 5140.8 5228.2 5255.8 5298.2 5301.0 4211.5 5657.8 5761.7 5770.5 5793.4 5209.3 6286.9 6339.3 6340.9 6341.3 5296.9 6242.5 6272.8 6294.4 6316.6 5306.2 6008.1 6013.0 6016.4 6064.5 5496.1 6390.4 6396.4 6400.2 6409.8 6100.4 6159.9 6197.1 6265.8 6284.4 6105.3 6187.1 6266.8 6297.0 6300.4 6274.4 6292.1 6325.4 6332.4 6340.3 5995.6 6181.9 6248.8 6307.3 6322.4 4916.4 4920.4 4948.0 4978.9 4980.0 4479.6 4483.4 4492.7 4507.5 4534.3 5677.8 5889.0 5925.1 5940.3 5985.7 6265.3 6317.1 6349.5 6352.7 6358.9 5934.9 5962.3 5963.9 5979.0 6000.1 5374.4 5444.2 5453.6 5477.5 5531.3 5314.6 6397.7 6399.6 6419.5 6437.9 5867.4 6149.4 6314.7 6325.4 6327.0 6360.7 6393.9 6430.8 6436.8 6445.5 6204.5 6221.4 6221.9 6241.5 6246.9 6119.4 6226.7 6262.5 6289.6 6306.2 6072.9 6092.5 6154.8 6156.0 6226.7 4794.4 5483.3 6170.3 6185.3 6214.6 5777.4 5858.5 6017.0 6067.3 6132.5 6163.1 6189.3 6199.6 6204.5 6211.8 6077.5 6101.8 6103.2 6112.8 6125.8 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:64039.94 Median:38621.71 stddev:135363.14 (350.5%) stddev-sans-first:135658.70 17:03:59 INFO - PROCESS | 1669 | Values: 461.4 537.5 547.7 586.6 602.7 37797.1 38553.2 38569.6 38607.4 38636.0 39876.2 40060.0 40368.8 40370.2 40373.6 9439.1 9593.2 9593.5 9645.8 9667.0 9480.4 9696.5 9722.1 9755.7 9762.0 9682.1 9708.4 9708.9 9752.3 9772.5 9672.7 9703.4 9709.0 9717.0 9735.9 9614.0 9700.3 9714.4 9751.1 9754.2 39261.4 39455.6 39603.2 39762.8 39779.6 3356.6 3465.3 3789.0 3831.9 3849.8 24846.4 28888.9 30047.8 30090.5 30759.4 2716.2 2731.1 2766.1 2803.5 2839.8 496680.0 501626.5 501789.0 501953.0 504844.0 40437.0 45107.6 45238.1 46188.0 66427.7 45208.9 45376.9 45457.5 45612.5 45809.3 13299.8 15793.2 15911.5 15945.2 16107.9 9624.7 11813.6 12004.8 12830.9 13072.8 14856.5 14894.0 14924.7 15034.9 15119.5 5315.2 5549.6 6472.2 6561.2 6610.4 948.3 1011.7 1075.3 1080.7 1155.8 29272.2 29543.3 29587.5 30154.0 30198.0 1133.7 1134.7 1143.5 1184.5 1188.1 15087.5 15111.0 15215.5 15328.5 15349.7 518230.0 526097.0 530242.0 530430.7 530779.0 58001.4 59142.7 60035.0 60059.7 60190.7 1416.2 1433.0 1444.8 1461.4 1463.6 29081.6 29181.9 29639.7 29791.9 29900.9 51883.0 51912.7 51989.0 52351.0 52377.7 493272.0 493764.0 497093.0 497307.0 498358.0 33525.2 33548.5 34052.5 34472.7 34542.8 44687.1 44974.0 45165.6 45780.1 45965.3 37502.4 37954.2 37974.6 38497.9 39000.6 37264.8 37404.3 37917.9 38061.6 38288.2 28240.0 36488.6 36791.6 37525.6 37623.6 30455.8 31144.4 31187.2 31238.5 31855.7 23127.0 24499.4 24592.8 24667.1 24793.3 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34106.40 Median:21542.95 stddev:101857.51 (472.8%) stddev-sans-first:102111.71 17:03:59 INFO - PROCESS | 1669 | Values: 351.4 361.8 369.8 370.5 370.6 19621.0 20233.4 21066.4 21407.9 21678.0 20447.6 20524.6 20795.2 20889.9 20987.0 5818.3 6055.5 6074.2 6078.2 6090.1 5699.3 5754.6 5911.1 5977.0 5980.1 4970.9 5502.1 5871.4 5901.0 5931.1 5069.8 5644.1 5854.9 5896.6 5917.2 5496.4 5497.7 5614.4 5631.9 5638.9 13028.2 13236.9 17081.3 23455.8 24008.5 1587.7 1991.5 2000.2 2049.7 2220.4 9373.8 9714.8 10031.9 10059.5 10101.4 1715.0 1728.1 1734.7 1775.8 1775.9 102638.0 113800.4 113925.0 116667.4 116707.0 11165.7 11261.8 11493.1 11523.1 11612.4 13897.4 13923.2 13945.2 13954.7 13977.9 8539.3 8633.1 8644.0 8675.6 8707.3 8679.2 8754.2 8774.9 8858.7 8888.9 4523.6 4542.1 4544.2 4546.2 4602.0 1877.8 1903.5 1905.2 1905.8 1954.6 778.9 957.8 961.3 1005.2 1039.3 14957.6 17317.0 19579.7 20014.9 20027.8 808.4 821.3 919.6 970.5 975.3 8904.0 10745.7 10854.3 10881.7 11011.7 605866.0 612763.0 612892.0 618084.0 623042.0 92360.1 93406.0 112691.5 113460.4 115814.0 1046.3 1055.9 1092.9 1110.3 1110.4 16806.4 17902.7 17953.4 18150.0 18297.9 43639.3 46090.3 49602.5 51105.7 53549.7 68545.3 71259.0 71563.0 72276.6 93398.5 5562.5 7805.4 7846.3 7860.3 8123.6 7223.7 8677.2 11348.6 11765.3 12682.4 10484.2 10797.5 10983.2 11007.7 11020.4 10572.0 10579.4 10832.1 10911.8 11126.3 11020.5 11154.6 11276.2 11336.9 11470.5 7566.3 7898.8 7924.0 8141.7 8183.6 10554.5 10832.4 10922.2 11105.2 11112.0 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6020.07 Median:513.34 stddev:3163.71 (616.3%) stddev-sans-first:3154.81 17:03:59 INFO - PROCESS | 1669 | Values: 1557.4 1586.4 1670.9 1727.8 1963.2 7931.8 8466.8 8543.9 8782.0 8802.3 8525.5 8555.7 8647.8 8661.4 8666.7 2470.4 2502.5 2504.9 2505.2 2526.4 2446.1 2507.1 2517.4 2520.1 2523.8 2479.0 2497.8 2520.0 2529.8 2530.9 2501.2 2513.4 2514.1 2524.5 2534.7 2247.8 2439.3 2491.6 2515.7 2540.9 8736.5 8821.8 8849.3 8854.6 8862.6 5408.6 5497.6 5535.8 5541.6 5562.7 3620.3 3685.7 3742.2 3780.5 3782.6 950.9 1028.3 1035.5 1072.5 1075.6 10957.8 11801.2 11825.6 11829.9 11859.2 4837.0 4848.9 4964.8 4967.5 4972.7 10044.4 10073.1 10080.3 10096.9 10119.1 4762.0 5345.9 5518.3 5522.3 5559.1 3789.6 4679.7 4885.9 4920.8 4996.2 3908.0 3944.3 3986.8 3997.1 4036.6 1123.5 1347.3 1356.5 1364.1 1364.6 1323.5 1342.4 1370.5 1385.1 1390.5 8031.6 8158.2 8173.1 8180.6 8197.4 498.8 501.3 506.4 512.8 513.9 6259.4 6262.1 6291.3 6292.0 6292.7 10436.6 10609.6 10629.1 10719.7 10779.6 10426.3 10575.3 10581.0 10587.8 10592.8 8291.8 8336.2 8375.1 8420.7 8459.5 7804.4 7873.5 7879.8 7904.0 7921.8 9215.8 9562.9 9567.7 9568.5 9672.0 9415.5 9749.0 9907.0 10001.9 10013.5 6532.7 7311.8 7356.0 7453.3 7523.2 8111.2 8111.7 8137.1 8137.8 8173.5 7226.2 7322.5 7329.8 7470.0 7510.6 7049.9 7181.4 7193.7 7204.0 7213.2 6285.8 7646.3 7668.8 7673.6 7683.4 6913.4 6937.1 6948.3 6982.1 7035.1 6998.2 7058.7 7073.1 7080.7 7091.4 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5917.53 Median:6718.88 stddev:1909.88 (28.4%) stddev-sans-first:1868.19 17:03:59 INFO - PROCESS | 1669 | Values: 304.4 331.2 332.1 336.8 339.0 6334.4 6794.4 6873.5 6878.6 6940.7 6811.2 6848.6 6868.7 6887.2 6896.8 4811.0 4939.1 5064.6 5082.1 5097.6 5057.9 5080.7 5087.4 5091.8 5129.3 5025.4 5028.3 5031.9 5044.9 5045.1 5042.9 5050.5 5051.6 5053.9 5059.1 4326.9 4329.3 4331.0 4340.2 4344.2 6458.7 6479.3 6599.1 6679.6 6695.5 4850.6 5952.5 6020.8 6026.5 6053.6 7316.7 7334.0 7343.7 7348.3 7382.6 4116.5 4121.9 4636.2 4808.9 4890.7 7753.6 7756.2 7762.1 7774.7 7806.8 4007.4 4798.2 4807.4 4814.9 4825.9 4029.5 4835.5 4899.6 4906.5 4910.4 5837.0 5840.9 5898.9 5911.3 5918.2 5974.6 7028.8 7417.2 7418.9 7425.1 1676.1 1700.1 1700.5 1702.2 1705.3 1046.1 1081.8 1082.0 1085.6 1104.2 5552.6 6742.2 6769.9 6812.3 6835.0 6027.8 7434.0 7553.3 7567.2 7568.5 6695.1 6905.4 6922.9 6944.7 6956.5 3246.7 4054.0 4062.9 4080.2 4087.1 7955.4 7966.3 7975.7 7976.2 8005.0 7668.5 7830.5 7864.4 7924.8 7928.6 6379.2 7010.7 7388.0 7941.8 7954.0 5512.8 5879.1 6484.3 6858.8 7674.5 7496.3 7505.0 7537.7 7541.2 7548.0 6588.7 7176.6 7503.5 7941.8 7952.7 3897.7 4786.8 4809.8 4809.8 4831.5 7588.3 7636.0 7642.6 7649.4 7650.7 7306.2 7332.7 7334.0 7341.8 7363.9 7133.0 7263.4 7328.9 7384.3 7405.7 7121.1 7170.6 7185.1 7202.6 7213.6 7351.7 7354.0 7357.6 7358.2 7371.5 5829.8 7151.1 7158.7 7166.9 7195.4 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18262.39 Median:633.93 stddev:25659.26 (4047.7%) stddev-sans-first:25697.16 17:03:59 INFO - PROCESS | 1669 | Values: 648.1 665.2 687.2 732.4 766.5 14654.0 15042.3 17067.1 17441.3 17567.4 16216.8 16295.0 16313.5 16338.0 16339.9 748.9 914.7 950.2 950.9 951.2 925.7 939.0 945.2 946.5 946.8 986.6 990.1 992.6 993.1 993.3 969.1 969.3 973.5 974.9 980.5 725.1 728.8 729.7 729.9 731.6 15291.3 15418.6 15614.8 15616.1 15630.9 12646.4 12681.4 12813.1 12865.7 13007.3 10025.3 10096.9 10142.2 10182.3 10239.5 3168.6 3288.9 3350.3 3470.8 3483.3 84900.0 84996.6 85496.0 85699.3 85905.0 9258.4 9303.1 9313.6 9318.9 10134.7 21579.5 21580.8 21594.1 21649.0 21697.0 7240.3 7383.6 7453.3 7582.7 7601.8 4091.8 4125.2 4129.5 4138.1 4138.6 3556.4 3560.4 3568.6 3574.4 3588.8 645.3 656.0 660.3 660.4 662.4 435.0 504.5 585.5 588.0 632.5 7773.3 7799.6 7855.6 8079.1 8187.0 449.3 503.6 562.5 623.1 635.4 3730.0 3866.6 3873.1 3893.7 3922.9 87383.0 96371.5 96445.5 99102.5 99365.0 71712.0 72509.6 74435.0 75032.6 75261.0 65748.0 66593.7 67248.0 67471.0 69178.3 7003.5 8286.3 8500.9 8566.1 8776.9 48017.3 48281.5 48352.8 48524.5 49346.8 62886.0 63746.0 64079.0 65052.7 65154.0 10796.0 10812.1 10868.9 10878.3 11146.1 11654.8 11784.1 11813.4 11865.0 11889.0 10909.7 11105.0 11134.2 11278.1 11506.3 11128.4 11225.9 11386.7 11614.9 11995.6 10830.5 11048.5 11079.9 11329.3 11391.0 9109.0 9340.0 9427.6 9555.5 9614.1 7219.4 9293.8 9430.6 9441.5 9456.5 17:03:59 INFO - PROCESS | 1669 | -------- Summary: end -------- 17:03:59 INFO - PROCESS | 1669 | 17:03:59 INFO - TEST-INFO | 1669: exit 0 17:03:59 INFO - TEST-OK | dromaeo_css | took 1111895ms 17:03:59 INFO - TEST-START | kraken 17:03:59 INFO - operating with platform_type : mac_ 17:03:59 INFO - Initialising browser for kraken test... 17:03:59 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp0OI3Ro/profile http://localhost:49276/getInfo.html) 17:04:02 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 17:04:02 INFO - PROCESS | 1681 | colorDepth:24 17:04:02 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 17:04:02 INFO - PROCESS | 1681 | __metrics 17:04:02 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 17:04:03 INFO - TEST-INFO | 1681: exit 0 17:04:03 INFO - Browser initialized. 17:04:03 INFO - Running cycle 1/1 for kraken test... 17:04:03 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp0OI3Ro/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:15 INFO - PROCESS | 1684 | RSS: Main: 255492096 17:04:15 INFO - PROCESS | 1684 | 17:04:18 INFO - PROCESS | 1684 | 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) 17:04:18 INFO - PROCESS | 1684 | RSS: Main: 267448320 17:04:18 INFO - PROCESS | 1684 | 17:04:21 INFO - PROCESS | 1684 | 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) 17:04:22 INFO - PROCESS | 1684 | RSS: Main: 276783104 17:04:22 INFO - PROCESS | 1684 | 17:04:25 INFO - PROCESS | 1684 | 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) 17:04:25 INFO - PROCESS | 1684 | RSS: Main: 281358336 17:04:25 INFO - PROCESS | 1684 | 17:04:27 INFO - PROCESS | 1684 | 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) 17:04:28 INFO - PROCESS | 1684 | RSS: Main: 282574848 17:04:28 INFO - PROCESS | 1684 | 17:04:30 INFO - PROCESS | 1684 | 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) 17:04:31 INFO - PROCESS | 1684 | RSS: Main: 284438528 17:04:31 INFO - PROCESS | 1684 | 17:04:34 INFO - PROCESS | 1684 | 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) 17:04:34 INFO - PROCESS | 1684 | RSS: Main: 283807744 17:04:34 INFO - PROCESS | 1684 | 17:04:37 INFO - PROCESS | 1684 | 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) 17:04:38 INFO - PROCESS | 1684 | RSS: Main: 283934720 17:04:38 INFO - PROCESS | 1684 | 17:04:41 INFO - PROCESS | 1684 | 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) 17:04:41 INFO - PROCESS | 1684 | RSS: Main: 283635712 17:04:41 INFO - PROCESS | 1684 | 17:04:43 INFO - PROCESS | 1684 | 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) 17:04:44 INFO - PROCESS | 1684 | RSS: Main: 282673152 17:04:44 INFO - PROCESS | 1684 | 17:04:46 INFO - PROCESS | 1684 | 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) 17:04:46 INFO - PROCESS | 1684 | RSS: Main: 283860992 17:04:46 INFO - PROCESS | 1684 | 17:04:48 INFO - PROCESS | 1684 | 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) 17:04:49 INFO - PROCESS | 1684 | RSS: Main: 283021312 17:04:49 INFO - PROCESS | 1684 | 17:04:52 INFO - PROCESS | 1684 | 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) 17:04:52 INFO - PROCESS | 1684 | RSS: Main: 284246016 17:04:52 INFO - PROCESS | 1684 | 17:04:55 INFO - PROCESS | 1684 | 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) 17:04:55 INFO - PROCESS | 1684 | RSS: Main: 284016640 17:04:55 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | 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) 17:04:57 INFO - PROCESS | 1684 | RSS: Main: 286056448 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | __start_tp_report 17:04:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 17:04:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 17:04:57 INFO - PROCESS | 1684 | |i|pagename|runs| 17:04:57 INFO - PROCESS | 1684 | |0;ai-astar;115;111;117;114;115;125;113;116;127;167 17:04:57 INFO - PROCESS | 1684 | |1;audio-beat-detection;155;124;183;174;116;155;175;151;179;123 17:04:57 INFO - PROCESS | 1684 | |2;audio-dft;192;201;199;205;208;235;274;200;202;201 17:04:57 INFO - PROCESS | 1684 | |3;audio-fft;56;68;56;60;82;68;121;58;57;64 17:04:57 INFO - PROCESS | 1684 | |4;audio-oscillator;84;80;157;114;118;83;121;81;81;128 17:04:57 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;90;87;78;129;137;86;97;87;85;119 17:04:57 INFO - PROCESS | 1684 | |6;imaging-darkroom;93;95;95;95;95;97;151;150;94;138 17:04:57 INFO - PROCESS | 1684 | |7;imaging-desaturate;120;89;149;144;124;91;92;90;92;91 17:04:57 INFO - PROCESS | 1684 | |8;json-parse-financial;54;56;54;57;58;56;58;65;59;56 17:04:57 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;66;61;88;102;57;74;90;99;69;69 17:04:57 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;85;85;85;87;85;84;83;86;96;110 17:04:57 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;134;138;140;133;122;144;132;134;143;133 17:04:57 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;145;187;151;137;149;158;173;137;142;141 17:04:57 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;68;68;66;68;69;70;66;68;65;70 17:04:57 INFO - PROCESS | 1684 | __end_tp_report 17:04:57 INFO - PROCESS | 1684 | __start_cc_report 17:04:57 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,946 17:04:57 INFO - PROCESS | 1684 | __end_cc_report 17:04:57 INFO - PROCESS | 1684 | __startTimestamp1457744697913__endTimestamp 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | ------- Summary: start ------- 17:04:57 INFO - PROCESS | 1684 | Number of tests: 14 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:122.00 Median:116.50 stddev:16.61 (14.3%) stddev-sans-first:17.43 17:04:57 INFO - PROCESS | 1684 | Values: 115.0 111.0 117.0 114.0 115.0 125.0 113.0 116.0 127.0 167.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:164.50 stddev:24.99 (15.2%) stddev-sans-first:26.50 17:04:57 INFO - PROCESS | 1684 | Values: 155.0 124.0 183.0 174.0 116.0 155.0 175.0 151.0 179.0 123.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:211.70 Median:203.50 stddev:24.70 (12.1%) stddev-sans-first:25.15 17:04:57 INFO - PROCESS | 1684 | Values: 192.0 201.0 199.0 205.0 208.0 235.0 274.0 200.0 202.0 201.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:69.00 Median:62.00 stddev:19.96 (32.2%) stddev-sans-first:20.60 17:04:57 INFO - PROCESS | 1684 | Values: 56.0 68.0 56.0 60.0 82.0 68.0 121.0 58.0 57.0 64.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:80.50 stddev:26.75 (33.2%) stddev-sans-first:27.30 17:04:57 INFO - PROCESS | 1684 | Values: 84.0 80.0 157.0 114.0 118.0 83.0 121.0 81.0 81.0 128.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:86.50 stddev:20.87 (24.1%) stddev-sans-first:21.85 17:04:57 INFO - PROCESS | 1684 | Values: 90.0 87.0 78.0 129.0 137.0 86.0 97.0 87.0 85.0 119.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:95.00 stddev:25.12 (26.4%) stddev-sans-first:25.85 17:04:57 INFO - PROCESS | 1684 | Values: 93.0 95.0 95.0 95.0 95.0 97.0 151.0 150.0 94.0 138.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:90.50 stddev:23.92 (26.4%) stddev-sans-first:24.99 17:04:57 INFO - PROCESS | 1684 | Values: 120.0 89.0 149.0 144.0 124.0 91.0 92.0 90.0 92.0 91.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:3.16 (5.5%) stddev-sans-first:3.12 17:04:57 INFO - PROCESS | 1684 | Values: 54.0 56.0 54.0 57.0 58.0 56.0 58.0 65.0 59.0 56.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:71.50 stddev:16.02 (22.4%) stddev-sans-first:16.45 17:04:57 INFO - PROCESS | 1684 | Values: 66.0 61.0 88.0 102.0 57.0 74.0 90.0 99.0 69.0 69.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:8.34 (9.8%) stddev-sans-first:8.75 17:04:57 INFO - PROCESS | 1684 | Values: 85.0 85.0 85.0 87.0 85.0 84.0 83.0 86.0 96.0 110.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:6.38 (4.7%) stddev-sans-first:6.75 17:04:57 INFO - PROCESS | 1684 | Values: 134.0 138.0 140.0 133.0 122.0 144.0 132.0 134.0 143.0 133.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:150.00 stddev:16.44 (11.0%) stddev-sans-first:17.24 17:04:57 INFO - PROCESS | 1684 | Values: 145.0 187.0 151.0 137.0 149.0 158.0 173.0 137.0 142.0 141.0 17:04:57 INFO - PROCESS | 1684 | 17:04:57 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.69 (2.5%) stddev-sans-first:1.79 17:04:57 INFO - PROCESS | 1684 | Values: 68.0 68.0 66.0 68.0 69.0 70.0 66.0 68.0 65.0 70.0 17:04:57 INFO - PROCESS | 1684 | -------- Summary: end -------- 17:04:57 INFO - PROCESS | 1684 | 17:04:58 INFO - TEST-INFO | 1684: exit 0 17:04:58 INFO - TEST-OK | kraken | took 59073ms 17:04:58 INFO - SUITE-END | took 1170s 17:04:59 INFO - Completed test suite (00:19:31) 17:04:59 INFO - javascript benchmark 17:04:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3527.453244747065, 3539.7876127432355, 3560.8397622107004, 3578.2485678007633, 3606.296772129436, 5698.316202055748, 5769.596128271022, 5778.739956701948, 5786.681732504716, 5795.130730390443, 5654.123610840326, 5681.460261275182, 5817.331006934204, 5823.06830907055, 5924.081767326072, 5223.660462069973, 5246.1606143017125, 5280.735963201843, 5290.0, 5308.654937429054, 5302.708351040691, 5308.814191503298, 5310.38930522989, 5334.866628334284, 5347.46525347466, 5241.895162096775, 5243.659162154467, 5319.281896943901, 5320.095583750772, 5323.866903327409, 5238.580913526908, 5270.683758974474, 5273.050850846846, 5273.525382715536, 5344.118220493614, 5140.820071297487, 5228.215767634847, 5255.789768409259, 5298.178782288752, 5301.01931142736, 4211.452511173558, 5657.830265092054, 5761.654300741969, 5770.480656740913, 5793.362730099686, 5209.322788037569, 6286.9056964145575, 6339.270983836872, 6340.904886426707, 6341.302456729756, 5296.867578310535, 6242.500599951993, 6272.811815645492, 6294.370562943669, 6316.589421687576, 5306.177542480922, 6008.128821320884, 6012.969935150296, 6016.368281330441, 6064.545159113084, 5496.148097044965, 6390.360963903572, 6396.392342727433, 6400.167978162902, 6409.807705768834, 6100.369238099044, 6159.938400615936, 6197.101420294032, 6265.8120256392385, 6284.37156284377, 6105.338445949952, 6187.133801267826, 6266.780662676784, 6296.968515157395, 6300.401461861115, 6274.372562743689, 6292.087647291117, 6325.399087086719, 6332.430081292706, 6340.334264902119, 5995.640261584232, 6181.907271390933, 6248.75004999804, 6307.274663413675, 6322.399372059647, 4916.360873086547, 4920.434150072716, 4948.0103979204305, 4978.8755281118265, 4980.028894365564, 4479.59683628475, 4483.417155769729, 4492.685512014193, 4507.549245075466, 4534.274516077412, 5677.83604361105, 5889.0, 5925.081612350093, 5940.287165540163, 5985.730642121115, 6265.337956661236, 6317.052442133625, 6349.46029587481, 6352.650604216812, 6358.872822543616, 5934.910976335358, 5962.34414214436, 5963.850903727442, 5979.01346277868, 6000.0999850022845, 5374.435684253175, 5444.210589464506, 5453.64551304164, 5477.4796394342475, 5531.3362396512675, 5314.574834013192, 6397.7440902364315, 6399.64801935898, 6419.45434638061, 6437.93774027299, 5867.354590995073, 6149.354317796746, 6314.652694101868, 6325.367463253638, 6327.0, 6360.681965901779, 6393.904091438539, 6430.807075787734, 6436.8390790230615, 6445.484361250995, 6204.503639708722, 6221.440070393686, 6221.9377806221355, 6241.469475094668, 6246.9062964054665, 6119.441623354484, 6226.719797609209, 6262.4990000800735, 6289.559730818799, 6306.243250809749, 6072.9372359837735, 6092.543059270661, 6154.78458253959, 6156.015037593964, 6226.688665566794, 4794.4486384064885, 5483.341998960151, 6170.259568851767, 6185.257769067741, 6214.5960512566535, 5777.3933736957015, 5858.531317494675, 6017.037274036134, 6067.302260239952, 6132.478739307209, 6163.137160797402, 6189.288231853395, 6199.597026193283, 6204.472619827185, 6211.751529938932, 6077.48341390969, 6101.84745381369, 6103.176071230327, 6112.786052488142, 6125.816225513242], "unit": "score", "name": "dojo.html", "value": 5743.244243870729}, {"lowerIsBetter": false, "replicates": [461.3633186203039, 537.4544836990455, 547.7206624621442, 586.6157666728293, 602.7137109872814, 37797.055073623174, 38553.22893542134, 38569.614303856986, 38607.42088868669, 38636.0, 39876.202475950464, 40060.0, 40368.79815600918, 40370.19259614813, 40373.59626403735, 9439.103285187895, 9593.184579310768, 9593.47235902025, 9645.807083858319, 9666.951665241664, 9480.383775054634, 9696.46669433181, 9722.125008749212, 9755.658551950683, 9762.0, 9682.12860842524, 9708.41749495029, 9708.854367184462, 9752.268579856503, 9772.511374431286, 9672.70981870545, 9703.369280996712, 9709.029097090304, 9717.028297170227, 9735.902640973605, 9613.951930240373, 9700.320977531575, 9714.417134971854, 9751.0736480035, 9754.219662426989, 39261.411078833844, 39455.60544394548, 39603.20793584112, 39762.80711578657, 39779.602203977876, 3356.647552007053, 3465.324261768956, 3788.981055094707, 3831.907906246734, 3849.8075096245075, 24846.37884052913, 28888.855555722297, 30047.849760751276, 30090.54864177039, 30759.38481230363, 2716.171567671859, 2731.1260396673074, 2766.1286694691307, 2803.523401021831, 2839.7870159738104, 496680.0, 501626.491867542, 501789.0, 501953.0, 504844.0, 40437.0, 45107.64677059693, 45238.095238095055, 46188.0, 66427.66786166039, 45208.86977825581, 45376.865578360805, 45457.54542454533, 45612.543874561496, 45809.31286030712, 13299.80301772845, 15793.21033948298, 15911.522654320388, 15945.20273986296, 16107.919460402858, 9624.66313679032, 11813.645590632295, 12004.799520047925, 12830.935845320713, 13072.803907941197, 14856.480023199136, 14894.03188792725, 14924.701505970037, 15034.924825375803, 15119.470818521298, 5315.229291752674, 5549.639273447213, 6472.223333200046, 6561.179852518435, 6610.4050635443045, 948.3266880514774, 1011.691434112588, 1075.3010543147018, 1080.6649938519083, 1155.8324043013884, 29272.24366537972, 29543.26141846471, 29587.546076226103, 30154.0, 30198.0, 1133.6712353417581, 1134.744682446443, 1143.5311522275827, 1184.5261895241972, 1188.0614314691297, 15087.47193848232, 15111.0, 15215.467458638894, 15328.540143795704, 15349.693006139814, 518230.0, 526097.0, 530242.0, 530430.6956930459, 530779.0, 58001.41998580044, 59142.70428647829, 60035.0, 60059.69970150121, 60190.69904650449, 1416.221078406872, 1433.0470237292293, 1444.8266208055102, 1461.4008256614736, 1463.597510684549, 29081.563776542946, 29181.854090729412, 29639.703602964557, 29791.85104074466, 29900.85049574825, 51883.0, 51912.74043629758, 51989.0, 52351.0, 52377.7381113092, 493272.0, 493764.0, 497093.0, 497307.0, 498358.0, 33525.16187095342, 33548.496772547944, 34052.489212661334, 34472.655273446944, 34542.82728586341, 44687.10625787531, 44974.0, 45165.64503064913, 45780.084398312516, 45965.310520341554, 37502.43746343862, 37954.2409151821, 37974.62025379711, 38497.87176978409, 39000.6099938997, 37264.813675931444, 37404.25191496209, 37917.86246412612, 38061.61938380581, 38288.23423531569, 28240.0, 36488.635113648525, 36791.63208367882, 37525.62474375221, 37623.623763762014, 30455.84772076214, 31144.377112457172, 31187.220319492193, 31238.531422028234, 31855.6814431862, 23127.0, 24499.38751531226, 24592.754072459764, 24667.061334341503, 24793.256202313958], "unit": "score", "name": "ext.html", "value": 19260.382862675284}, {"lowerIsBetter": false, "replicates": [351.3833222694173, 361.8299399282337, 369.76704676054084, 370.5201763715988, 370.5979012771143, 19621.0, 20233.39299821004, 21066.36800895972, 21407.892960535177, 21678.0, 20447.591048179027, 20524.589508209865, 20795.16819327225, 20889.895550522226, 20987.0, 5818.272715910512, 6055.485283750886, 6074.240719910012, 6078.240219972504, 6090.147379366892, 5699.2590963174725, 5754.625949313281, 5911.142884281777, 5977.0, 5980.132880732292, 4970.856702958322, 5502.119660854264, 5871.412858714137, 5900.970495147519, 5931.051031834907, 5069.7972081116895, 5644.125160600113, 5854.882902341972, 5896.5872388933, 5917.230760001173, 5496.422875598045, 5497.670139791625, 5614.410486898899, 5631.915521267184, 5638.85902852432, 13028.218306901616, 13236.86763132366, 17081.316747330093, 23455.765442345528, 24008.519829603483, 1587.7116286463665, 1991.4623051775939, 2000.1599328282157, 2049.7437820272467, 2220.4448887778058, 9373.812523749555, 9714.805703885953, 10031.89968100317, 10059.497025148714, 10101.393916365041, 1715.0395778364157, 1728.1013872786082, 1734.670412621598, 1775.849052830511, 1775.8934463932205, 102638.0, 113800.43099784531, 113925.0, 116667.41666291615, 116707.0, 11165.66503004895, 11261.831072533918, 11493.138014648935, 11523.07815374768, 11612.361320127306, 13897.444102235999, 13923.23422211788, 13945.233012184224, 13954.651133721534, 13977.930110349384, 8539.274161696201, 8633.136686331316, 8644.011877268138, 8675.609597568124, 8707.346948978726, 8679.17547832955, 8754.21212090915, 8774.912250877409, 8858.689945851993, 8888.911110888937, 4523.592876641118, 4542.136993971135, 4544.227481328182, 4546.158960592301, 4601.953980460153, 1877.755891734066, 1903.4955736729778, 1905.2188602673116, 1905.7808352039692, 1954.6286205620886, 778.9143194248628, 957.7988622389237, 961.2550273537925, 1005.215931573374, 1039.3296323871211, 14957.626059348604, 17317.0, 19579.706304405445, 20014.89992550028, 20027.799722002594, 808.401782680812, 821.3347188776991, 919.5907821019582, 970.4565443351604, 975.2734213011352, 8904.0, 10745.731356716145, 10854.294470859526, 10881.673549793519, 11011.724706882393, 605865.9706701438, 612763.0, 612892.0, 618084.0, 623042.0, 92360.0763992365, 93406.0, 112691.50652633347, 113460.43269783599, 115814.0, 1046.3460337289193, 1055.9260851740457, 1092.9234953553175, 1110.3337997201777, 1110.3559935237704, 16806.411775587796, 17902.731459027866, 17953.371631992817, 18150.0, 18297.908510457364, 43639.34540981824, 46090.30864537102, 49602.503974959785, 51105.74447127741, 53549.73225133849, 68545.31454685389, 71259.0, 71563.0, 72276.63861680658, 93398.53300733452, 5562.527185189304, 7805.375569954504, 7846.293833555007, 7860.3318717909615, 8123.5532045738055, 7223.674934628059, 8677.1756683115, 11348.602798901999, 11765.294032365431, 12682.429290681757, 10484.213683973885, 10797.514111865143, 10983.176261780558, 11007.669769906915, 11020.393878336768, 10572.0, 10579.36523808574, 10832.133429325477, 10911.83632245501, 11126.332420054823, 11020.50407731638, 11154.609588664358, 11276.210665253353, 11336.886631133582, 11470.483828227916, 7566.281203285899, 7898.763037108896, 7924.0, 8141.674333026849, 8183.63173657175, 10554.525046372779, 10832.350058996486, 10922.19580398665, 11105.222634415837, 11111.999920006914], "unit": "score", "name": "jquery.html", "value": 9193.115490002547}, {"lowerIsBetter": false, "replicates": [1557.4237532113116, 1586.3575252022931, 1670.9498715038553, 1727.7646482764821, 1963.1558429875165, 7931.8413631727335, 8466.830663386743, 8543.871841922368, 8781.999999999993, 8802.339824513163, 8525.531095789729, 8555.743327700164, 8647.827043459143, 8661.35039872009, 8666.696665616704, 2470.3700556358103, 2502.5245203411296, 2504.874756262189, 2505.1732928133674, 2526.393665520271, 2446.1438496526252, 2507.0723832182025, 2517.3958250020046, 2520.1179587144443, 2523.785478234343, 2478.950420991579, 2497.8001759859258, 2519.962200566993, 2529.84820910745, 2530.8861101250486, 2501.17461237792, 2513.3716570857287, 2514.094925826701, 2524.545581795276, 2534.6958364996135, 2247.763984781591, 2439.2804122783823, 2491.576432006545, 2515.72327044025, 2540.9364765880814, 8736.51949142797, 8821.779455513599, 8849.336299777478, 8854.645814167425, 8862.556872156367, 5408.648437851527, 5497.642653227567, 5535.806246781343, 5541.612087153901, 5562.749676264578, 3620.2759448110482, 3685.68671662909, 3742.176721121349, 3780.4518344839844, 3782.6406491383273, 950.8668786369914, 1028.331584470093, 1035.4667346316653, 1072.5495291977388, 1075.5643964194514, 10957.780844383067, 11801.232919860182, 11825.64523064301, 11829.881701182963, 11859.169858109935, 4837.032593481318, 4848.854534363974, 4964.776585053682, 4967.5032496750755, 4972.65191436596, 10044.397336159855, 10073.1437827784, 10080.344777589433, 10096.949515252376, 10119.089281964658, 4761.952380476151, 5345.904089661688, 5518.2826232589505, 5522.2544956431175, 5559.082751345983, 3789.6020917803785, 4679.742614156254, 4885.926711099336, 4920.75396230187, 4996.175631020841, 3907.9804600976813, 3944.2505923874373, 3986.7807270599815, 3997.060690737674, 4036.6367026967714, 1123.5225029362489, 1347.2926713475504, 1356.5319964612193, 1364.0519838712198, 1364.6315494816345, 1323.4706117553055, 1342.4026308292716, 1370.465518447806, 1385.058160450883, 1390.450771945076, 8031.598420078973, 8158.184181581794, 8173.141820108803, 8180.5909704515725, 8197.385196110316, 498.8229178641603, 501.2906736967151, 506.3973871093387, 512.7692538357754, 513.9049275883973, 6259.374062593704, 6262.091996660459, 6291.339409361951, 6291.9685401573615, 6292.685365731695, 10436.63471778484, 10609.628662996758, 10629.149668026539, 10719.678409647722, 10779.568817247378, 10426.322289051188, 10575.259731818698, 10580.994805493467, 10587.84118238227, 10592.841107383396, 8291.756236564564, 8336.24973752353, 8375.120612335739, 8420.663173473115, 8459.492430454193, 7804.414668899742, 7873.488223265469, 7879.84240315179, 7903.960480197562, 7921.762347129596, 9215.815683686424, 9562.856557151508, 9567.712968610953, 9568.4737339447, 9671.951640241754, 9415.529223538933, 9748.951255243679, 9906.950465247915, 10001.899981000097, 10013.497975303762, 6532.706028228836, 7311.780646580611, 7356.0, 7453.329200371993, 7523.172451030492, 8111.1888811118415, 8111.716089936824, 8137.104918458846, 8137.8372432552205, 8173.509589424653, 7226.168990566152, 7322.524035937647, 7329.780106596811, 7470.0, 7510.586917719578, 7049.894251586128, 7181.35367816899, 7193.676284567103, 7203.991441198132, 7213.1704853942465, 6285.779997700059, 7646.31183193493, 7668.846623067396, 7673.577953212627, 7683.385329173541, 6913.3777959983845, 6937.098177236927, 6948.305169483011, 6982.1272340957385, 7035.085438892911, 6998.16022077354, 7058.71765129389, 7073.115860517435, 7080.681369338289, 7091.397231235403], "unit": "score", "name": "mootools.html", "value": 4844.904973057077}, {"lowerIsBetter": false, "replicates": [304.36387949186195, 331.16381137627485, 332.14804027669044, 336.8282176090195, 338.97288216942655, 6334.429901308881, 6794.4224740897025, 6873.450123990081, 6878.552894061895, 6940.652967351625, 6811.182658081025, 6848.554843935153, 6868.6565671716335, 6887.242403335629, 6896.79309620711, 4810.97594512027, 4939.135651261033, 5064.594832413398, 5082.085224659569, 5097.5921926246, 5057.937833055063, 5080.720560369178, 5087.414947281054, 5091.7708703108265, 5129.333186685744, 5025.3969523657215, 5028.346314979048, 5031.886607624788, 5044.899102017957, 5045.066662667418, 5042.924356134661, 5050.520200580957, 5051.646384753032, 5053.949460505403, 5059.089363914494, 4326.891827704332, 4329.264025115738, 4330.978345108286, 4340.197063543254, 4344.174606824693, 6458.6770661466735, 6479.319671434479, 6599.1091202687985, 6679.632620205887, 6695.531312808105, 4850.563449289581, 5952.494038006775, 6020.819375418744, 6026.5178785697035, 6053.576249662526, 7316.743913962986, 7334.046573945407, 7343.706251749977, 7348.301911318416, 7382.593957332345, 4116.526599441043, 4121.91756164875, 4636.235021221528, 4808.8797780055775, 4890.682105663156, 7753.643112455354, 7756.185600511978, 7762.107357653942, 7774.689012439496, 7806.765797026042, 4007.3788562772816, 4798.184308667535, 4807.351007613997, 4814.903701926012, 4825.9034819304115, 4029.49631296088, 4835.540623640749, 4899.608031357554, 4906.460289368167, 4910.386201724785, 5836.970815145982, 5840.912386314209, 5898.882022359615, 5911.290645122527, 5918.201042859245, 5974.581779275496, 7028.824279392954, 7417.184109747924, 7418.888716669254, 7425.108986921496, 1676.069781271406, 1700.0819557439092, 1700.523853321072, 1702.208473060033, 1705.2667353038312, 1046.0585473074293, 1081.7944590527932, 1082.0, 1085.625459216569, 1104.2325583719237, 5552.555795536347, 6742.224644165984, 6769.898451523231, 6812.284710105368, 6835.043093966849, 6027.849303767441, 7433.959245705605, 7553.32020118181, 7567.243275672388, 7568.5458872467825, 6695.12963314766, 6905.37851593359, 6922.861542769117, 6944.687489063004, 6956.513044086865, 3246.6915643013876, 4054.0, 4062.878113656595, 4080.224757296104, 4087.080406908422, 7955.4033447491665, 7966.28303452692, 7975.680972761141, 7976.162502937224, 8005.0, 7668.463207575528, 7830.491018083806, 7864.449488535747, 7924.841503169904, 7928.5996272068405, 6379.170707807955, 7010.719571217196, 7388.0, 7941.761747147595, 7953.960230198812, 5512.751926163252, 5879.059350503899, 6484.28672845996, 6858.794236172923, 7674.501157424749, 7496.325330720261, 7505.0, 7537.660805263667, 7541.20817314196, 7547.962260188664, 6588.7364505421165, 7176.641167941686, 7503.536810321935, 7941.841163176588, 7952.681892724458, 3897.7466464679705, 4786.808527658994, 4809.831655892027, 4809.831655892027, 4831.468538460696, 7588.279113484431, 7636.007319048488, 7642.617869106633, 7649.426293028157, 7650.65572049248, 7306.159791624032, 7332.743353982585, 7334.0, 7341.77974660761, 7363.926360736324, 7132.964335178499, 7263.418926485762, 7328.926710732824, 7384.298491643285, 7405.740799072007, 7121.074260346122, 7170.569765814068, 7185.101862267216, 7202.567845929261, 7213.639318033972, 7351.66917488725, 7354.0, 7357.632118394166, 7358.1538123116525, 7371.520851144658, 5829.76680932758, 7151.141862976476, 7158.713651453883, 7166.856662866818, 7195.352418282379], "unit": "score", "name": "prototype.html", "value": 5278.543289754154}, {"lowerIsBetter": false, "replicates": [648.0764910003244, 665.1519312876082, 687.1650944102914, 732.4301019851927, 766.5247546521158, 14654.047486913356, 15042.323095460702, 17067.14664266785, 17441.30234790607, 17567.385141520048, 16216.83783162168, 16295.0, 16313.51059468215, 16338.01971881685, 16339.918300408512, 748.9363404110657, 914.6981496106303, 950.2493030505892, 950.9239260859115, 951.1914872358475, 925.676013395313, 938.9812203755921, 945.2013048973606, 946.4888959961612, 946.7585765629755, 986.595495846703, 990.128686755654, 992.5880759484805, 993.0913214408844, 993.3046867192994, 969.142309056483, 969.3408482232079, 973.4597298499366, 974.9463779492125, 980.4950450517989, 725.0972539188743, 728.7522242437597, 729.6716477585055, 729.8868675355276, 731.5756861020595, 15291.311890964822, 15418.614534636612, 15614.843851561453, 15616.063036217864, 15630.905836591442, 12646.367681615975, 12681.36593170347, 12813.10308278421, 12865.742685146339, 13007.349632518431, 10025.298229123964, 10096.899031009669, 10142.18862490999, 10182.28723989321, 10239.53922073501, 3168.621649582439, 3288.8684452621865, 3350.279689866666, 3470.8091054991964, 3483.3207524532727, 84900.0, 84996.57501712452, 85496.0, 85699.28601427999, 85905.0, 9258.398204116846, 9303.116203960613, 9313.580888860017, 9318.906810931803, 10134.746631334128, 21579.460513487287, 21580.784192158193, 21594.136234550442, 21649.0, 21697.0, 7240.348368646847, 7383.556986580822, 7453.2546745325035, 7582.658780354897, 7601.809954751065, 4091.774952377648, 4125.195586860534, 4129.483814523184, 4138.13099249155, 4138.565450627701, 3556.4309710446205, 3560.4481305397703, 3568.6252943441086, 3574.4459608760685, 3588.784672919633, 645.2643985856128, 655.9868802623921, 660.2934859700075, 660.3693472733528, 662.4303099334569, 434.9608535231844, 504.45518839653084, 585.519873703559, 587.9559033072537, 632.4813652804656, 7773.261540153676, 7799.649015794303, 7855.567943763148, 8079.111297757242, 8186.959065204755, 449.33722758930315, 503.61221859168967, 562.5274769193896, 623.0716232813076, 635.369569980282, 3729.9627003730157, 3866.6167103784187, 3873.1479074603544, 3893.727439079294, 3922.921541569153, 87383.0, 96371.51814241025, 96445.51777241069, 99102.50448747854, 99365.0, 71712.0, 72509.63745181345, 74435.0, 75032.62483687655, 75261.0, 65748.01377979238, 66593.66812663816, 67247.99999999903, 67471.0, 69178.30821691718, 7003.509754317352, 8286.295664868312, 8500.872486912578, 8566.143385661633, 8776.868346974928, 48017.27974080462, 48281.5171848277, 48352.758236208596, 48524.514754851996, 49346.75326623344, 62886.0, 63746.04380934197, 64079.03881441689, 65052.67473662602, 65154.0, 10796.0, 10812.135029197803, 10868.945655271673, 10878.347299162075, 11146.108311334912, 11654.766904662029, 11784.116191285517, 11813.350265735124, 11865.0, 11889.048876089719, 10909.727256818644, 11105.0, 11134.220604557604, 11278.097752179641, 11506.30962142274, 11128.387938663127, 11225.943870280596, 11386.715332116763, 11614.941925290319, 11995.580154694544, 10830.458477075957, 11048.502817373077, 11079.889201107886, 11329.263597866113, 11391.0, 9109.0, 9339.953300233727, 9427.62289508412, 9555.474448905377, 9614.086661767122, 7219.448471743232, 9293.767655808659, 9430.575624096795, 9441.480718560546, 9456.479893605918], "unit": "score", "name": "yui.html", "value": 6912.388438836809}], "name": "dromaeo_css", "value": 7512.611818558777}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 117.0, 114.0, 115.0, 125.0, 113.0, 116.0, 127.0, 167.0], "unit": "score", "name": "ai-astar", "value": 122.0}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 183.0, 174.0, 116.0, 155.0, 175.0, 151.0, 179.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 153.5}, {"lowerIsBetter": true, "replicates": [192.0, 201.0, 199.0, 205.0, 208.0, 235.0, 274.0, 200.0, 202.0, 201.0], "unit": "score", "name": "audio-dft", "value": 211.7}, {"lowerIsBetter": true, "replicates": [56.0, 68.0, 56.0, 60.0, 82.0, 68.0, 121.0, 58.0, 57.0, 64.0], "unit": "score", "name": "audio-fft", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 157.0, 114.0, 118.0, 83.0, 121.0, 81.0, 81.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 78.0, 129.0, 137.0, 86.0, 97.0, 87.0, 85.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.5}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 95.0, 95.0, 95.0, 97.0, 151.0, 150.0, 94.0, 138.0], "unit": "score", "name": "imaging-darkroom", "value": 110.3}, {"lowerIsBetter": true, "replicates": [120.0, 89.0, 149.0, 144.0, 124.0, 91.0, 92.0, 90.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 108.2}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 54.0, 57.0, 58.0, 56.0, 58.0, 65.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [66.0, 61.0, 88.0, 102.0, 57.0, 74.0, 90.0, 99.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 87.0, 85.0, 84.0, 83.0, 86.0, 96.0, 110.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [134.0, 138.0, 140.0, 133.0, 122.0, 144.0, 132.0, 134.0, 143.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.3}, {"lowerIsBetter": true, "replicates": [145.0, 187.0, 151.0, 137.0, 149.0, 158.0, 173.0, 137.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 68.0, 69.0, 70.0, 66.0, 68.0, 65.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1557.3999999999999}]} 17:04:59 INFO - Return code: 0 17:04:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:04:59 ERROR - # TBPL SUCCESS # 17:04:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:59 INFO - 2016-03-11 17:04:59.212 screenresolution[1689:10550] starting screenresolution argv=screenresolution get 17:04:59 INFO - 2016-03-11 17:04:59.215 screenresolution[1689:10550] Display 0: 1600x1200x32@60 17:04:59 INFO - 2016-03-11 17:04:59.220 screenresolution[1690:10554] starting screenresolution argv=screenresolution list 17:04:59 INFO - Available Modes on Display 0 17:04:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:59 INFO - Intel Iris: 17:04:59 INFO - Chipset Model: Intel Iris 17:04:59 INFO - Type: GPU 17:04:59 INFO - Bus: Built-In 17:04:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:59 INFO - Vendor: Intel (0x8086) 17:04:59 INFO - Device ID: 0x0a2e 17:04:59 INFO - Revision ID: 0x0009 17:04:59 INFO - Displays: 17:04:59 INFO - Display: 17:04:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:59 INFO - Display Serial Number: 1600x1200 60 17:04:59 INFO - Main Display: Yes 17:04:59 INFO - Mirror: Off 17:04:59 INFO - Online: Yes 17:04:59 INFO - Rotation: Supported 17:04:59 INFO - Return code: 0 17:04:59 INFO - Running post-action listener: _resource_record_post_action 17:04:59 INFO - Running post-run listener: _resource_record_post_run 17:05:00 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39392768; Write bytes: 708306432; Read time: 426; Write time: 2100 17:05:00 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399696384; Write bytes: 393115648; Read time: 30151; Write time: 677 17:05:00 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37578240; Write bytes: 302155264; Read time: 407; Write time: 1326 17:05:00 INFO - Running post-run listener: _upload_blobber_files 17:05:00 INFO - Blob upload gear active. 17:05:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:05:00 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 17:05:00 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:05:00 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:05:00 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:05:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:02 INFO - (blobuploader) - INFO - Done attempting. 17:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:03 INFO - (blobuploader) - INFO - Done attempting. 17:05:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:03 INFO - Return code: 0 17:05:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:05:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/994f41ebd14af8fc8d4d2898a2dd61877766306cff3efe7e7bbfa7093cd88b6bf1ea2aa3edb8abdb80c714ae881da4de6e3b9a267c0fcb3f226a628f298612d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1b66c6821db9f849b9e6d57b1a25eb4c495fa44dc2fe3e4d46011fe2617874e512d58d21657179d9cf2ed3e03ce21d533cd0f506df4fad95cce9cd9abbac4"} 17:05:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:05:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:05:03 INFO - Contents: 17:05:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/994f41ebd14af8fc8d4d2898a2dd61877766306cff3efe7e7bbfa7093cd88b6bf1ea2aa3edb8abdb80c714ae881da4de6e3b9a267c0fcb3f226a628f298612d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1b66c6821db9f849b9e6d57b1a25eb4c495fa44dc2fe3e4d46011fe2617874e512d58d21657179d9cf2ed3e03ce21d533cd0f506df4fad95cce9cd9abbac4"} 17:05:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:03 INFO - Copying logs to upload dir... 17:05:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:05:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.671888 ========= master_lag: 7.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 17:05:10.883315) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 mins, 24 secs) (at 2016-03-11 17:05:10.892064) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/994f41ebd14af8fc8d4d2898a2dd61877766306cff3efe7e7bbfa7093cd88b6bf1ea2aa3edb8abdb80c714ae881da4de6e3b9a267c0fcb3f226a628f298612d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1b66c6821db9f849b9e6d57b1a25eb4c495fa44dc2fe3e4d46011fe2617874e512d58d21657179d9cf2ed3e03ce21d533cd0f506df4fad95cce9cd9abbac4"} build_url:https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/NS2oSpglSECAHDwM5Va9kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/994f41ebd14af8fc8d4d2898a2dd61877766306cff3efe7e7bbfa7093cd88b6bf1ea2aa3edb8abdb80c714ae881da4de6e3b9a267c0fcb3f226a628f298612d1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f2a1b66c6821db9f849b9e6d57b1a25eb4c495fa44dc2fe3e4d46011fe2617874e512d58d21657179d9cf2ed3e03ce21d533cd0f506df4fad95cce9cd9abbac4"}' ========= master_lag: 84.97 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 mins, 24 secs) (at 2016-03-11 17:06:35.871877) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-11 17:06:35.872198) ========= 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.9o84hIWGQc/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.xpNA1nM1c3/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005600 ========= master_lag: 9.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-11 17:06:45.320380) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-11 17:06:45.320677) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-11 17:06:48.897437) ========= ========= Total master_lag: 102.42 =========