builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0116 starttime: 1458647533.41 results: success (0) buildid: 20160322035003 builduid: 49bff8b39ad84fbeaa5490fab8e5f1a4 revision: 792ec1f6bbbf0ef816f0d6d395557928027f82a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.412494) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.412893) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.413184) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005314 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.443447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.443744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.472402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.472687) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.006096 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.521122) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.523442) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.523798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.524084) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-22 04:52:13-- 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% 7.12M=0.002s 2016-03-22 04:52:13 (7.12 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125575 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.677844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.678158) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.027289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:13.731276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 04:52:13.731642) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 792ec1f6bbbf0ef816f0d6d395557928027f82a2 --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 792ec1f6bbbf0ef816f0d6d395557928027f82a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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-22 04:52:13,833 truncating revision to first 12 chars 2016-03-22 04:52:13,833 Setting DEBUG logging. 2016-03-22 04:52:13,833 attempt 1/10 2016-03-22 04:52:13,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/792ec1f6bbbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 04:52:14,836 unpacking tar archive at: fx-team-792ec1f6bbbf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253641 ========= master_lag: 1.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-22 04:52:16.406499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:16.406847) ========= echo 792ec1f6bbbf0ef816f0d6d395557928027f82a2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'792ec1f6bbbf0ef816f0d6d395557928027f82a2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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 792ec1f6bbbf0ef816f0d6d395557928027f82a2 program finished with exit code 0 elapsedTime=0.007189 script_repo_revision: '792ec1f6bbbf0ef816f0d6d395557928027f82a2' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:16.448983) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:16.449319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:52:16.469486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-22 04:52:16.469808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:52:16 INFO - MultiFileLogger online at 20160322 04:52:16 in /builds/slave/test 04:52:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:16 INFO - {'append_to_log': False, 04:52:16 INFO - 'base_work_dir': '/builds/slave/test', 04:52:16 INFO - 'blob_upload_branch': 'Fx-Team', 04:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:16 INFO - 'branch': 'Fx-Team', 04:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:16 INFO - 'config_files': ('talos/mac_config.py',), 04:52:16 INFO - 'default_actions': ('clobber', 04:52:16 INFO - 'read-buildbot-config', 04:52:16 INFO - 'download-and-extract', 04:52:16 INFO - 'populate-webroot', 04:52:16 INFO - 'create-virtualenv', 04:52:16 INFO - 'install', 04:52:16 INFO - 'run-tests'), 04:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:16 INFO - 'download_minidump_stackwalk': True, 04:52:16 INFO - 'download_symbols': 'ondemand', 04:52:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:16 INFO - 'installer_path': 'installer.exe', 04:52:16 INFO - 'log_level': 'info', 04:52:16 INFO - 'log_name': 'talos', 04:52:16 INFO - 'log_to_console': True, 04:52:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:52:16 INFO - 'opt_config_files': (), 04:52:16 INFO - 'pip_index': False, 04:52:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:16 INFO - 'cmd': ('bash', 04:52:16 INFO - '-c', 04:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:16 INFO - 'enabled': True, 04:52:16 INFO - 'halt_on_failure': False, 04:52:16 INFO - 'name': 'check_screen_resolution'},), 04:52:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:16 INFO - 'cmd': ('bash', 04:52:16 INFO - '-c', 04:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:16 INFO - 'enabled': True, 04:52:16 INFO - 'halt_on_failure': False, 04:52:16 INFO - 'name': 'check_screen_resolution'},), 04:52:16 INFO - 'run_cmd_checks_enabled': True, 04:52:16 INFO - 'sps_profile': False, 04:52:16 INFO - 'sps_profile_interval': 0, 04:52:16 INFO - 'suite': 'dromaeojs', 04:52:16 INFO - 'system_bits': '32', 04:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:16 INFO - 'title': 't-yosemite-r7-0116', 04:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:16 INFO - 'use_talos_json': True, 04:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:16 INFO - 'work_dir': 'build'} 04:52:16 INFO - ##### 04:52:16 INFO - ##### Running clobber step. 04:52:16 INFO - ##### 04:52:16 INFO - Running pre-action listener: _resource_record_pre_action 04:52:16 INFO - Running main action method: clobber 04:52:16 INFO - rmtree: /builds/slave/test/build 04:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:18 INFO - Running post-action listener: _resource_record_post_action 04:52:18 INFO - ##### 04:52:18 INFO - ##### Running read-buildbot-config step. 04:52:18 INFO - ##### 04:52:18 INFO - Running pre-action listener: _resource_record_pre_action 04:52:18 INFO - Running main action method: read_buildbot_config 04:52:18 INFO - Using buildbot properties: 04:52:18 INFO - { 04:52:18 INFO - "project": "", 04:52:18 INFO - "product": "firefox", 04:52:18 INFO - "script_repo_revision": "production", 04:52:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:52:18 INFO - "repository": "", 04:52:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:52:18 INFO - "buildid": "20160322035003", 04:52:18 INFO - "pgo_build": "False", 04:52:18 INFO - "basedir": "/builds/slave/test", 04:52:18 INFO - "buildnumber": 602, 04:52:18 INFO - "slavename": "t-yosemite-r7-0116", 04:52:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:52:18 INFO - "platform": "yosemite_r7", 04:52:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:52:18 INFO - "branch": "fx-team", 04:52:18 INFO - "repo_path": "integration/fx-team", 04:52:18 INFO - "revision": "792ec1f6bbbf0ef816f0d6d395557928027f82a2", 04:52:18 INFO - "stage_platform": "macosx64", 04:52:18 INFO - "builduid": "49bff8b39ad84fbeaa5490fab8e5f1a4", 04:52:18 INFO - "slavebuilddir": "test" 04:52:18 INFO - } 04:52:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:52:18 INFO - Running post-action listener: _resource_record_post_action 04:52:18 INFO - ##### 04:52:18 INFO - ##### Running download-and-extract step. 04:52:18 INFO - ##### 04:52:18 INFO - Running pre-action listener: _resource_record_pre_action 04:52:18 INFO - Running main action method: download_and_extract 04:52:18 INFO - mkdir: /builds/slave/test/build/tests 04:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:18 INFO - https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:20 INFO - Downloaded 1199 bytes. 04:52:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:52:20 INFO - Using the following test package requirements: 04:52:20 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:52:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:52:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'jsshell-mac.zip'], 04:52:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:52:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:52:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:52:20 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:52:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:52:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:52:20 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:20 INFO - https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:21 INFO - Downloaded 17858438 bytes. 04:52:21 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'] 04:52:21 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 04:52:24 INFO - Return code: 0 04:52:24 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 04:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:24 INFO - https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:26 INFO - Downloaded 17858438 bytes. 04:52:26 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'] 04:52:26 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 04:52:29 INFO - Return code: 0 04:52: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')]} 04:52:29 INFO - https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:32 INFO - Downloaded 10847637 bytes. 04:52:32 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'] 04:52:32 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 04:52:32 INFO - Return code: 0 04:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:32 INFO - https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MCJZ81mHRl62xOeEkirUyA/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 04:52:35 INFO - Downloaded 111262112 bytes. 04:52:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:52:35 INFO - mkdir: /builds/slave/test/properties 04:52:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:35 INFO - Contents: 04:52:35 INFO - build_url:https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:52:36 INFO - Running post-action listener: _resource_record_post_action 04:52:36 INFO - Running post-action listener: set_extra_try_arguments 04:52:36 INFO - ##### 04:52:36 INFO - ##### Running populate-webroot step. 04:52:36 INFO - ##### 04:52:36 INFO - Running pre-action listener: _resource_record_pre_action 04:52:36 INFO - Running main action method: populate_webroot 04:52:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:36 INFO - '--tppagecycles', 04:52:36 INFO - '7'], 04:52:36 INFO - 'tests': ['tsvgm']}}, 04:52:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:52:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:52:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'tests': ['damp', 'tps']}, 04:52:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['damp', 'tps']}, 04:52:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:52:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:36 INFO - 'other': {'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'other_l64': {'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'other_nol64': {'tests': ['a11yr', 04:52:36 INFO - 'ts_paint', 04:52:36 INFO - 'tpaint', 04:52:36 INFO - 'sessionrestore', 04:52:36 INFO - 'sessionrestore_no_auto_restore', 04:52:36 INFO - 'tabpaint']}, 04:52:36 INFO - 'svgr': {'tests': ['tsvgx', 04:52:36 INFO - 'tsvgr_opacity', 04:52:36 INFO - 'tart', 04:52:36 INFO - 'tscrollx', 04:52:36 INFO - 'cart']}, 04:52:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['tsvgx', 04:52:36 INFO - 'tsvgr_opacity', 04:52:36 INFO - 'tart', 04:52:36 INFO - 'tscrollx', 04:52:36 INFO - 'cart']}, 04:52:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'tests': ['tp5o']}, 04:52:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'talos_options': ['--e10s'], 04:52:36 INFO - 'tests': ['tp5o']}, 04:52:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'talos_options': ['--xperf_path', 04:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:36 INFO - 'tests': ['tp5n']}, 04:52:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:52:36 INFO - 'talos_options': ['--e10s', 04:52:36 INFO - '--xperf_path', 04:52:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:36 INFO - 'tests': ['tp5n']}}, 04:52:36 INFO - 'talos.zip': {'path': '', 04:52:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:36 INFO - Running post-action listener: _resource_record_post_action 04:52:36 INFO - ##### 04:52:36 INFO - ##### Running create-virtualenv step. 04:52:36 INFO - ##### 04:52:36 INFO - Running pre-action listener: _resource_record_pre_action 04:52:36 INFO - Running main action method: create_virtualenv 04:52:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:52:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:36 INFO - Using real prefix '/tools/python27' 04:52:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:40 INFO - Installing pip.................done. 04:52:40 INFO - Return code: 0 04:52:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:40 INFO - 'HOME': '/Users/cltbld', 04:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:40 INFO - 'LOGNAME': 'cltbld', 04:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:40 INFO - 'MOZ_NO_REMOTE': '1', 04:52:40 INFO - 'NO_EM_RESTART': '1', 04:52:40 INFO - 'PAGER': '/bin/cat', 04:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:40 INFO - 'PWD': '/builds/slave/test', 04:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:40 INFO - 'SHELL': '/bin/bash', 04:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:40 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:40 INFO - 'USER': 'cltbld', 04:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:40 INFO - 'XPC_FLAGS': '0x0', 04:52:40 INFO - 'XPC_SERVICE_NAME': '0', 04:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:52:40 INFO - Cleaning up... 04:52:40 INFO - Return code: 0 04:52:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:40 INFO - 'HOME': '/Users/cltbld', 04:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:40 INFO - 'LOGNAME': 'cltbld', 04:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:40 INFO - 'MOZ_NO_REMOTE': '1', 04:52:40 INFO - 'NO_EM_RESTART': '1', 04:52:40 INFO - 'PAGER': '/bin/cat', 04:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:40 INFO - 'PWD': '/builds/slave/test', 04:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:40 INFO - 'SHELL': '/bin/bash', 04:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:40 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:40 INFO - 'USER': 'cltbld', 04:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:40 INFO - 'XPC_FLAGS': '0x0', 04:52:40 INFO - 'XPC_SERVICE_NAME': '0', 04:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:41 INFO - Downloading/unpacking psutil>=0.7.1 04:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:44 INFO - Installing collected packages: psutil 04:52:44 INFO - Running setup.py install for psutil 04:52:44 INFO - building 'psutil._psutil_osx' extension 04:52:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:52:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:52:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:52:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:52:45 INFO - building 'psutil._psutil_posix' extension 04:52:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:52:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:52:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:52:45 INFO - ^ 04:52:45 INFO - 1 warning generated. 04:52:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:52:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:45 INFO - Successfully installed psutil 04:52:45 INFO - Cleaning up... 04:52:45 INFO - Return code: 0 04:52:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:45 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:52:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:45 INFO - 'HOME': '/Users/cltbld', 04:52:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:45 INFO - 'LOGNAME': 'cltbld', 04:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:45 INFO - 'MOZ_NO_REMOTE': '1', 04:52:45 INFO - 'NO_EM_RESTART': '1', 04:52:45 INFO - 'PAGER': '/bin/cat', 04:52:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:45 INFO - 'PWD': '/builds/slave/test', 04:52:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:45 INFO - 'SHELL': '/bin/bash', 04:52:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:45 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:45 INFO - 'USER': 'cltbld', 04:52:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:45 INFO - 'XPC_FLAGS': '0x0', 04:52:45 INFO - 'XPC_SERVICE_NAME': '0', 04:52:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:52:48 INFO - Installing collected packages: mozsystemmonitor 04:52:48 INFO - Running setup.py install for mozsystemmonitor 04:52:48 INFO - Successfully installed mozsystemmonitor 04:52:48 INFO - Cleaning up... 04:52:48 INFO - Return code: 0 04:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:48 INFO - 'HOME': '/Users/cltbld', 04:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:48 INFO - 'LOGNAME': 'cltbld', 04:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:48 INFO - 'MOZ_NO_REMOTE': '1', 04:52:48 INFO - 'NO_EM_RESTART': '1', 04:52:48 INFO - 'PAGER': '/bin/cat', 04:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:48 INFO - 'PWD': '/builds/slave/test', 04:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:48 INFO - 'SHELL': '/bin/bash', 04:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:48 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:48 INFO - 'USER': 'cltbld', 04:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:48 INFO - 'XPC_FLAGS': '0x0', 04:52:48 INFO - 'XPC_SERVICE_NAME': '0', 04:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - Downloading docopt-0.6.1.tar.gz 04:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:52 INFO - Running setup.py install for blobuploader 04:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:52 INFO - Running setup.py install for requests 04:52:53 INFO - Running setup.py install for docopt 04:52:53 INFO - Successfully installed blobuploader requests docopt 04:52:53 INFO - Cleaning up... 04:52:53 INFO - Return code: 0 04:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:53 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:53 INFO - 'HOME': '/Users/cltbld', 04:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:53 INFO - 'LOGNAME': 'cltbld', 04:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:53 INFO - 'MOZ_NO_REMOTE': '1', 04:52:53 INFO - 'NO_EM_RESTART': '1', 04:52:53 INFO - 'PAGER': '/bin/cat', 04:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:53 INFO - 'PWD': '/builds/slave/test', 04:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:53 INFO - 'SHELL': '/bin/bash', 04:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:53 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:53 INFO - 'USER': 'cltbld', 04:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:53 INFO - 'XPC_FLAGS': '0x0', 04:52:53 INFO - 'XPC_SERVICE_NAME': '0', 04:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-McYHU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6xHygI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-FbMzvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:53 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-XP48Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-GatUcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-R4ec5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6Pn8Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-wNVfpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9r0BeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Lh2I4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-UVKPws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4YwqpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-4Hw5PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:54 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-aQOW31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dFVTTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-K5HiQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:55 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-O7atRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:55 INFO - Running setup.py install for manifestparser 04:52:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:55 INFO - Running setup.py install for mozcrash 04:52:55 INFO - Running setup.py install for mozdebug 04:52:55 INFO - Running setup.py install for mozdevice 04:52:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:55 INFO - Running setup.py install for mozfile 04:52:56 INFO - Running setup.py install for mozhttpd 04:52:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozinfo 04:52:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozInstall 04:52:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozleak 04:52:56 INFO - Running setup.py install for mozlog 04:52:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for moznetwork 04:52:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozprocess 04:52:57 INFO - Running setup.py install for mozprofile 04:52:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozrunner 04:52:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozscreenshot 04:52:57 INFO - Running setup.py install for moztest 04:52:57 INFO - Running setup.py install for mozversion 04:52:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:57 INFO - Cleaning up... 04:52:57 INFO - Return code: 0 04:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:57 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:52:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:52:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:57 INFO - 'HOME': '/Users/cltbld', 04:52:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:57 INFO - 'LOGNAME': 'cltbld', 04:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:57 INFO - 'MOZ_NO_REMOTE': '1', 04:52:57 INFO - 'NO_EM_RESTART': '1', 04:52:57 INFO - 'PAGER': '/bin/cat', 04:52:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:57 INFO - 'PWD': '/builds/slave/test', 04:52:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:57 INFO - 'SHELL': '/bin/bash', 04:52:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:52:57 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:52:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:57 INFO - 'USER': 'cltbld', 04:52:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:57 INFO - 'XPC_FLAGS': '0x0', 04:52:57 INFO - 'XPC_SERVICE_NAME': '0', 04:52:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-LJOhEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-RnKCdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:58 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)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-K8QDed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-2ccR5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-cN1crP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-n3f16e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-X8DHcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:58 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-tbqSyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-R9eZR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-8H_LEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-uOIW_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-B0YZOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-jqrfyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ZljyMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-YKU3kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qwoFz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:59 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-5uIysD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:53:00 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)) 04:53:00 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)) 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:02 INFO - Downloading blessings-1.6.tar.gz 04:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:02 INFO - Installing collected packages: blessings 04:53:02 INFO - Running setup.py install for blessings 04:53:02 INFO - Successfully installed blessings 04:53:02 INFO - Cleaning up... 04:53:02 INFO - Return code: 0 04:53:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:03 INFO - Reading from file tmpfile_stdout 04:53:03 INFO - Current package versions: 04:53:03 INFO - blessings == 1.6 04:53:03 INFO - blobuploader == 1.2.4 04:53:03 INFO - docopt == 0.6.1 04:53:03 INFO - manifestparser == 1.1 04:53:03 INFO - mozInstall == 1.12 04:53:03 INFO - mozcrash == 0.17 04:53:03 INFO - mozdebug == 0.1 04:53:03 INFO - mozdevice == 0.48 04:53:03 INFO - mozfile == 1.2 04:53:03 INFO - mozhttpd == 0.7 04:53:03 INFO - mozinfo == 0.9 04:53:03 INFO - mozleak == 0.1 04:53:03 INFO - mozlog == 3.1 04:53:03 INFO - moznetwork == 0.27 04:53:03 INFO - mozprocess == 0.22 04:53:03 INFO - mozprofile == 0.28 04:53:03 INFO - mozrunner == 6.11 04:53:03 INFO - mozscreenshot == 0.1 04:53:03 INFO - mozsystemmonitor == 0.0 04:53:03 INFO - moztest == 0.7 04:53:03 INFO - mozversion == 1.4 04:53:03 INFO - psutil == 3.1.1 04:53:03 INFO - requests == 1.2.3 04:53:03 INFO - wsgiref == 0.1.2 04:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:03 INFO - 'HOME': '/Users/cltbld', 04:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PAGER': '/bin/cat', 04:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test', 04:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:53:03 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - 'XPC_FLAGS': '0x0', 04:53:03 INFO - 'XPC_SERVICE_NAME': '0', 04:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:53:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:53:03 INFO - Cleaning up... 04:53:03 INFO - Return code: 0 04:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53: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')]} 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:03 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:03 INFO - 'HOME': '/Users/cltbld', 04:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:03 INFO - 'LOGNAME': 'cltbld', 04:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:03 INFO - 'MOZ_NO_REMOTE': '1', 04:53:03 INFO - 'NO_EM_RESTART': '1', 04:53:03 INFO - 'PAGER': '/bin/cat', 04:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:03 INFO - 'PWD': '/builds/slave/test', 04:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:03 INFO - 'SHELL': '/bin/bash', 04:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:53:03 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:03 INFO - 'USER': 'cltbld', 04:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:03 INFO - 'XPC_FLAGS': '0x0', 04:53:03 INFO - 'XPC_SERVICE_NAME': '0', 04:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:03 INFO - Downloading/unpacking jsonschema 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:05 INFO - Downloading/unpacking functools32 (from jsonschema) 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:06 INFO - warning: no files found matching '*.txt' 04:53:06 INFO - no previously-included directories found matching 'build' 04:53:06 INFO - no previously-included directories found matching 'dist' 04:53:06 INFO - no previously-included directories found matching '.git*' 04:53:06 INFO - Installing collected packages: jsonschema, functools32 04:53:06 INFO - Running setup.py install for functools32 04:53:06 INFO - warning: no files found matching '*.txt' 04:53:06 INFO - no previously-included directories found matching 'build' 04:53:06 INFO - no previously-included directories found matching 'dist' 04:53:06 INFO - no previously-included directories found matching '.git*' 04:53:06 INFO - Successfully installed jsonschema functools32 04:53:06 INFO - Cleaning up... 04:53:06 INFO - Return code: 0 04:53:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:06 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 0x1018c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1018d9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce0ad6b040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, '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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:06 INFO - 'HOME': '/Users/cltbld', 04:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:06 INFO - 'LOGNAME': 'cltbld', 04:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:06 INFO - 'MOZ_NO_REMOTE': '1', 04:53:06 INFO - 'NO_EM_RESTART': '1', 04:53:06 INFO - 'PAGER': '/bin/cat', 04:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:06 INFO - 'PWD': '/builds/slave/test', 04:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:06 INFO - 'SHELL': '/bin/bash', 04:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:53:06 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:06 INFO - 'USER': 'cltbld', 04:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:06 INFO - 'XPC_FLAGS': '0x0', 04:53:06 INFO - 'XPC_SERVICE_NAME': '0', 04:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:06 INFO - Downloading/unpacking flake8 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:53:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:53:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:10 INFO - no previously-included directories found matching 'docs/_build' 04:53:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:53:10 INFO - Running setup.py install for pep8 04:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:53:10 INFO - no previously-included directories found matching 'docs/_build' 04:53:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:53:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:53:10 INFO - Cleaning up... 04:53:11 INFO - Return code: 0 04:53:11 INFO - Running post-action listener: _resource_record_post_action 04:53:11 INFO - Running post-action listener: _start_resource_monitoring 04:53:11 INFO - Starting resource monitoring. 04:53:11 INFO - ##### 04:53:11 INFO - ##### Running install step. 04:53:11 INFO - ##### 04:53:11 INFO - Running pre-action listener: _resource_record_pre_action 04:53:11 INFO - Running main action method: install 04:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:11 INFO - Reading from file tmpfile_stdout 04:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:11 INFO - Reading from file tmpfile_stdout 04:53:11 INFO - Output received: 04:53:11 INFO - Usage: mozinstall [options] installer 04:53:11 INFO - Options: 04:53:11 INFO - -h, --help show this help message and exit 04:53:11 INFO - -d DEST, --destination=DEST 04:53:11 INFO - Directory to install application into. [default: 04:53:11 INFO - "/builds/slave/test"] 04:53:11 INFO - --app=APP Application being installed. [default: firefox] 04:53:11 INFO - mkdir: /builds/slave/test/build/application 04:53:11 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'] 04:53:11 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 04:53:45 INFO - Reading from file tmpfile_stdout 04:53:45 INFO - Output received: 04:53:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:45 INFO - Running post-action listener: _resource_record_post_action 04:53:45 INFO - ##### 04:53:45 INFO - ##### Running run-tests step. 04:53:45 INFO - ##### 04:53:45 INFO - Running pre-action listener: _resource_record_pre_action 04:53:45 INFO - Running main action method: run_tests 04:53:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:45 INFO - 2016-03-22 04:53:45.525 screenresolution[1647:7560] starting screenresolution argv=screenresolution get 04:53:45 INFO - 2016-03-22 04:53:45.528 screenresolution[1647:7560] Display 0: 1600x1200x32@60 04:53:45 INFO - 2016-03-22 04:53:45.534 screenresolution[1648:7562] starting screenresolution argv=screenresolution list 04:53:45 INFO - Available Modes on Display 0 04:53:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:45 INFO - Intel Iris: 04:53:45 INFO - Chipset Model: Intel Iris 04:53:45 INFO - Type: GPU 04:53:45 INFO - Bus: Built-In 04:53:45 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:45 INFO - Vendor: Intel (0x8086) 04:53:45 INFO - Device ID: 0x0a2e 04:53:45 INFO - Revision ID: 0x0009 04:53:45 INFO - Displays: 04:53:45 INFO - Display: 04:53:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:45 INFO - Display Serial Number: 1600x1200 60 04:53:45 INFO - Main Display: Yes 04:53:45 INFO - Mirror: Off 04:53:45 INFO - Online: Yes 04:53:45 INFO - Rotation: Supported 04:53:45 INFO - Return code: 0 04:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:45 INFO - Python 2.7.3 04:53:45 INFO - Return code: 0 04:53:45 INFO - grabbing minidump binary from tooltool 04:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:53:45 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 0x101768e00>, '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 0x101591db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101763b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:53:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:53:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:45 INFO - Return code: 0 04:53:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:53:47 INFO - Return code: 0 04:53:47 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:53:47 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j9kdkbPBnF/Render', 04:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:47 INFO - 'HOME': '/Users/cltbld', 04:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:47 INFO - 'LOGNAME': 'cltbld', 04:53:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:47 INFO - 'MOZ_NO_REMOTE': '1', 04:53:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:47 INFO - 'NO_EM_RESTART': '1', 04:53:47 INFO - 'PAGER': '/bin/cat', 04:53:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:47 INFO - 'PWD': '/builds/slave/test', 04:53:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:47 INFO - 'SHELL': '/bin/bash', 04:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kAKbOUoZX/Listeners', 04:53:47 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 04:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:47 INFO - 'USER': 'cltbld', 04:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:47 INFO - 'XPC_FLAGS': '0x0', 04:53:47 INFO - 'XPC_SERVICE_NAME': '0', 04:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:53:47 INFO - mozversion application_buildid: 20160322035003 04:53:47 INFO - mozversion application_changeset: 792ec1f6bbbf0ef816f0d6d395557928027f82a2 04:53:47 INFO - mozversion application_display_name: Nightly 04:53:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:47 INFO - mozversion application_name: Firefox 04:53:47 INFO - mozversion application_remotingname: firefox 04:53:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:53:47 INFO - mozversion application_vendor: Mozilla 04:53:47 INFO - mozversion application_version: 48.0a1 04:53:47 INFO - mozversion platform_buildid: 20160322035003 04:53:47 INFO - mozversion platform_changeset: 792ec1f6bbbf0ef816f0d6d395557928027f82a2 04:53:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:53:47 INFO - mozversion platform_version: 48.0a1 04:53:47 INFO - using testdate: 1458647627 04:53:47 INFO - actual date: 1458647627 04:53:47 INFO - starting webserver on 'localhost:49281' 04:53:47 INFO - SUITE-START | Running 2 tests 04:53:47 INFO - TEST-START | dromaeo_css 04:53:47 INFO - operating with platform_type : mac_ 04:53:47 INFO - Initialising browser for dromaeo_css test... 04:53:47 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpyj3G6w/profile http://localhost:49281/getInfo.html) 04:53:49 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 04:53:49 INFO - PROCESS | 1666 | colorDepth:24 04:53:49 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 04:53:49 INFO - PROCESS | 1666 | __metrics 04:53:49 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:49 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:53:50 INFO - TEST-INFO | 1666: exit 0 04:53:50 INFO - Browser initialized. 04:53:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpyj3G6w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:02 INFO - PROCESS | 1669 | RSS: Main: 247373824 04:54:02 INFO - PROCESS | 1669 | 04:54:53 INFO - PROCESS | 1669 | 1458647693393 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:57:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 04:57:05 INFO - PROCESS | 1669 | RSS: Main: 337944576 04:57:05 INFO - PROCESS | 1669 | 05:00:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 05:00:08 INFO - PROCESS | 1669 | RSS: Main: 380772352 05:00:08 INFO - PROCESS | 1669 | 05:03:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 05:03:11 INFO - PROCESS | 1669 | RSS: Main: 372502528 05:03:11 INFO - PROCESS | 1669 | 05:06:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 05:06:13 INFO - PROCESS | 1669 | RSS: Main: 333250560 05:06:13 INFO - PROCESS | 1669 | 05:09:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 05:09:17 INFO - PROCESS | 1669 | RSS: Main: 332976128 05:09:17 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 05:12:20 INFO - PROCESS | 1669 | RSS: Main: 443711488 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | __start_tp_report 05:12:20 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 05:12:20 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 05:12:20 INFO - PROCESS | 1669 | |i|pagename|runs| 05:12:20 INFO - PROCESS | 1669 | |0;dojo.html;3455.533502977098;3491.4064609016464;3492.458668906317;3539.5398598182232;3574.249407624399;5534.529564986981;5602.635828671134;5617.578681598881;5641.605087643867;5695.202671625976;4856.975715121428;5608.2428872102255;5646.576506761989;5647.887042259153;5782.479576838084;5031.245313203012;5061.898762024757;5086.3387759591205;5097;5186.818461353853;5204.479552044803;5238.345206849144;5241.292425522563;5285.814996475124;5288.048151332759;5061.721605311706;5100.209467532539;5140.023395554833;5144.6913185209005;5175.404828444739;5139.511746384088;5149.794008239666;5172.431032586413;5177.559907407875;5186.818461353834;5089.134847076006;5105.183170692671;5121.180611102206;5127.307813445212;5154.175331946871;5434.239206511092;5516.779328826842;5543.556515478752;5558.44415558445;5562.193481945135;6099.878002439971;6103.792276408629;6104.755809767604;6121.326654068049;6130.754769809202;6149.200603921461;6157.384261573851;6180.505559555225;6197.070439434121;6256.1866957295715;5715.485606295453;5767.279090113736;5769.826905192851;5779.133130030487;5813.418658134195;6169.444749972435;6237.313895471494;6244.937550624436;6247.062940558862;6247.250329960434;5984.102384642251;6042.615606431687;6083.7566497340495;6134.325224225332;6146.262448506208;4837.879053023703;6260.843478913063;6264.467520260829;6267.749290028439;6278.905816412757;5948.345681974979;6182.536309776785;6199.442050215503;6224.470919971763;6232.345603711545;5161.406438259648;6101.237345331833;6137.003815650162;6177.722002509898;6185.103160041769;4881.219004959189;4893.192623217129;4908;4911.582515486152;4930.654854160174;4385.978070109692;4386.956130438719;4387.561243875651;4388.27593447084;4433.645308375322;5621.18492818539;5683.318001839806;5708.457696518824;5735.254416925856;5803.47768700819;5867.266591676041;6230.06549017651;6260.40526150015;6270.372962703693;6277.435030847154;5619.494245517923;5688.9715551422805;5721.113227449752;5739.799107031234;5740.712964351766;5274.973625131926;5302.575793936476;5322.494363035506;5328.307320048369;5375;6285.182926219653;6294.937050629435;6310.05349197624;6316.526260530387;6323.36766323364;6247.0629405589525;6267.811965640855;6272.435480806749;6282.434580887742;6300.117983482408;6183.598066125687;6235.688215589112;6289.182406287154;6300.810975670737;6303.36966303366;6110.480609148272;6172.938270617236;6176;6181.938180618316;6209.627422354673;6218.378162183926;6262.812115636538;6272.153259310117;6286.339934306832;6304.936950630618;5893.116032595145;5995.190649262294;6094.481969032682;6130.122981477994;6141.424638644238;6097.917917222819;6123.83172914054;6124.319907527481;6130.214697154755;6132.171952247653;5173.430922598436;5953;5954.493868021266;5972.313183983897;6004.219451471281;5939.881202376015;6012.308584512837;6033.75864965414;6125.877482450415;6129.111278864629;5940.46535811779;5955.791547295824;5962.165296858357;5988.191594134736;6000.909986350295 05:12:20 INFO - PROCESS | 1669 | |1;ext.html;562.9360508638671;566.4986486959043;587.6885250817065;621.5990686007525;634.3561285295425;39098.80450597747;39588.80205598975;39626.40560391596;39663.206735865264;39871.00322491939;38023.049423764416;39951;42295.15409691804;42904;42972.78513607428;9477.383970041943;9714.708558743214;9722.902770972305;9734.172595329406;9738.220942324597;9620.903790962106;9757.560909759042;9775.169110625606;9779.315447918649;9821.558029888636;9840.21278297738;9901.405915645084;9902.30683852127;9915.405075695446;9919.256055795844;9792.11870931616;9876.456794876314;9877.160441362494;9886.159676427513;9888.258380621483;9659.71020869375;9780.951095244549;9794.216462682969;9794.412335259836;9810.215182785432;41868.74393768192;42155.156896862194;42197.367039494435;42213.1557368854;42258;3251.7723759336855;3269.362474317509;3283.169640407621;3284.490903909898;3464.6419059994028;28813;29852.701472985427;29883.10350689461;29914.700852991627;29931;2746.780257579409;2767.349672826884;2823.68939416664;2885.5960165576835;2918.7810914181523;378728.99999999726;379282;379895;380043;381356;60637.09044364338;61717.69141154355;68659;69115;69548.6522567384;74147;74848.62575687196;74961.25038749543;75018;75040.87438688424;17088.572785680208;17438.564035899202;17497.737533936746;17515.56211094733;17530.386436474662;11718.23831450953;12950.287734174522;13117.868821311664;13143.948484121438;13183.406746696422;21500.139994400048;22007;22021.559568808534;22041.889790550944;22059.889700551394;8520.914790852135;8695.304375649934;8697.782555436039;8724.476531408009;8796.47221166732;926.3700683535126;937.6952490440498;1003.9196864250843;1024.5543188712934;1108.8613923259593;25888.8705556471;29337.706622933925;29599.556006659917;30184.54723179154;30235.546466803014;1088.080571916729;1112.5382966069153;1117.7038084907506;1126.0878688262533;1219.1892391559513;13053.34733263333;14416.351264193136;14879.03286286388;15129.167895765839;15603.765943510856;502245;505753;508236;509277;510088;61356.69321653363;61578.38421615727;61725.765484690055;61780;61851.38148618546;1183.5325046606715;1356.193065126268;1368.4526189524072;1475.6237159524253;1495.461633811827;28442;28720.85639571789;28965.13104606865;29128.70871291345;29172.854135729187;47495.76252118717;47801;48164.518354816006;48270;48302.5169748298;311062;312255;313439;314035.8596414007;314408;29130.708692913646;31286.53070203994;32901.83549082239;33075;33583.32833343368;41525;42226;42412.78793606012;42603.57396425996;43134.137317254106;33956.830215848764;34944.30111397707;35146.82426587851;35837;35848.82075589606;34897.65102348944;34990.47514287339;35285.82357088301;35667.286654267285;35721.642783571835;36101;36225.45661815128;36478.905632831054;36990.815045924595;37207.069823254635;28714.717991963556;31402.05793826189;32249;32277;32359.352812944082;23338.883305583364;24188.63717044281;24413.51172976495;24467;24553.140640077512 05:12:20 INFO - PROCESS | 1669 | |2;jquery.html;354.4700672494619;358.41220398546386;363.1303029244958;368.7861040596454;368.78794693051503;19153.616927661456;19611.5097122572;21168.57662846746;21186.788132118712;21223.36329910103;12355.876441235585;17508.774385793;19778.91215983124;20286.28997985071;20317;5126.102931986897;5284.180951952434;5334.359876814788;5343.305370301875;5352.946470535303;3286.474164133739;4127.607877251657;5287.259783630295;5725.255716756816;5943.554233432488;6012.879742405149;6024.09638554216;6033.577649564532;6038.758449662008;6040.879182416349;4875.464228767927;5452.59105567082;5715.971420142914;5724.16999535065;5989.101634754778;3786.2048969716393;5404.891902161974;5477.890442191134;5645.971770141164;5658.971705141489;13610.319484025758;13652.931735341359;13787.448502060006;13791.10357826738;13808.309584520734;2024.1903238704488;2054.815066643994;2157.072458842697;2304.366299267698;2592.6240695099104;9694.660686875926;9782;10017.949910250474;10133.746656333577;14127.869770418341;1678.8321167883237;1778.6798376292263;1836.9265229390808;1848.2976468941852;1852.4257480181186;95372;103789.48105259502;107465.92534074637;109102;115655.42172289168;9144.948330941894;9772.657956971472;11000.174986876016;11205.60780372683;11694.941525292319;13846.446142154202;13954.441822327197;13977;13982.091164074303;13988.440462381594;8273;8765.956170219108;8815.074417186232;8846.778830529289;8877;8928.598213080297;8929.151730585583;8936.195742383217;9045.32160087996;9050.683226087056;4470.508244093147;4554.521775213621;4560.384348113029;4569.817207311737;4592.655550833634;1655.1062426289668;1743.3636722596414;1815.5549967209568;1920.7983161768093;1959.0400703655391;869.2611280411726;927.7216834949488;995.4773743784571;1004.9547770350351;1013.5793645637126;19541.413757587296;20800;20820.958952052337;20912.163513459596;20959.246741187115;929.0894922975522;950.7147855643279;962.43216502264;1024.3700124423426;1046.304207701885;11036.613718519813;11211.719707007227;11216.327020378803;11220.719482013015;11221.270617409842;586791;589563;592962;609086;609837;91008;112122.43938780254;115045;115101;115648.84351156549;936.9718908432621;1018.4398580780542;1049.4070849969742;1080.5947769586248;1081.648464249122;18017.189226484577;18431.907840460713;19051.90474047621;19059.714104288723;19318.903405482884;49986.25020624621;51035.48964510307;51045.74477127591;53335;53523.19715204353;76037.61981190059;76732.23267767251;76886;78572.35704072662;78893.4221315582;7572.39420846342;7799.415043871619;7812.609369531614;7885.842283154419;8206.876896846432;10809.35143891369;12060.698482537655;12432.316222607844;12448.128630995743;12578.308193049104;6638.767643132467;10886;11125.998660120627;11252.212345135762;11331.490082946122;10603.310784798963;10705.839412408664;10898.237123401286;11050.557977680803;11139;5621.988042152452;6368;11064.834027489755;11179.466164248748;11195.72010699739;6554.344565543408;7748.147703752696;7805.726799561988;7857.882131768142;7973.960130199312;7558.9244107558225;7868.370530357673;7871.606419679108;8335.874961875455;8378.120297368932 05:12:20 INFO - PROCESS | 1669 | |3;mootools.html;1483.6587584855477;1609.4286528282457;1633.3384979083469;1934.7388102606144;2049.7437820272467;7981.12207657158;8563.486190828547;8731.17053879882;8738;8745.387822852403;8428.91571084289;8669.133086691343;8703.216710496054;8712.172343627346;8756.036835948056;2180.8800515971616;2385.057902128658;2440;2473.369290830836;2493.987530062347;2476.2076135636603;2482.553140434721;2483.279848843842;2485.515324511721;2486.353548077495;2394.245812569035;2467;2490.1906880263896;2490.7384724603926;2492.9376765580914;2449.473363226906;2463.5811911975006;2469.962950555743;2480.3923038855414;2485.192312498445;2119.2688522459725;2428.0409238350753;2467.5558399488086;2477.6283557466345;2478.10788116278;7445.143808462042;8771.12288771124;8872.112788721077;8874.156955089256;8875.511846848422;5407.918881216785;5597.63615365;5601.691906945116;5607.943920560783;5613.915791263134;3560.3413368526903;3665.0470877572025;3738.1962877981364;3743.737938344317;3750.8124593770203;1042.046527427403;1050.6217761605892;1052.6736711619346;1063.547992103353;1070.304302203566;11919.702007449796;11945.163838531307;11946.10404219687;11955.82066268998;11957.521699132025;4886.804527818918;4921.581665558396;4982.402111746614;5025.296458495814;5035.345405097387;10164.949175254224;10168.440735759605;10189.898101019044;10193.388396696222;10215.642452514126;5568.9443105569235;5574.136008918624;5577.637453565505;5584.46947539983;5591.888162236733;4452.755098469551;4612.584867361887;4842.539958703917;4937.802487900515;4967.925481117786;3903.33643280643;3997.2405243003736;4019.7789121598007;4032.7781971991235;4054.858079967246;1339.4776037345443;1341.6042267531102;1350.4665657065405;1350.527315439608;1368.1449094316054;1157.8784227656142;1369.664432214114;1414.56855659025;1415.179196066279;1417.121384741467;8202.958985205156;8275.793105172419;8303.377246706521;8325.958370208231;8328.458650187718;520.4327283261264;531.3039917707738;532.1538753382141;537.40348213483;537.862844974529;6201.720922558496;6219.440250377397;6242.219722534684;6267.2165979252595;6275.497960163176;10309;10651.98806113418;10665.9466702666;10667.14662826972;10676.94661526703;10142.137918277029;10613.84079238812;10656.89343106559;10662.41356725372;10672.359658420519;8130.674773009014;8253.380996425412;8263.462874913112;8320.583970801557;8321.958390208132;8028.718994835386;8058.919410805817;8111.229433203836;8182.427230093836;8187.590620469072;9448.960614332555;9449.433034017706;9541.427514349161;9595.13643772064;9611.134997849947;8362.87455688153;9722.708318750449;9886.011398860344;9966.40201587907;10059.245556583139;6813.250542440229;6875.346842049998;7454.515456495311;7542.660580273791;7600.315971562586;8243.670253190045;8246.670133194604;8272.958635206785;8285.50286982783;8294.253517183482;7287.562746235243;7376.852462950818;7382.926170738224;7520.736774212876;7556.622168891424;7229.963850180716;7235.710571577078;7280.344768970606;7311.013013243357;7325.267473252632;6725.327467253432;7719.498232614862;7841.137474877645;7845.372370210255;7852.097008843828;6811.455083593201;7000.859982800417;7095.893561596684;7101.147862256562;7104.147502299757;7020.192677842114;7075.752348667772;7080.327368899946;7097;7106.609136497542 05:12:20 INFO - PROCESS | 1669 | |4;prototype.html;321.40219192302317;325.9527368531563;330.0346486526908;330.69575990089123;335.95800524934367;5094.745262736867;6331.1769469968895;6345.682715864205;6378.649174295418;6481.416672499474;6350.301466838644;6353.777617783378;6363.840903977403;6364.949783285764;6388.520860935437;4169.124483858393;4397.702677710083;4555.74943378114;4610;4813.927791083128;4744.051189762062;4747.504536071144;4748.097861406339;4751.14479393709;4754.809807607691;4701.294805779126;4744.478107408182;4752.643551733617;4754.500777418373;4765.380500534926;3853.6531712146043;4515.209838278288;4630.86107416778;4765.380500534943;4771.451283102453;4105.158442519277;4114.814833332477;4117.279476091702;4121.4848143982;4131.442255295527;6087.391260873921;6111.541634377395;6122.102148333986;6134.9079763803575;6137.324894261627;5551.750171242304;5555.583331250173;5571.052921003439;5574.944250557523;5579.721013949286;6787.151606049244;6789.796306110825;6792.660366981631;6797.354251346114;6810.965945170243;4259.829606815723;4441.844535441244;4474.2841145416905;4585.564371384713;4591.311303304497;6403.551751377452;6708.027336036247;7104.325089116525;7126.964365178193;7198.280171982812;4516.345129956204;4522.66080043998;4522.977385113053;4528.954710452919;4532.206863798888;3969.7816620085596;4468.821247150077;4572.611328037087;4577.5193604671695;4583.954160458419;5430.56555475561;5433.891322173535;5438.238646589481;5443.564514838803;5455.8090466834265;6463.15978922737;6766.424853887376;6795.7961261162245;6814.284500127415;6814.420774234147;1565.9451919182775;1581.905085694862;1596.832332605083;1599.856012958816;1605.7671637612714;976.6386437018349;1030.685640879539;1030.9432981185957;1048.8688913885765;1057.3867157049046;6178.41305076017;6254.718537665816;6426.646534440557;6448.097266382711;6454.096426500294;7126.857462850714;7135.036770036082;7139.428845692332;7141.535800172972;7150.713971441188;5114.74426278692;5499.752511137009;6228.750849966042;6420;6425.421712045845;3348.8325583721203;3714.0714821294678;3771.7548359356556;3773.2453509298252;3776.9046976377094;7165.140183177948;7460.813479663052;7481.177070522238;7518;7558.58427786477;6242.531810114259;7399.741009064657;7419.629018549159;7421.554706717614;7434.702611895572;6140.416660417253;7325.2308507607;7460.216677249028;7488.588127652923;7520.09758828944;7134.250903655042;7138.571685698875;7145.3926416253125;7154.284571542804;7167.8566428672175;6739.865202696017;7011.474139439664;7045.859082818418;7068.9293107070325;7087.681054352463;6044.818655440344;6141.754329826936;7414.518056326321;7488.9625551871895;7497.325240728361;4493.6854420190275;4546.704464209815;4546.88632784183;4548.317752337176;4550.840720574764;7081.468889833386;7089.291070892869;7096;7112;7115.715371385087;6609.603423794588;6871.312868713088;6885.380315771605;6908.929115986829;6912;6808.353206445379;6852.657367131723;6864.931350686629;6865.485088618473;6881.931180688129;5498.395176530658;6728.73085076611;6729.596224226562;6740.764073257413;6745.93254067453;6825.55633883796;6858.279880612663;6859.83382824931;6860.519763616699;6860.931390686229;6426.903596446151;6459.192600924885;6683;6692.564983276072;6708.060871478095 05:12:20 INFO - PROCESS | 1669 | |5;yui.html;698.8678341087439;748.1209578744977;748.9887651685226;770.0951382126002;808.5835794565797;14205.579442055789;15104.169270690109;15265.847341526582;15279.847201527982;17390.478285651418;16164.595885102879;16223.756643650355;16239.675206495864;16255.593610159753;16273;748.1508487866283;757.3751654884715;917.6833992272672;941.4398432932394;946.6402766948585;928.2666693312275;939.8590211468266;941.3739862991102;941.6468824190929;943.4197968249546;986.2061040862139;986.7631768375574;986.9981968302179;988.2044953812178;993.6075250276136;791.3234184771994;800.0119851982796;801.7354273089867;984.8227319082562;985.5121714751173;597.8804239152187;721.6463932673005;728.4609389052064;732.3518685962908;732.5458215906119;15446.304916278683;15470.767938480933;15474.61313467161;15493.302801373966;15509.146996915166;12412.689682757913;12433.3783310835;12440.875591244063;12587.433565489575;12635.472905418954;9841.950790246003;9986.850197247048;10104.343217690826;10120.089191972758;10456.58173673052;3074.446599612091;3429.537012503305;3442.7245820334315;3552.6447355264527;3589.856405743767;81334.59332703358;81346.77979830308;82017.35965280721;82109;82796.58601706952;9302.90697093034;9374.343795934356;9389.90610093904;9453.101955314234;9961.203103751683;21449.356519304445;21714.674279885814;21740.782592174193;21753.45616359572;21773.782262177174;7521.946927430165;7539.170691223961;7662.73180438682;7709.845803084019;7866.6066696666085;4154.729942553724;4207.789610519461;4211.894702632459;4271.786410679453;4482.260427029569;3643.544556930384;3682.1715114099648;3682.5765037021088;3684.502592150079;3688.981555092207;667.8764428580728;672.8082496488576;673.9663016849236;686.5091459606406;699.1610067918518;502.7209898506364;559.4293820303268;578.5227187570272;616.2050954268943;627.1282916745727;7881.605919703992;8049.758507244792;8078.798030049295;8137.186281371815;8188.959055204805;502.8692539939569;547.9178123281459;577.4254616656453;577.8670905691714;617.2685367839035;3762.9247415051545;3768.7927164005696;3774.7735135891935;3778.886633401002;3990.182012687392;93898.53050734702;94029;94062.52968735113;94706;95130.52434737782;72397.63801181066;78962.6051869737;79153.60423197848;79169;79251.8112228317;68649.31350686429;69407.26481837995;69828.30171698218;70902;73206.63396682983;7723.961380193063;7729.9227007729205;7813.570253636105;7848.7645370638975;7903.762887113396;48014;48155.5184448165;48754.512454874995;48844.2673359907;49648.751756240985;65545;68660.31339686539;70566;70616.94074588783;70816.64591677215;9803.705888823346;9904.900950990397;10341.63804266847;10718.035376816124;11014.650564244577;11532.481038353126;11769.999550038343;12051.698707532381;12284.385780711107;12342.074344424384;10637.42672538627;10988.175886808682;11104.722381940193;11169.218154729091;11318.26431281964;9695.806083878424;10990.725231868948;11198.888011119785;11589.536418543501;11716.414179291172;10807.35155890649;10845.566177352817;10880.564777409132;11259.887401126212;11755.05959523219;9085.2731781456;9387.530623468663;9484.715458536255;9724.465154416575;10290.691279261635;8371.916280837357;8513.702020429255;8964.462132272085;8973.461592304482;9116.90883091187 05:12:20 INFO - PROCESS | 1669 | __end_tp_report 05:12:20 INFO - PROCESS | 1669 | __start_cc_report 05:12:20 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1318 05:12:20 INFO - PROCESS | 1669 | __end_cc_report 05:12:20 INFO - PROCESS | 1669 | __startTimestamp1458648740555__endTimestamp 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | ------- Summary: start ------- 05:12:20 INFO - PROCESS | 1669 | Number of tests: 6 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5693.37 Median:5948.35 stddev:632.70 (10.6%) stddev-sans-first:609.80 05:12:20 INFO - PROCESS | 1669 | Values: 3455.5 3491.4 3492.5 3539.5 3574.2 5534.5 5602.6 5617.6 5641.6 5695.2 4857.0 5608.2 5646.6 5647.9 5782.5 5031.2 5061.9 5086.3 5097.0 5186.8 5204.5 5238.3 5241.3 5285.8 5288.0 5061.7 5100.2 5140.0 5144.7 5175.4 5139.5 5149.8 5172.4 5177.6 5186.8 5089.1 5105.2 5121.2 5127.3 5154.2 5434.2 5516.8 5543.6 5558.4 5562.2 6099.9 6103.8 6104.8 6121.3 6130.8 6149.2 6157.4 6180.5 6197.1 6256.2 5715.5 5767.3 5769.8 5779.1 5813.4 6169.4 6237.3 6244.9 6247.1 6247.3 5984.1 6042.6 6083.8 6134.3 6146.3 4837.9 6260.8 6264.5 6267.7 6278.9 5948.3 6182.5 6199.4 6224.5 6232.3 5161.4 6101.2 6137.0 6177.7 6185.1 4881.2 4893.2 4908.0 4911.6 4930.7 4386.0 4387.0 4387.6 4388.3 4433.6 5621.2 5683.3 5708.5 5735.3 5803.5 5867.3 6230.1 6260.4 6270.4 6277.4 5619.5 5689.0 5721.1 5739.8 5740.7 5275.0 5302.6 5322.5 5328.3 5375.0 6285.2 6294.9 6310.1 6316.5 6323.4 6247.1 6267.8 6272.4 6282.4 6300.1 6183.6 6235.7 6289.2 6300.8 6303.4 6110.5 6172.9 6176.0 6181.9 6209.6 6218.4 6262.8 6272.2 6286.3 6304.9 5893.1 5995.2 6094.5 6130.1 6141.4 6097.9 6123.8 6124.3 6130.2 6132.2 5173.4 5953.0 5954.5 5972.3 6004.2 5939.9 6012.3 6033.8 6125.9 6129.1 5940.5 5955.8 5962.2 5988.2 6000.9 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:56463.04 Median:36734.86 stddev:108098.20 (294.3%) stddev-sans-first:108319.97 05:12:20 INFO - PROCESS | 1669 | Values: 562.9 566.5 587.7 621.6 634.4 39098.8 39588.8 39626.4 39663.2 39871.0 38023.0 39951.0 42295.2 42904.0 42972.8 9477.4 9714.7 9722.9 9734.2 9738.2 9620.9 9757.6 9775.2 9779.3 9821.6 9840.2 9901.4 9902.3 9915.4 9919.3 9792.1 9876.5 9877.2 9886.2 9888.3 9659.7 9781.0 9794.2 9794.4 9810.2 41868.7 42155.2 42197.4 42213.2 42258.0 3251.8 3269.4 3283.2 3284.5 3464.6 28813.0 29852.7 29883.1 29914.7 29931.0 2746.8 2767.3 2823.7 2885.6 2918.8 378729.0 379282.0 379895.0 380043.0 381356.0 60637.1 61717.7 68659.0 69115.0 69548.7 74147.0 74848.6 74961.3 75018.0 75040.9 17088.6 17438.6 17497.7 17515.6 17530.4 11718.2 12950.3 13117.9 13143.9 13183.4 21500.1 22007.0 22021.6 22041.9 22059.9 8520.9 8695.3 8697.8 8724.5 8796.5 926.4 937.7 1003.9 1024.6 1108.9 25888.9 29337.7 29599.6 30184.5 30235.5 1088.1 1112.5 1117.7 1126.1 1219.2 13053.3 14416.4 14879.0 15129.2 15603.8 502245.0 505753.0 508236.0 509277.0 510088.0 61356.7 61578.4 61725.8 61780.0 61851.4 1183.5 1356.2 1368.5 1475.6 1495.5 28442.0 28720.9 28965.1 29128.7 29172.9 47495.8 47801.0 48164.5 48270.0 48302.5 311062.0 312255.0 313439.0 314035.9 314408.0 29130.7 31286.5 32901.8 33075.0 33583.3 41525.0 42226.0 42412.8 42603.6 43134.1 33956.8 34944.3 35146.8 35837.0 35848.8 34897.7 34990.5 35285.8 35667.3 35721.6 36101.0 36225.5 36478.9 36990.8 37207.1 28714.7 31402.1 32249.0 32277.0 32359.4 23338.9 24188.6 24413.5 24467.0 24553.1 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33474.64 Median:356.44 stddev:99208.82 (27833.2%) stddev-sans-first:99455.96 05:12:20 INFO - PROCESS | 1669 | Values: 354.5 358.4 363.1 368.8 368.8 19153.6 19611.5 21168.6 21186.8 21223.4 12355.9 17508.8 19778.9 20286.3 20317.0 5126.1 5284.2 5334.4 5343.3 5352.9 3286.5 4127.6 5287.3 5725.3 5943.6 6012.9 6024.1 6033.6 6038.8 6040.9 4875.5 5452.6 5716.0 5724.2 5989.1 3786.2 5404.9 5477.9 5646.0 5659.0 13610.3 13652.9 13787.4 13791.1 13808.3 2024.2 2054.8 2157.1 2304.4 2592.6 9694.7 9782.0 10017.9 10133.7 14127.9 1678.8 1778.7 1836.9 1848.3 1852.4 95372.0 103789.5 107465.9 109102.0 115655.4 9144.9 9772.7 11000.2 11205.6 11694.9 13846.4 13954.4 13977.0 13982.1 13988.4 8273.0 8766.0 8815.1 8846.8 8877.0 8928.6 8929.2 8936.2 9045.3 9050.7 4470.5 4554.5 4560.4 4569.8 4592.7 1655.1 1743.4 1815.6 1920.8 1959.0 869.3 927.7 995.5 1005.0 1013.6 19541.4 20800.0 20821.0 20912.2 20959.2 929.1 950.7 962.4 1024.4 1046.3 11036.6 11211.7 11216.3 11220.7 11221.3 586791.0 589563.0 592962.0 609086.0 609837.0 91008.0 112122.4 115045.0 115101.0 115648.8 937.0 1018.4 1049.4 1080.6 1081.6 18017.2 18431.9 19051.9 19059.7 19318.9 49986.3 51035.5 51045.7 53335.0 53523.2 76037.6 76732.2 76886.0 78572.4 78893.4 7572.4 7799.4 7812.6 7885.8 8206.9 10809.4 12060.7 12432.3 12448.1 12578.3 6638.8 10886.0 11126.0 11252.2 11331.5 10603.3 10705.8 10898.2 11050.6 11139.0 5622.0 6368.0 11064.8 11179.5 11195.7 6554.3 7748.1 7805.7 7857.9 7974.0 7558.9 7868.4 7871.6 8335.9 8378.1 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6050.40 Median:2972.89 stddev:3183.30 (107.1%) stddev-sans-first:3173.73 05:12:20 INFO - PROCESS | 1669 | Values: 1483.7 1609.4 1633.3 1934.7 2049.7 7981.1 8563.5 8731.2 8738.0 8745.4 8428.9 8669.1 8703.2 8712.2 8756.0 2180.9 2385.1 2440.0 2473.4 2494.0 2476.2 2482.6 2483.3 2485.5 2486.4 2394.2 2467.0 2490.2 2490.7 2492.9 2449.5 2463.6 2470.0 2480.4 2485.2 2119.3 2428.0 2467.6 2477.6 2478.1 7445.1 8771.1 8872.1 8874.2 8875.5 5407.9 5597.6 5601.7 5607.9 5613.9 3560.3 3665.0 3738.2 3743.7 3750.8 1042.0 1050.6 1052.7 1063.5 1070.3 11919.7 11945.2 11946.1 11955.8 11957.5 4886.8 4921.6 4982.4 5025.3 5035.3 10164.9 10168.4 10189.9 10193.4 10215.6 5568.9 5574.1 5577.6 5584.5 5591.9 4452.8 4612.6 4842.5 4937.8 4967.9 3903.3 3997.2 4019.8 4032.8 4054.9 1339.5 1341.6 1350.5 1350.5 1368.1 1157.9 1369.7 1414.6 1415.2 1417.1 8203.0 8275.8 8303.4 8326.0 8328.5 520.4 531.3 532.2 537.4 537.9 6201.7 6219.4 6242.2 6267.2 6275.5 10309.0 10652.0 10665.9 10667.1 10676.9 10142.1 10613.8 10656.9 10662.4 10672.4 8130.7 8253.4 8263.5 8320.6 8322.0 8028.7 8058.9 8111.2 8182.4 8187.6 9449.0 9449.4 9541.4 9595.1 9611.1 8362.9 9722.7 9886.0 9966.4 10059.2 6813.3 6875.3 7454.5 7542.7 7600.3 8243.7 8246.7 8273.0 8285.5 8294.3 7287.6 7376.9 7382.9 7520.7 7556.6 7230.0 7235.7 7280.3 7311.0 7325.3 6725.3 7719.5 7841.1 7845.4 7852.1 6811.5 7000.9 7095.9 7101.1 7104.1 7020.2 7075.8 7080.3 7097.0 7106.6 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5563.59 Median:6338.43 stddev:1779.49 (28.1%) stddev-sans-first:1740.44 05:12:20 INFO - PROCESS | 1669 | Values: 321.4 326.0 330.0 330.7 336.0 5094.7 6331.2 6345.7 6378.6 6481.4 6350.3 6353.8 6363.8 6364.9 6388.5 4169.1 4397.7 4555.7 4610.0 4813.9 4744.1 4747.5 4748.1 4751.1 4754.8 4701.3 4744.5 4752.6 4754.5 4765.4 3853.7 4515.2 4630.9 4765.4 4771.5 4105.2 4114.8 4117.3 4121.5 4131.4 6087.4 6111.5 6122.1 6134.9 6137.3 5551.8 5555.6 5571.1 5574.9 5579.7 6787.2 6789.8 6792.7 6797.4 6811.0 4259.8 4441.8 4474.3 4585.6 4591.3 6403.6 6708.0 7104.3 7127.0 7198.3 4516.3 4522.7 4523.0 4529.0 4532.2 3969.8 4468.8 4572.6 4577.5 4584.0 5430.6 5433.9 5438.2 5443.6 5455.8 6463.2 6766.4 6795.8 6814.3 6814.4 1565.9 1581.9 1596.8 1599.9 1605.8 976.6 1030.7 1030.9 1048.9 1057.4 6178.4 6254.7 6426.6 6448.1 6454.1 7126.9 7135.0 7139.4 7141.5 7150.7 5114.7 5499.8 6228.8 6420.0 6425.4 3348.8 3714.1 3771.8 3773.2 3776.9 7165.1 7460.8 7481.2 7518.0 7558.6 6242.5 7399.7 7419.6 7421.6 7434.7 6140.4 7325.2 7460.2 7488.6 7520.1 7134.3 7138.6 7145.4 7154.3 7167.9 6739.9 7011.5 7045.9 7068.9 7087.7 6044.8 6141.8 7414.5 7489.0 7497.3 4493.7 4546.7 4546.9 4548.3 4550.8 7081.5 7089.3 7096.0 7112.0 7115.7 6609.6 6871.3 6885.4 6908.9 6912.0 6808.4 6852.7 6864.9 6865.5 6881.9 5498.4 6728.7 6729.6 6740.8 6745.9 6825.6 6858.3 6859.8 6860.5 6860.9 6426.9 6459.2 6683.0 6692.6 6708.1 05:12:20 INFO - PROCESS | 1669 | 05:12:20 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18414.35 Median:680.24 stddev:25996.06 (3821.6%) stddev-sans-first:26034.95 05:12:20 INFO - PROCESS | 1669 | Values: 698.9 748.1 749.0 770.1 808.6 14205.6 15104.2 15265.8 15279.8 17390.5 16164.6 16223.8 16239.7 16255.6 16273.0 748.2 757.4 917.7 941.4 946.6 928.3 939.9 941.4 941.6 943.4 986.2 986.8 987.0 988.2 993.6 791.3 800.0 801.7 984.8 985.5 597.9 721.6 728.5 732.4 732.5 15446.3 15470.8 15474.6 15493.3 15509.1 12412.7 12433.4 12440.9 12587.4 12635.5 9842.0 9986.9 10104.3 10120.1 10456.6 3074.4 3429.5 3442.7 3552.6 3589.9 81334.6 81346.8 82017.4 82109.0 82796.6 9302.9 9374.3 9389.9 9453.1 9961.2 21449.4 21714.7 21740.8 21753.5 21773.8 7521.9 7539.2 7662.7 7709.8 7866.6 4154.7 4207.8 4211.9 4271.8 4482.3 3643.5 3682.2 3682.6 3684.5 3689.0 667.9 672.8 674.0 686.5 699.2 502.7 559.4 578.5 616.2 627.1 7881.6 8049.8 8078.8 8137.2 8189.0 502.9 547.9 577.4 577.9 617.3 3762.9 3768.8 3774.8 3778.9 3990.2 93898.5 94029.0 94062.5 94706.0 95130.5 72397.6 78962.6 79153.6 79169.0 79251.8 68649.3 69407.3 69828.3 70902.0 73206.6 7724.0 7729.9 7813.6 7848.8 7903.8 48014.0 48155.5 48754.5 48844.3 49648.8 65545.0 68660.3 70566.0 70616.9 70816.6 9803.7 9904.9 10341.6 10718.0 11014.7 11532.5 11770.0 12051.7 12284.4 12342.1 10637.4 10988.2 11104.7 11169.2 11318.3 9695.8 10990.7 11198.9 11589.5 11716.4 10807.4 10845.6 10880.6 11259.9 11755.1 9085.3 9387.5 9484.7 9724.5 10290.7 8371.9 8513.7 8964.5 8973.5 9116.9 05:12:20 INFO - PROCESS | 1669 | -------- Summary: end -------- 05:12:20 INFO - PROCESS | 1669 | 05:12:21 INFO - TEST-INFO | 1669: exit 0 05:12:21 INFO - TEST-OK | dromaeo_css | took 1113853ms 05:12:21 INFO - TEST-START | kraken 05:12:21 INFO - operating with platform_type : mac_ 05:12:21 INFO - Initialising browser for kraken test... 05:12:21 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpagYWem/profile http://localhost:49281/getInfo.html) 05:12:23 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 05:12:23 INFO - PROCESS | 1679 | colorDepth:24 05:12:23 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 05:12:23 INFO - PROCESS | 1679 | __metrics 05:12:23 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:23 ERROR - PROCESS | 1679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:12:23 INFO - TEST-INFO | 1679: exit 0 05:12:23 INFO - Browser initialized. 05:12:23 INFO - Running cycle 1/1 for kraken test... 05:12:23 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpagYWem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:35 INFO - PROCESS | 1681 | RSS: Main: 247132160 05:12:35 INFO - PROCESS | 1681 | 05:12:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:39 INFO - PROCESS | 1681 | RSS: Main: 292052992 05:12:39 INFO - PROCESS | 1681 | 05:12:41 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 05:12:42 INFO - PROCESS | 1681 | RSS: Main: 303894528 05:12:42 INFO - PROCESS | 1681 | 05:12:45 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 05:12:46 INFO - PROCESS | 1681 | RSS: Main: 290230272 05:12:46 INFO - PROCESS | 1681 | 05:12:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 05:12:48 INFO - PROCESS | 1681 | RSS: Main: 292098048 05:12:48 INFO - PROCESS | 1681 | 05:12:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:51 INFO - PROCESS | 1681 | RSS: Main: 291926016 05:12:51 INFO - PROCESS | 1681 | 05:12:54 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:55 INFO - PROCESS | 1681 | RSS: Main: 292007936 05:12:55 INFO - PROCESS | 1681 | 05:12:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:58 INFO - PROCESS | 1681 | RSS: Main: 293285888 05:12:58 INFO - PROCESS | 1681 | 05:13:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 05:13:02 INFO - PROCESS | 1681 | RSS: Main: 292450304 05:13:02 INFO - PROCESS | 1681 | 05:13:03 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:04 INFO - PROCESS | 1681 | RSS: Main: 327311360 05:13:04 INFO - PROCESS | 1681 | 05:13:05 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:06 INFO - PROCESS | 1681 | RSS: Main: 326492160 05:13:06 INFO - PROCESS | 1681 | 05:13:08 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:09 INFO - PROCESS | 1681 | RSS: Main: 332800000 05:13:09 INFO - PROCESS | 1681 | 05:13:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:12 INFO - PROCESS | 1681 | RSS: Main: 334475264 05:13:12 INFO - PROCESS | 1681 | 05:13:15 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:15 INFO - PROCESS | 1681 | RSS: Main: 335474688 05:13:15 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 05:13:17 INFO - PROCESS | 1681 | RSS: Main: 393953280 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | __start_tp_report 05:13:17 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 05:13:17 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 05:13:17 INFO - PROCESS | 1681 | |i|pagename|runs| 05:13:17 INFO - PROCESS | 1681 | |0;ai-astar;112;108;112;112;110;111;116;113;111;110 05:13:17 INFO - PROCESS | 1681 | |1;audio-beat-detection;156;122;149;196;142;142;140;119;160;120 05:13:17 INFO - PROCESS | 1681 | |2;audio-dft;185;185;185;185;186;185;179;184;181;180 05:13:17 INFO - PROCESS | 1681 | |3;audio-fft;79;75;84;80;80;80;84;96;77;56 05:13:17 INFO - PROCESS | 1681 | |4;audio-oscillator;94;92;128;78;79;84;114;86;115;151 05:13:17 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;89;85;89;87;92;129;89;89;133;129 05:13:17 INFO - PROCESS | 1681 | |6;imaging-darkroom;94;93;94;94;93;94;94;95;95;93 05:13:17 INFO - PROCESS | 1681 | |7;imaging-desaturate;85;86;84;87;114;134;132;85;84;86 05:13:17 INFO - PROCESS | 1681 | |8;json-parse-financial;57;57;58;57;56;56;56;65;55;55 05:13:17 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;62;65;74;71;69;67;65;66;66;68 05:13:17 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;83;83;84;80;87;83;82;83;85;84 05:13:17 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;123;117;132;119;121;129;128;128;139;128 05:13:17 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;138;123;136;131;142;135;136;135;133;160 05:13:17 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;66;66;67;68;65;69;67;67;67;65 05:13:17 INFO - PROCESS | 1681 | __end_tp_report 05:13:17 INFO - PROCESS | 1681 | __start_cc_report 05:13:17 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1258 05:13:17 INFO - PROCESS | 1681 | __end_cc_report 05:13:17 INFO - PROCESS | 1681 | __startTimestamp1458648797592__endTimestamp 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | ------- Summary: start ------- 05:13:17 INFO - PROCESS | 1681 | Number of tests: 14 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 05:13:17 INFO - PROCESS | 1681 | Values: 112.0 108.0 112.0 112.0 110.0 111.0 116.0 113.0 111.0 110.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:145.50 stddev:23.18 (15.9%) stddev-sans-first:24.21 05:13:17 INFO - PROCESS | 1681 | Values: 156.0 122.0 149.0 196.0 142.0 142.0 140.0 119.0 160.0 120.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:183.50 Median:185.00 stddev:2.51 (1.4%) stddev-sans-first:2.60 05:13:17 INFO - PROCESS | 1681 | Values: 185.0 185.0 185.0 185.0 186.0 185.0 179.0 184.0 181.0 180.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:79.10 Median:80.00 stddev:9.95 (12.4%) stddev-sans-first:10.55 05:13:17 INFO - PROCESS | 1681 | Values: 79.0 75.0 84.0 80.0 80.0 80.0 84.0 96.0 77.0 56.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:81.50 stddev:24.13 (29.6%) stddev-sans-first:25.41 05:13:17 INFO - PROCESS | 1681 | Values: 94.0 92.0 128.0 78.0 79.0 84.0 114.0 86.0 115.0 151.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:89.00 stddev:20.28 (22.8%) stddev-sans-first:21.03 05:13:17 INFO - PROCESS | 1681 | Values: 89.0 85.0 89.0 87.0 92.0 129.0 89.0 89.0 133.0 129.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:13:17 INFO - PROCESS | 1681 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 94.0 95.0 95.0 93.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:85.00 stddev:20.67 (24.3%) stddev-sans-first:21.41 05:13:17 INFO - PROCESS | 1681 | Values: 85.0 86.0 84.0 87.0 114.0 134.0 132.0 85.0 84.0 86.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:2.90 (5.1%) stddev-sans-first:3.07 05:13:17 INFO - PROCESS | 1681 | Values: 57.0 57.0 58.0 57.0 56.0 56.0 56.0 65.0 55.0 55.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:3.40 (5.0%) stddev-sans-first:3.02 05:13:17 INFO - PROCESS | 1681 | Values: 62.0 65.0 74.0 71.0 69.0 67.0 65.0 66.0 66.0 68.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:1.84 (2.2%) stddev-sans-first:1.94 05:13:17 INFO - PROCESS | 1681 | Values: 83.0 83.0 84.0 80.0 87.0 83.0 82.0 83.0 85.0 84.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.00 stddev:6.57 (5.1%) stddev-sans-first:6.85 05:13:17 INFO - PROCESS | 1681 | Values: 123.0 117.0 132.0 119.0 121.0 129.0 128.0 128.0 139.0 128.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:136.00 stddev:9.50 (7.0%) stddev-sans-first:10.07 05:13:17 INFO - PROCESS | 1681 | Values: 138.0 123.0 136.0 131.0 142.0 135.0 136.0 135.0 133.0 160.0 05:13:17 INFO - PROCESS | 1681 | 05:13:17 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 05:13:17 INFO - PROCESS | 1681 | Values: 66.0 66.0 67.0 68.0 65.0 69.0 67.0 67.0 67.0 65.0 05:13:17 INFO - PROCESS | 1681 | -------- Summary: end -------- 05:13:17 INFO - PROCESS | 1681 | 05:13:18 INFO - TEST-INFO | 1681: exit 0 05:13:18 INFO - TEST-OK | kraken | took 57308ms 05:13:18 INFO - SUITE-END | took 1171s 05:13:18 INFO - Completed test suite (00:19:31) 05:13:18 INFO - javascript benchmark 05:13:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3455.533502977098, 3491.4064609016464, 3492.458668906317, 3539.5398598182232, 3574.249407624399, 5534.529564986981, 5602.635828671134, 5617.578681598881, 5641.605087643867, 5695.202671625976, 4856.975715121428, 5608.2428872102255, 5646.576506761989, 5647.887042259153, 5782.479576838084, 5031.245313203012, 5061.898762024757, 5086.3387759591205, 5097.0, 5186.818461353853, 5204.479552044803, 5238.345206849144, 5241.292425522563, 5285.814996475124, 5288.048151332759, 5061.721605311706, 5100.209467532539, 5140.023395554833, 5144.6913185209005, 5175.404828444739, 5139.511746384088, 5149.794008239666, 5172.431032586413, 5177.559907407875, 5186.818461353834, 5089.134847076006, 5105.183170692671, 5121.180611102206, 5127.307813445212, 5154.175331946871, 5434.239206511092, 5516.779328826842, 5543.556515478752, 5558.44415558445, 5562.193481945135, 6099.878002439971, 6103.792276408629, 6104.755809767604, 6121.326654068049, 6130.754769809202, 6149.200603921461, 6157.384261573851, 6180.505559555225, 6197.070439434121, 6256.1866957295715, 5715.485606295453, 5767.279090113736, 5769.826905192851, 5779.133130030487, 5813.418658134195, 6169.444749972435, 6237.313895471494, 6244.937550624436, 6247.062940558862, 6247.250329960434, 5984.102384642251, 6042.615606431687, 6083.7566497340495, 6134.325224225332, 6146.262448506208, 4837.879053023703, 6260.843478913063, 6264.467520260829, 6267.749290028439, 6278.905816412757, 5948.345681974979, 6182.536309776785, 6199.442050215503, 6224.470919971763, 6232.345603711545, 5161.406438259648, 6101.237345331833, 6137.003815650162, 6177.722002509898, 6185.103160041769, 4881.219004959189, 4893.192623217129, 4908.0, 4911.582515486152, 4930.654854160174, 4385.978070109692, 4386.956130438719, 4387.561243875651, 4388.27593447084, 4433.645308375322, 5621.18492818539, 5683.318001839806, 5708.457696518824, 5735.254416925856, 5803.47768700819, 5867.266591676041, 6230.06549017651, 6260.40526150015, 6270.372962703693, 6277.435030847154, 5619.494245517923, 5688.9715551422805, 5721.113227449752, 5739.799107031234, 5740.712964351766, 5274.973625131926, 5302.575793936476, 5322.494363035506, 5328.307320048369, 5375.0, 6285.182926219653, 6294.937050629435, 6310.05349197624, 6316.526260530387, 6323.36766323364, 6247.0629405589525, 6267.811965640855, 6272.435480806749, 6282.434580887742, 6300.117983482408, 6183.598066125687, 6235.688215589112, 6289.182406287154, 6300.810975670737, 6303.36966303366, 6110.480609148272, 6172.938270617236, 6176.0, 6181.938180618316, 6209.627422354673, 6218.378162183926, 6262.812115636538, 6272.153259310117, 6286.339934306832, 6304.936950630618, 5893.116032595145, 5995.190649262294, 6094.481969032682, 6130.122981477994, 6141.424638644238, 6097.917917222819, 6123.83172914054, 6124.319907527481, 6130.214697154755, 6132.171952247653, 5173.430922598436, 5953.0, 5954.493868021266, 5972.313183983897, 6004.219451471281, 5939.881202376015, 6012.308584512837, 6033.75864965414, 6125.877482450415, 6129.111278864629, 5940.46535811779, 5955.791547295824, 5962.165296858357, 5988.191594134736, 6000.909986350295], "unit": "score", "name": "dojo.html", "value": 5655.2644506836195}, {"lowerIsBetter": false, "replicates": [562.9360508638671, 566.4986486959043, 587.6885250817065, 621.5990686007525, 634.3561285295425, 39098.80450597747, 39588.80205598975, 39626.40560391596, 39663.206735865264, 39871.00322491939, 38023.049423764416, 39951.0, 42295.15409691804, 42904.0, 42972.78513607428, 9477.383970041943, 9714.708558743214, 9722.902770972305, 9734.172595329406, 9738.220942324597, 9620.903790962106, 9757.560909759042, 9775.169110625606, 9779.315447918649, 9821.558029888636, 9840.21278297738, 9901.405915645084, 9902.30683852127, 9915.405075695446, 9919.256055795844, 9792.11870931616, 9876.456794876314, 9877.160441362494, 9886.159676427513, 9888.258380621483, 9659.71020869375, 9780.951095244549, 9794.216462682969, 9794.412335259836, 9810.215182785432, 41868.74393768192, 42155.156896862194, 42197.367039494435, 42213.1557368854, 42258.0, 3251.7723759336855, 3269.362474317509, 3283.169640407621, 3284.490903909898, 3464.6419059994028, 28813.0, 29852.701472985427, 29883.10350689461, 29914.700852991627, 29931.0, 2746.780257579409, 2767.349672826884, 2823.68939416664, 2885.5960165576835, 2918.7810914181523, 378728.99999999726, 379282.0, 379895.0, 380043.0, 381356.0, 60637.09044364338, 61717.69141154355, 68659.0, 69115.0, 69548.6522567384, 74147.0, 74848.62575687196, 74961.25038749543, 75018.0, 75040.87438688424, 17088.572785680208, 17438.564035899202, 17497.737533936746, 17515.56211094733, 17530.386436474662, 11718.23831450953, 12950.287734174522, 13117.868821311664, 13143.948484121438, 13183.406746696422, 21500.139994400048, 22007.0, 22021.559568808534, 22041.889790550944, 22059.889700551394, 8520.914790852135, 8695.304375649934, 8697.782555436039, 8724.476531408009, 8796.47221166732, 926.3700683535126, 937.6952490440498, 1003.9196864250843, 1024.5543188712934, 1108.8613923259593, 25888.8705556471, 29337.706622933925, 29599.556006659917, 30184.54723179154, 30235.546466803014, 1088.080571916729, 1112.5382966069153, 1117.7038084907506, 1126.0878688262533, 1219.1892391559513, 13053.34733263333, 14416.351264193136, 14879.03286286388, 15129.167895765839, 15603.765943510856, 502245.0, 505753.0, 508236.0, 509277.0, 510088.0, 61356.69321653363, 61578.38421615727, 61725.765484690055, 61780.0, 61851.38148618546, 1183.5325046606715, 1356.193065126268, 1368.4526189524072, 1475.6237159524253, 1495.461633811827, 28442.0, 28720.85639571789, 28965.13104606865, 29128.70871291345, 29172.854135729187, 47495.76252118717, 47801.0, 48164.518354816006, 48270.0, 48302.5169748298, 311062.0, 312255.0, 313439.0, 314035.8596414007, 314408.0, 29130.708692913646, 31286.53070203994, 32901.83549082239, 33075.0, 33583.32833343368, 41525.0, 42226.0, 42412.78793606012, 42603.57396425996, 43134.137317254106, 33956.830215848764, 34944.30111397707, 35146.82426587851, 35837.0, 35848.82075589606, 34897.65102348944, 34990.47514287339, 35285.82357088301, 35667.286654267285, 35721.642783571835, 36101.0, 36225.45661815128, 36478.905632831054, 36990.815045924595, 37207.069823254635, 28714.717991963556, 31402.05793826189, 32249.0, 32277.0, 32359.352812944082, 23338.883305583364, 24188.63717044281, 24413.51172976495, 24467.0, 24553.140640077512], "unit": "score", "name": "ext.html", "value": 19619.11965058852}, {"lowerIsBetter": false, "replicates": [354.4700672494619, 358.41220398546386, 363.1303029244958, 368.7861040596454, 368.78794693051503, 19153.616927661456, 19611.5097122572, 21168.57662846746, 21186.788132118712, 21223.36329910103, 12355.876441235585, 17508.774385793, 19778.91215983124, 20286.28997985071, 20317.0, 5126.102931986897, 5284.180951952434, 5334.359876814788, 5343.305370301875, 5352.946470535303, 3286.474164133739, 4127.607877251657, 5287.259783630295, 5725.255716756816, 5943.554233432488, 6012.879742405149, 6024.09638554216, 6033.577649564532, 6038.758449662008, 6040.879182416349, 4875.464228767927, 5452.59105567082, 5715.971420142914, 5724.16999535065, 5989.101634754778, 3786.2048969716393, 5404.891902161974, 5477.890442191134, 5645.971770141164, 5658.971705141489, 13610.319484025758, 13652.931735341359, 13787.448502060006, 13791.10357826738, 13808.309584520734, 2024.1903238704488, 2054.815066643994, 2157.072458842697, 2304.366299267698, 2592.6240695099104, 9694.660686875926, 9782.0, 10017.949910250474, 10133.746656333577, 14127.869770418341, 1678.8321167883237, 1778.6798376292263, 1836.9265229390808, 1848.2976468941852, 1852.4257480181186, 95372.0, 103789.48105259502, 107465.92534074637, 109102.0, 115655.42172289168, 9144.948330941894, 9772.657956971472, 11000.174986876016, 11205.60780372683, 11694.941525292319, 13846.446142154202, 13954.441822327197, 13977.0, 13982.091164074303, 13988.440462381594, 8273.0, 8765.956170219108, 8815.074417186232, 8846.778830529289, 8877.0, 8928.598213080297, 8929.151730585583, 8936.195742383217, 9045.32160087996, 9050.683226087056, 4470.508244093147, 4554.521775213621, 4560.384348113029, 4569.817207311737, 4592.655550833634, 1655.1062426289668, 1743.3636722596414, 1815.5549967209568, 1920.7983161768093, 1959.0400703655391, 869.2611280411726, 927.7216834949488, 995.4773743784571, 1004.9547770350351, 1013.5793645637126, 19541.413757587296, 20800.0, 20820.958952052337, 20912.163513459596, 20959.246741187115, 929.0894922975522, 950.7147855643279, 962.43216502264, 1024.3700124423426, 1046.304207701885, 11036.613718519813, 11211.719707007227, 11216.327020378803, 11220.719482013015, 11221.270617409842, 586791.0, 589563.0, 592962.0, 609086.0, 609837.0, 91008.0, 112122.43938780254, 115045.0, 115101.0, 115648.84351156549, 936.9718908432621, 1018.4398580780542, 1049.4070849969742, 1080.5947769586248, 1081.648464249122, 18017.189226484577, 18431.907840460713, 19051.90474047621, 19059.714104288723, 19318.903405482884, 49986.25020624621, 51035.48964510307, 51045.74477127591, 53335.0, 53523.19715204353, 76037.61981190059, 76732.23267767251, 76886.0, 78572.35704072662, 78893.4221315582, 7572.39420846342, 7799.415043871619, 7812.609369531614, 7885.842283154419, 8206.876896846432, 10809.35143891369, 12060.698482537655, 12432.316222607844, 12448.128630995743, 12578.308193049104, 6638.767643132467, 10886.0, 11125.998660120627, 11252.212345135762, 11331.490082946122, 10603.310784798963, 10705.839412408664, 10898.237123401286, 11050.557977680803, 11139.0, 5621.988042152452, 6368.0, 11064.834027489755, 11179.466164248748, 11195.72010699739, 6554.344565543408, 7748.147703752696, 7805.726799561988, 7857.882131768142, 7973.960130199312, 7558.9244107558225, 7868.370530357673, 7871.606419679108, 8335.874961875455, 8378.120297368932], "unit": "score", "name": "jquery.html", "value": 9010.452716189624}, {"lowerIsBetter": false, "replicates": [1483.6587584855477, 1609.4286528282457, 1633.3384979083469, 1934.7388102606144, 2049.7437820272467, 7981.12207657158, 8563.486190828547, 8731.17053879882, 8738.0, 8745.387822852403, 8428.91571084289, 8669.133086691343, 8703.216710496054, 8712.172343627346, 8756.036835948056, 2180.8800515971616, 2385.057902128658, 2440.0, 2473.369290830836, 2493.987530062347, 2476.2076135636603, 2482.553140434721, 2483.279848843842, 2485.515324511721, 2486.353548077495, 2394.245812569035, 2467.0, 2490.1906880263896, 2490.7384724603926, 2492.9376765580914, 2449.473363226906, 2463.5811911975006, 2469.962950555743, 2480.3923038855414, 2485.192312498445, 2119.2688522459725, 2428.0409238350753, 2467.5558399488086, 2477.6283557466345, 2478.10788116278, 7445.143808462042, 8771.12288771124, 8872.112788721077, 8874.156955089256, 8875.511846848422, 5407.918881216785, 5597.63615365, 5601.691906945116, 5607.943920560783, 5613.915791263134, 3560.3413368526903, 3665.0470877572025, 3738.1962877981364, 3743.737938344317, 3750.8124593770203, 1042.046527427403, 1050.6217761605892, 1052.6736711619346, 1063.547992103353, 1070.304302203566, 11919.702007449796, 11945.163838531307, 11946.10404219687, 11955.82066268998, 11957.521699132025, 4886.804527818918, 4921.581665558396, 4982.402111746614, 5025.296458495814, 5035.345405097387, 10164.949175254224, 10168.440735759605, 10189.898101019044, 10193.388396696222, 10215.642452514126, 5568.9443105569235, 5574.136008918624, 5577.637453565505, 5584.46947539983, 5591.888162236733, 4452.755098469551, 4612.584867361887, 4842.539958703917, 4937.802487900515, 4967.925481117786, 3903.33643280643, 3997.2405243003736, 4019.7789121598007, 4032.7781971991235, 4054.858079967246, 1339.4776037345443, 1341.6042267531102, 1350.4665657065405, 1350.527315439608, 1368.1449094316054, 1157.8784227656142, 1369.664432214114, 1414.56855659025, 1415.179196066279, 1417.121384741467, 8202.958985205156, 8275.793105172419, 8303.377246706521, 8325.958370208231, 8328.458650187718, 520.4327283261264, 531.3039917707738, 532.1538753382141, 537.40348213483, 537.862844974529, 6201.720922558496, 6219.440250377397, 6242.219722534684, 6267.2165979252595, 6275.497960163176, 10309.0, 10651.98806113418, 10665.9466702666, 10667.14662826972, 10676.94661526703, 10142.137918277029, 10613.84079238812, 10656.89343106559, 10662.41356725372, 10672.359658420519, 8130.674773009014, 8253.380996425412, 8263.462874913112, 8320.583970801557, 8321.958390208132, 8028.718994835386, 8058.919410805817, 8111.229433203836, 8182.427230093836, 8187.590620469072, 9448.960614332555, 9449.433034017706, 9541.427514349161, 9595.13643772064, 9611.134997849947, 8362.87455688153, 9722.708318750449, 9886.011398860344, 9966.40201587907, 10059.245556583139, 6813.250542440229, 6875.346842049998, 7454.515456495311, 7542.660580273791, 7600.315971562586, 8243.670253190045, 8246.670133194604, 8272.958635206785, 8285.50286982783, 8294.253517183482, 7287.562746235243, 7376.852462950818, 7382.926170738224, 7520.736774212876, 7556.622168891424, 7229.963850180716, 7235.710571577078, 7280.344768970606, 7311.013013243357, 7325.267473252632, 6725.327467253432, 7719.498232614862, 7841.137474877645, 7845.372370210255, 7852.097008843828, 6811.455083593201, 7000.859982800417, 7095.893561596684, 7101.147862256562, 7104.147502299757, 7020.192677842114, 7075.752348667772, 7080.327368899946, 7097.0, 7106.609136497542], "unit": "score", "name": "mootools.html", "value": 4870.461085800404}, {"lowerIsBetter": false, "replicates": [321.40219192302317, 325.9527368531563, 330.0346486526908, 330.69575990089123, 335.95800524934367, 5094.745262736867, 6331.1769469968895, 6345.682715864205, 6378.649174295418, 6481.416672499474, 6350.301466838644, 6353.777617783378, 6363.840903977403, 6364.949783285764, 6388.520860935437, 4169.124483858393, 4397.702677710083, 4555.74943378114, 4610.0, 4813.927791083128, 4744.051189762062, 4747.504536071144, 4748.097861406339, 4751.14479393709, 4754.809807607691, 4701.294805779126, 4744.478107408182, 4752.643551733617, 4754.500777418373, 4765.380500534926, 3853.6531712146043, 4515.209838278288, 4630.86107416778, 4765.380500534943, 4771.451283102453, 4105.158442519277, 4114.814833332477, 4117.279476091702, 4121.4848143982, 4131.442255295527, 6087.391260873921, 6111.541634377395, 6122.102148333986, 6134.9079763803575, 6137.324894261627, 5551.750171242304, 5555.583331250173, 5571.052921003439, 5574.944250557523, 5579.721013949286, 6787.151606049244, 6789.796306110825, 6792.660366981631, 6797.354251346114, 6810.965945170243, 4259.829606815723, 4441.844535441244, 4474.2841145416905, 4585.564371384713, 4591.311303304497, 6403.551751377452, 6708.027336036247, 7104.325089116525, 7126.964365178193, 7198.280171982812, 4516.345129956204, 4522.66080043998, 4522.977385113053, 4528.954710452919, 4532.206863798888, 3969.7816620085596, 4468.821247150077, 4572.611328037087, 4577.5193604671695, 4583.954160458419, 5430.56555475561, 5433.891322173535, 5438.238646589481, 5443.564514838803, 5455.8090466834265, 6463.15978922737, 6766.424853887376, 6795.7961261162245, 6814.284500127415, 6814.420774234147, 1565.9451919182775, 1581.905085694862, 1596.832332605083, 1599.856012958816, 1605.7671637612714, 976.6386437018349, 1030.685640879539, 1030.9432981185957, 1048.8688913885765, 1057.3867157049046, 6178.41305076017, 6254.718537665816, 6426.646534440557, 6448.097266382711, 6454.096426500294, 7126.857462850714, 7135.036770036082, 7139.428845692332, 7141.535800172972, 7150.713971441188, 5114.74426278692, 5499.752511137009, 6228.750849966042, 6420.0, 6425.421712045845, 3348.8325583721203, 3714.0714821294678, 3771.7548359356556, 3773.2453509298252, 3776.9046976377094, 7165.140183177948, 7460.813479663052, 7481.177070522238, 7518.0, 7558.58427786477, 6242.531810114259, 7399.741009064657, 7419.629018549159, 7421.554706717614, 7434.702611895572, 6140.416660417253, 7325.2308507607, 7460.216677249028, 7488.588127652923, 7520.09758828944, 7134.250903655042, 7138.571685698875, 7145.3926416253125, 7154.284571542804, 7167.8566428672175, 6739.865202696017, 7011.474139439664, 7045.859082818418, 7068.9293107070325, 7087.681054352463, 6044.818655440344, 6141.754329826936, 7414.518056326321, 7488.9625551871895, 7497.325240728361, 4493.6854420190275, 4546.704464209815, 4546.88632784183, 4548.317752337176, 4550.840720574764, 7081.468889833386, 7089.291070892869, 7096.0, 7112.0, 7115.715371385087, 6609.603423794588, 6871.312868713088, 6885.380315771605, 6908.929115986829, 6912.0, 6808.353206445379, 6852.657367131723, 6864.931350686629, 6865.485088618473, 6881.931180688129, 5498.395176530658, 6728.73085076611, 6729.596224226562, 6740.764073257413, 6745.93254067453, 6825.55633883796, 6858.279880612663, 6859.83382824931, 6860.519763616699, 6860.931390686229, 6426.903596446151, 6459.192600924885, 6683.0, 6692.564983276072, 6708.060871478095], "unit": "score", "name": "prototype.html", "value": 4974.658092260628}, {"lowerIsBetter": false, "replicates": [698.8678341087439, 748.1209578744977, 748.9887651685226, 770.0951382126002, 808.5835794565797, 14205.579442055789, 15104.169270690109, 15265.847341526582, 15279.847201527982, 17390.478285651418, 16164.595885102879, 16223.756643650355, 16239.675206495864, 16255.593610159753, 16273.0, 748.1508487866283, 757.3751654884715, 917.6833992272672, 941.4398432932394, 946.6402766948585, 928.2666693312275, 939.8590211468266, 941.3739862991102, 941.6468824190929, 943.4197968249546, 986.2061040862139, 986.7631768375574, 986.9981968302179, 988.2044953812178, 993.6075250276136, 791.3234184771994, 800.0119851982796, 801.7354273089867, 984.8227319082562, 985.5121714751173, 597.8804239152187, 721.6463932673005, 728.4609389052064, 732.3518685962908, 732.5458215906119, 15446.304916278683, 15470.767938480933, 15474.61313467161, 15493.302801373966, 15509.146996915166, 12412.689682757913, 12433.3783310835, 12440.875591244063, 12587.433565489575, 12635.472905418954, 9841.950790246003, 9986.850197247048, 10104.343217690826, 10120.089191972758, 10456.58173673052, 3074.446599612091, 3429.537012503305, 3442.7245820334315, 3552.6447355264527, 3589.856405743767, 81334.59332703358, 81346.77979830308, 82017.35965280721, 82109.0, 82796.58601706952, 9302.90697093034, 9374.343795934356, 9389.90610093904, 9453.101955314234, 9961.203103751683, 21449.356519304445, 21714.674279885814, 21740.782592174193, 21753.45616359572, 21773.782262177174, 7521.946927430165, 7539.170691223961, 7662.73180438682, 7709.845803084019, 7866.6066696666085, 4154.729942553724, 4207.789610519461, 4211.894702632459, 4271.786410679453, 4482.260427029569, 3643.544556930384, 3682.1715114099648, 3682.5765037021088, 3684.502592150079, 3688.981555092207, 667.8764428580728, 672.8082496488576, 673.9663016849236, 686.5091459606406, 699.1610067918518, 502.7209898506364, 559.4293820303268, 578.5227187570272, 616.2050954268943, 627.1282916745727, 7881.605919703992, 8049.758507244792, 8078.798030049295, 8137.186281371815, 8188.959055204805, 502.8692539939569, 547.9178123281459, 577.4254616656453, 577.8670905691714, 617.2685367839035, 3762.9247415051545, 3768.7927164005696, 3774.7735135891935, 3778.886633401002, 3990.182012687392, 93898.53050734702, 94029.0, 94062.52968735113, 94706.0, 95130.52434737782, 72397.63801181066, 78962.6051869737, 79153.60423197848, 79169.0, 79251.8112228317, 68649.31350686429, 69407.26481837995, 69828.30171698218, 70902.0, 73206.63396682983, 7723.961380193063, 7729.9227007729205, 7813.570253636105, 7848.7645370638975, 7903.762887113396, 48014.0, 48155.5184448165, 48754.512454874995, 48844.2673359907, 49648.751756240985, 65545.0, 68660.31339686539, 70566.0, 70616.94074588783, 70816.64591677215, 9803.705888823346, 9904.900950990397, 10341.63804266847, 10718.035376816124, 11014.650564244577, 11532.481038353126, 11769.999550038343, 12051.698707532381, 12284.385780711107, 12342.074344424384, 10637.42672538627, 10988.175886808682, 11104.722381940193, 11169.218154729091, 11318.26431281964, 9695.806083878424, 10990.725231868948, 11198.888011119785, 11589.536418543501, 11716.414179291172, 10807.35155890649, 10845.566177352817, 10880.564777409132, 11259.887401126212, 11755.05959523219, 9085.2731781456, 9387.530623468663, 9484.715458536255, 9724.465154416575, 10290.691279261635, 8371.916280837357, 8513.702020429255, 8964.462132272085, 8973.461592304482, 9116.90883091187], "unit": "score", "name": "yui.html", "value": 6910.593131683865}], "name": "dromaeo_css", "value": 7423.815784568538}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 110.0, 111.0, 116.0, 113.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 149.0, 196.0, 142.0, 142.0, 140.0, 119.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 185.0, 185.0, 186.0, 185.0, 179.0, 184.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 84.0, 80.0, 80.0, 80.0, 84.0, 96.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 128.0, 78.0, 79.0, 84.0, 114.0, 86.0, 115.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 102.1}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 87.0, 92.0, 129.0, 89.0, 89.0, 133.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.1}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 87.0, 114.0, 134.0, 132.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 58.0, 57.0, 56.0, 56.0, 56.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 74.0, 71.0, 69.0, 67.0, 65.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 80.0, 87.0, 83.0, 82.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 132.0, 119.0, 121.0, 129.0, 128.0, 128.0, 139.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [138.0, 123.0, 136.0, 131.0, 142.0, 135.0, 136.0, 135.0, 133.0, 160.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 68.0, 65.0, 69.0, 67.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1451.4000000000005}]} 05:13:18 INFO - Return code: 0 05:13:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:13:18 ERROR - # TBPL SUCCESS # 05:13:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:18 INFO - 2016-03-22 05:13:18.908 screenresolution[1685:9959] starting screenresolution argv=screenresolution get 05:13:18 INFO - 2016-03-22 05:13:18.910 screenresolution[1685:9959] Display 0: 1600x1200x32@60 05:13:18 INFO - 2016-03-22 05:13:18.916 screenresolution[1686:9962] starting screenresolution argv=screenresolution list 05:13:18 INFO - Available Modes on Display 0 05:13:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:19 INFO - Intel Iris: 05:13:19 INFO - Chipset Model: Intel Iris 05:13:19 INFO - Type: GPU 05:13:19 INFO - Bus: Built-In 05:13:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:19 INFO - Vendor: Intel (0x8086) 05:13:19 INFO - Device ID: 0x0a2e 05:13:19 INFO - Revision ID: 0x0009 05:13:19 INFO - Displays: 05:13:19 INFO - Display: 05:13:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:19 INFO - Display Serial Number: 1600x1200 60 05:13:19 INFO - Main Display: Yes 05:13:19 INFO - Mirror: Off 05:13:19 INFO - Online: Yes 05:13:19 INFO - Rotation: Supported 05:13:19 INFO - Return code: 0 05:13:19 INFO - Running post-action listener: _resource_record_post_action 05:13:19 INFO - Running post-run listener: _resource_record_post_run 05:13:20 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39544320; Write bytes: 705636352; Read time: 424; Write time: 2015 05:13:20 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395944448; Write bytes: 390592512; Read time: 29861; Write time: 732 05:13:20 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37758464; Write bytes: 299851776; Read time: 404; Write time: 1244 05:13:20 INFO - Running post-run listener: _upload_blobber_files 05:13:20 INFO - Blob upload gear active. 05:13:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:13:20 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'] 05:13:20 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 05:13:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:13:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:13:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:22 INFO - (blobuploader) - INFO - Done attempting. 05:13:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:13:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:13:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:23 INFO - (blobuploader) - INFO - Done attempting. 05:13:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:23 INFO - Return code: 0 05:13:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727f48cf61ef24d7f3f53a138d7fefa2f7efe606124cbd835104ea2805dfd875ee3c07a5a6463fff17f15f2eff11614a2ef6cb2a77d2d1ce9d1dc21d9b598048", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb459e59e37348357346f091310c10ab363d3b6837d9273c5c1b06c434f39b5d1db5fdc1fa16f95aa4bf4ae224c376c8d9ca041b6b98f744f9b587679e9c17cb"} 05:13:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:23 INFO - Contents: 05:13:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727f48cf61ef24d7f3f53a138d7fefa2f7efe606124cbd835104ea2805dfd875ee3c07a5a6463fff17f15f2eff11614a2ef6cb2a77d2d1ce9d1dc21d9b598048", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb459e59e37348357346f091310c10ab363d3b6837d9273c5c1b06c434f39b5d1db5fdc1fa16f95aa4bf4ae224c376c8d9ca041b6b98f744f9b587679e9c17cb"} 05:13:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:23 INFO - Copying logs to upload dir... 05:13:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.945381 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-22 05:13:23.487668) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:13:23.494832) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727f48cf61ef24d7f3f53a138d7fefa2f7efe606124cbd835104ea2805dfd875ee3c07a5a6463fff17f15f2eff11614a2ef6cb2a77d2d1ce9d1dc21d9b598048", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb459e59e37348357346f091310c10ab363d3b6837d9273c5c1b06c434f39b5d1db5fdc1fa16f95aa4bf4ae224c376c8d9ca041b6b98f744f9b587679e9c17cb"} build_url:https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010887 build_url: 'https://queue.taskcluster.net/v1/task/MCJZ81mHRl62xOeEkirUyA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727f48cf61ef24d7f3f53a138d7fefa2f7efe606124cbd835104ea2805dfd875ee3c07a5a6463fff17f15f2eff11614a2ef6cb2a77d2d1ce9d1dc21d9b598048", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb459e59e37348357346f091310c10ab363d3b6837d9273c5c1b06c434f39b5d1db5fdc1fa16f95aa4bf4ae224c376c8d9ca041b6b98f744f9b587679e9c17cb"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 05:13:23.563188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:13:23.566531) ========= 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.j9kdkbPBnF/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.6kAKbOUoZX/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005237 ========= master_lag: 0.32 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 05:13:23.889203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:13:23.889556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 05:13:23.897166) ========= ========= Total master_lag: 2.02 =========