builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1459347082.37 results: success (0) buildid: 20160330040937 builduid: 96fa7cf3d24f403faf24d573f63e7bc0 revision: 48d54c93dcf3c14dff0788b85703341b45e510a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:22.372286) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:22.373225) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:22.373918) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005419 basedir: '/builds/slave/test' ========= master_lag: 0.44 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:22.821451) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:22.821798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:23.626696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:23.627158) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005940 ========= master_lag: 0.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.063259) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.063645) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.064063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.064378) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-30 07:11:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-03-30 07:11:24 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189248 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.461729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.462101) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.033453 ========= master_lag: 0.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:24.884097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-30 07:11:24.884574) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48d54c93dcf3c14dff0788b85703341b45e510a9 --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 48d54c93dcf3c14dff0788b85703341b45e510a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-30 07:11:25,063 truncating revision to first 12 chars 2016-03-30 07:11:25,063 Setting DEBUG logging. 2016-03-30 07:11:25,063 attempt 1/10 2016-03-30 07:11:25,063 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48d54c93dcf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 07:11:26,595 unpacking tar archive at: fx-team-48d54c93dcf3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.782466 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-30 07:11:26.886103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:26.886434) ========= echo 48d54c93dcf3c14dff0788b85703341b45e510a9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'48d54c93dcf3c14dff0788b85703341b45e510a9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 48d54c93dcf3c14dff0788b85703341b45e510a9 program finished with exit code 0 elapsedTime=0.006375 script_repo_revision: '48d54c93dcf3c14dff0788b85703341b45e510a9' ========= master_lag: 0.53 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:27.426979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:27.427253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 07:11:28.363902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-30 07:11:28.364313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:11:28 INFO - MultiFileLogger online at 20160330 07:11:28 in /builds/slave/test 07:11:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:11:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:28 INFO - {'append_to_log': False, 07:11:28 INFO - 'base_work_dir': '/builds/slave/test', 07:11:28 INFO - 'blob_upload_branch': 'Fx-Team', 07:11:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:28 INFO - 'branch': 'Fx-Team', 07:11:28 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:28 INFO - 'config_files': ('talos/mac_config.py',), 07:11:28 INFO - 'default_actions': ('clobber', 07:11:28 INFO - 'read-buildbot-config', 07:11:28 INFO - 'download-and-extract', 07:11:28 INFO - 'populate-webroot', 07:11:28 INFO - 'create-virtualenv', 07:11:28 INFO - 'install', 07:11:28 INFO - 'run-tests'), 07:11:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:28 INFO - 'download_minidump_stackwalk': True, 07:11:28 INFO - 'download_symbols': 'ondemand', 07:11:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:28 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:28 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:28 INFO - 'installer_path': 'installer.exe', 07:11:28 INFO - 'log_level': 'info', 07:11:28 INFO - 'log_name': 'talos', 07:11:28 INFO - 'log_to_console': True, 07:11:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:11:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:11:28 INFO - 'opt_config_files': (), 07:11:28 INFO - 'pip_index': False, 07:11:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:28 INFO - 'cmd': ('bash', 07:11:28 INFO - '-c', 07:11:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:28 INFO - 'enabled': True, 07:11:28 INFO - 'halt_on_failure': False, 07:11:28 INFO - 'name': 'check_screen_resolution'},), 07:11:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:11:28 INFO - 'cmd': ('bash', 07:11:28 INFO - '-c', 07:11:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:11:28 INFO - 'enabled': True, 07:11:28 INFO - 'halt_on_failure': False, 07:11:28 INFO - 'name': 'check_screen_resolution'},), 07:11:28 INFO - 'run_cmd_checks_enabled': True, 07:11:28 INFO - 'sps_profile': False, 07:11:28 INFO - 'sps_profile_interval': 0, 07:11:28 INFO - 'suite': 'dromaeojs-e10s', 07:11:28 INFO - 'system_bits': '32', 07:11:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:28 INFO - 'title': 't-yosemite-r7-0140', 07:11:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:28 INFO - 'use_talos_json': True, 07:11:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:28 INFO - 'work_dir': 'build'} 07:11:28 INFO - ##### 07:11:28 INFO - ##### Running clobber step. 07:11:28 INFO - ##### 07:11:28 INFO - Running pre-action listener: _resource_record_pre_action 07:11:28 INFO - Running main action method: clobber 07:11:28 INFO - rmtree: /builds/slave/test/build 07:11:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:30 INFO - Running post-action listener: _resource_record_post_action 07:11:30 INFO - ##### 07:11:30 INFO - ##### Running read-buildbot-config step. 07:11:30 INFO - ##### 07:11:30 INFO - Running pre-action listener: _resource_record_pre_action 07:11:30 INFO - Running main action method: read_buildbot_config 07:11:30 INFO - Using buildbot properties: 07:11:30 INFO - { 07:11:30 INFO - "project": "", 07:11:30 INFO - "product": "firefox", 07:11:30 INFO - "script_repo_revision": "production", 07:11:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 07:11:30 INFO - "repository": "", 07:11:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 07:11:30 INFO - "buildid": "20160330040937", 07:11:30 INFO - "pgo_build": "False", 07:11:30 INFO - "basedir": "/builds/slave/test", 07:11:30 INFO - "buildnumber": 574, 07:11:30 INFO - "slavename": "t-yosemite-r7-0140", 07:11:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:11:30 INFO - "platform": "yosemite_r7", 07:11:30 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 07:11:30 INFO - "branch": "fx-team", 07:11:30 INFO - "repo_path": "integration/fx-team", 07:11:30 INFO - "revision": "48d54c93dcf3c14dff0788b85703341b45e510a9", 07:11:30 INFO - "stage_platform": "macosx64", 07:11:30 INFO - "builduid": "96fa7cf3d24f403faf24d573f63e7bc0", 07:11:30 INFO - "slavebuilddir": "test" 07:11:30 INFO - } 07:11:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:11:30 INFO - Running post-action listener: _resource_record_post_action 07:11:30 INFO - ##### 07:11:30 INFO - ##### Running download-and-extract step. 07:11:30 INFO - ##### 07:11:30 INFO - Running pre-action listener: _resource_record_pre_action 07:11:30 INFO - Running main action method: download_and_extract 07:11:30 INFO - mkdir: /builds/slave/test/build/tests 07:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:30 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:11:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:11:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:11:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:32 INFO - Downloaded 1199 bytes. 07:11:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:11:32 INFO - Using the following test package requirements: 07:11:32 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:11:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:11:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:11:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'jsshell-mac.zip'], 07:11:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:11:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:11:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:11:32 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:11:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:11:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:11:32 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:11:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:11: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')]} 07:11:32 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:11:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:11:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:11:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:34 INFO - Downloaded 17946676 bytes. 07:11:34 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'] 07:11:34 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 07:11:37 INFO - Return code: 0 07:11:37 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 07:11:37 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')]} 07:11:37 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:39 INFO - Downloaded 17946676 bytes. 07:11:39 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'] 07:11:39 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 07:11:42 INFO - Return code: 0 07:11:42 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')]} 07:11:42 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:44 INFO - Downloaded 10847531 bytes. 07:11:44 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'] 07:11:44 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 07:11:44 INFO - Return code: 0 07:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:44 INFO - https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPzsJe5OS-mWjJAqYmt4mA/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 07:11:49 INFO - Downloaded 111429329 bytes. 07:11:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:11:49 INFO - mkdir: /builds/slave/test/properties 07:11:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:49 INFO - Contents: 07:11:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:11:51 INFO - Running post-action listener: _resource_record_post_action 07:11:51 INFO - Running post-action listener: set_extra_try_arguments 07:11:51 INFO - ##### 07:11:51 INFO - ##### Running populate-webroot step. 07:11:51 INFO - ##### 07:11:51 INFO - Running pre-action listener: _resource_record_pre_action 07:11:51 INFO - Running main action method: populate_webroot 07:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:51 INFO - '--tppagecycles', 07:11:51 INFO - '7'], 07:11:51 INFO - 'tests': ['tsvgm']}}, 07:11:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:11:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:11:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'tests': ['damp', 'tps']}, 07:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['damp', 'tps']}, 07:11:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:11:51 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['dromaeo_dom']}, 07:11:51 INFO - 'other': {'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'other_l64': {'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'other_nol64': {'tests': ['a11yr', 07:11:51 INFO - 'ts_paint', 07:11:51 INFO - 'tpaint', 07:11:51 INFO - 'sessionrestore', 07:11:51 INFO - 'sessionrestore_no_auto_restore', 07:11:51 INFO - 'tabpaint']}, 07:11:51 INFO - 'svgr': {'tests': ['tsvgx', 07:11:51 INFO - 'tsvgr_opacity', 07:11:51 INFO - 'tart', 07:11:51 INFO - 'tscrollx', 07:11:51 INFO - 'cart']}, 07:11:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['tsvgx', 07:11:51 INFO - 'tsvgr_opacity', 07:11:51 INFO - 'tart', 07:11:51 INFO - 'tscrollx', 07:11:51 INFO - 'cart']}, 07:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'tests': ['tp5o']}, 07:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'talos_options': ['--e10s'], 07:11:51 INFO - 'tests': ['tp5o']}, 07:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'talos_options': ['--xperf_path', 07:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:51 INFO - 'tests': ['tp5n']}, 07:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:51 INFO - 'talos_options': ['--e10s', 07:11:51 INFO - '--xperf_path', 07:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:51 INFO - 'tests': ['tp5n']}}, 07:11:51 INFO - 'talos.zip': {'path': '', 07:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:51 INFO - Running post-action listener: _resource_record_post_action 07:11:51 INFO - ##### 07:11:51 INFO - ##### Running create-virtualenv step. 07:11:51 INFO - ##### 07:11:51 INFO - Running pre-action listener: _resource_record_pre_action 07:11:51 INFO - Running main action method: create_virtualenv 07:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:51 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 07:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:51 INFO - Using real prefix '/tools/python27' 07:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:55 INFO - Installing pip.................done. 07:11:55 INFO - Return code: 0 07:11:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:11:55 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 07:11:55 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 07:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:55 INFO - 'HOME': '/Users/cltbld', 07:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:55 INFO - 'LOGNAME': 'cltbld', 07:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:55 INFO - 'MOZ_NO_REMOTE': '1', 07:11:55 INFO - 'NO_EM_RESTART': '1', 07:11:55 INFO - 'PAGER': '/bin/cat', 07:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:55 INFO - 'PWD': '/builds/slave/test', 07:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:55 INFO - 'SHELL': '/bin/bash', 07:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:11:55 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:55 INFO - 'USER': 'cltbld', 07:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:55 INFO - 'XPC_FLAGS': '0x0', 07:11:55 INFO - 'XPC_SERVICE_NAME': '0', 07:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:55 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 07:11:55 INFO - Cleaning up... 07:11:55 INFO - Return code: 0 07:11:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:55 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:11:55 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 07:11:55 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 07:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:11:55 INFO - 'HOME': '/Users/cltbld', 07:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:11:55 INFO - 'LOGNAME': 'cltbld', 07:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:55 INFO - 'MOZ_NO_REMOTE': '1', 07:11:55 INFO - 'NO_EM_RESTART': '1', 07:11:55 INFO - 'PAGER': '/bin/cat', 07:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:55 INFO - 'PWD': '/builds/slave/test', 07:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:11:55 INFO - 'SHELL': '/bin/bash', 07:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:11:55 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:11:55 INFO - 'USER': 'cltbld', 07:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:55 INFO - 'XPC_FLAGS': '0x0', 07:11:55 INFO - 'XPC_SERVICE_NAME': '0', 07:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:55 INFO - Downloading/unpacking psutil>=0.7.1 07:11:55 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 07:11:55 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 07:11:55 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 07:11:55 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 07:11:55 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 07:11:55 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 07:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:59 INFO - Installing collected packages: psutil 07:11:59 INFO - Running setup.py install for psutil 07:11:59 INFO - building 'psutil._psutil_osx' extension 07:11:59 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 07:11:59 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 07:11:59 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 07:12:00 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 07:12:00 INFO - building 'psutil._psutil_posix' extension 07:12:00 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 07:12:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:12:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:12:00 INFO - ^ 07:12:00 INFO - 1 warning generated. 07:12:00 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 07:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:12:00 INFO - Successfully installed psutil 07:12:00 INFO - Cleaning up... 07:12:00 INFO - Return code: 0 07:12:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:12:00 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')]} 07:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:00 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')]} 07:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:00 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:00 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 07:12:00 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 07:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:00 INFO - 'HOME': '/Users/cltbld', 07:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:00 INFO - 'LOGNAME': 'cltbld', 07:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:00 INFO - 'MOZ_NO_REMOTE': '1', 07:12:00 INFO - 'NO_EM_RESTART': '1', 07:12:00 INFO - 'PAGER': '/bin/cat', 07:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:00 INFO - 'PWD': '/builds/slave/test', 07:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:00 INFO - 'SHELL': '/bin/bash', 07:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:00 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:00 INFO - 'USER': 'cltbld', 07:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:00 INFO - 'XPC_FLAGS': '0x0', 07:12:00 INFO - 'XPC_SERVICE_NAME': '0', 07:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12: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 07:12:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:12:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:12:04 INFO - Installing collected packages: mozsystemmonitor 07:12:04 INFO - Running setup.py install for mozsystemmonitor 07:12:04 INFO - Successfully installed mozsystemmonitor 07:12:04 INFO - Cleaning up... 07:12:04 INFO - Return code: 0 07:12:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:04 INFO - 'HOME': '/Users/cltbld', 07:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:04 INFO - 'LOGNAME': 'cltbld', 07:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:04 INFO - 'MOZ_NO_REMOTE': '1', 07:12:04 INFO - 'NO_EM_RESTART': '1', 07:12:04 INFO - 'PAGER': '/bin/cat', 07:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:04 INFO - 'PWD': '/builds/slave/test', 07:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:04 INFO - 'SHELL': '/bin/bash', 07:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:04 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:04 INFO - 'USER': 'cltbld', 07:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:04 INFO - 'XPC_FLAGS': '0x0', 07:12:04 INFO - 'XPC_SERVICE_NAME': '0', 07:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:12:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:12:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:08 INFO - Downloading docopt-0.6.1.tar.gz 07:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:12:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:12:08 INFO - Running setup.py install for blobuploader 07:12:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:12:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:12:08 INFO - Running setup.py install for requests 07:12:09 INFO - Running setup.py install for docopt 07:12:09 INFO - Successfully installed blobuploader requests docopt 07:12:09 INFO - Cleaning up... 07:12:09 INFO - Return code: 0 07:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:09 INFO - 'HOME': '/Users/cltbld', 07:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:09 INFO - 'LOGNAME': 'cltbld', 07:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:09 INFO - 'MOZ_NO_REMOTE': '1', 07:12:09 INFO - 'NO_EM_RESTART': '1', 07:12:09 INFO - 'PAGER': '/bin/cat', 07:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:09 INFO - 'PWD': '/builds/slave/test', 07:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:09 INFO - 'SHELL': '/bin/bash', 07:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:09 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:09 INFO - 'USER': 'cltbld', 07:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:09 INFO - 'XPC_FLAGS': '0x0', 07:12:09 INFO - 'XPC_SERVICE_NAME': '0', 07:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SDpiIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:09 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Vb7YJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-XcZ7Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-BpAVat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-lMnJh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uDP40m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-EwUp5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-eY_x48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MsEGHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-xszyZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Snznp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:10 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-AYN_tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:11 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Ti53R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:11 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-a_nfV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6sCHyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-lfhgJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FPYAfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:12:11 INFO - Running setup.py install for manifestparser 07:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:12:11 INFO - Running setup.py install for mozcrash 07:12:11 INFO - Running setup.py install for mozdebug 07:12:11 INFO - Running setup.py install for mozdevice 07:12:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozfile 07:12:12 INFO - Running setup.py install for mozhttpd 07:12:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozinfo 07:12:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozInstall 07:12:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:12:12 INFO - Running setup.py install for mozleak 07:12:12 INFO - Running setup.py install for mozlog 07:12:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Running setup.py install for moznetwork 07:12:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Running setup.py install for mozprocess 07:12:13 INFO - Running setup.py install for mozprofile 07:12:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Running setup.py install for mozrunner 07:12:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:12:13 INFO - Running setup.py install for mozscreenshot 07:12:13 INFO - Running setup.py install for moztest 07:12:13 INFO - Running setup.py install for mozversion 07:12:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:12:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:12:14 INFO - Cleaning up... 07:12:14 INFO - Return code: 0 07:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:14 INFO - 'HOME': '/Users/cltbld', 07:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:14 INFO - 'LOGNAME': 'cltbld', 07:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:14 INFO - 'MOZ_NO_REMOTE': '1', 07:12:14 INFO - 'NO_EM_RESTART': '1', 07:12:14 INFO - 'PAGER': '/bin/cat', 07:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:14 INFO - 'PWD': '/builds/slave/test', 07:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:14 INFO - 'SHELL': '/bin/bash', 07:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:14 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:14 INFO - 'USER': 'cltbld', 07:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:14 INFO - 'XPC_FLAGS': '0x0', 07:12:14 INFO - 'XPC_SERVICE_NAME': '0', 07:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uAlWdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-_BUS8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-TYinof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ebiKiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-1x7wuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:12:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:12:14 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uLeqB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-I1yD3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-1uwvBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-m7Y5g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zjFFKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5Yntmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-OdwvaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Xp1PeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-kh4wF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:12:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-30k13j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:12:15 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)) 07:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:12:15 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-IX7Jjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:12:16 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9TGdKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:12:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:20 INFO - Downloading blessings-1.6.tar.gz 07:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:12:20 INFO - Installing collected packages: blessings 07:12:20 INFO - Running setup.py install for blessings 07:12:20 INFO - Successfully installed blessings 07:12:20 INFO - Cleaning up... 07:12:20 INFO - Return code: 0 07:12:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:21 INFO - Reading from file tmpfile_stdout 07:12:21 INFO - Current package versions: 07:12:21 INFO - blessings == 1.6 07:12:21 INFO - blobuploader == 1.2.4 07:12:21 INFO - docopt == 0.6.1 07:12:21 INFO - manifestparser == 1.1 07:12:21 INFO - mozInstall == 1.12 07:12:21 INFO - mozcrash == 0.17 07:12:21 INFO - mozdebug == 0.1 07:12:21 INFO - mozdevice == 0.48 07:12:21 INFO - mozfile == 1.2 07:12:21 INFO - mozhttpd == 0.7 07:12:21 INFO - mozinfo == 0.9 07:12:21 INFO - mozleak == 0.1 07:12:21 INFO - mozlog == 3.1 07:12:21 INFO - moznetwork == 0.27 07:12:21 INFO - mozprocess == 0.22 07:12:21 INFO - mozprofile == 0.28 07:12:21 INFO - mozrunner == 6.11 07:12:21 INFO - mozscreenshot == 0.1 07:12:21 INFO - mozsystemmonitor == 0.0 07:12:21 INFO - moztest == 0.7 07:12:21 INFO - mozversion == 1.4 07:12:21 INFO - psutil == 3.1.1 07:12:21 INFO - requests == 1.2.3 07:12:21 INFO - wsgiref == 0.1.2 07:12:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:12:21 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')]} 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:21 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')]} 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:21 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:21 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 07:12:21 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 07:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:21 INFO - 'HOME': '/Users/cltbld', 07:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:21 INFO - 'LOGNAME': 'cltbld', 07:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:21 INFO - 'MOZ_NO_REMOTE': '1', 07:12:21 INFO - 'NO_EM_RESTART': '1', 07:12:21 INFO - 'PAGER': '/bin/cat', 07:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:21 INFO - 'PWD': '/builds/slave/test', 07:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:21 INFO - 'SHELL': '/bin/bash', 07:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:21 INFO - 'USER': 'cltbld', 07:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:21 INFO - 'XPC_FLAGS': '0x0', 07:12:21 INFO - 'XPC_SERVICE_NAME': '0', 07:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 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)) 07:12:21 INFO - Cleaning up... 07:12:21 INFO - Return code: 0 07:12:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:12:21 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')]} 07:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:21 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')]} 07:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:21 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:21 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 07:12:21 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 07:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:21 INFO - 'HOME': '/Users/cltbld', 07:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:21 INFO - 'LOGNAME': 'cltbld', 07:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:21 INFO - 'MOZ_NO_REMOTE': '1', 07:12:21 INFO - 'NO_EM_RESTART': '1', 07:12:21 INFO - 'PAGER': '/bin/cat', 07:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:21 INFO - 'PWD': '/builds/slave/test', 07:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:21 INFO - 'SHELL': '/bin/bash', 07:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:21 INFO - 'USER': 'cltbld', 07:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:21 INFO - 'XPC_FLAGS': '0x0', 07:12:21 INFO - 'XPC_SERVICE_NAME': '0', 07:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:22 INFO - Downloading/unpacking jsonschema 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:12:27 INFO - Downloading/unpacking functools32 (from jsonschema) 07:12:27 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 07:12:27 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 07:12:27 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 07:12:27 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 07:12:27 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 07:12:27 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 07:12:27 INFO - Downloading functools32-3.2.3-2.tar.gz 07:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:12:27 INFO - warning: no files found matching '*.txt' 07:12:27 INFO - no previously-included directories found matching 'build' 07:12:27 INFO - no previously-included directories found matching 'dist' 07:12:27 INFO - no previously-included directories found matching '.git*' 07:12:27 INFO - Installing collected packages: jsonschema, functools32 07:12:27 INFO - Running setup.py install for functools32 07:12:27 INFO - warning: no files found matching '*.txt' 07:12:27 INFO - no previously-included directories found matching 'build' 07:12:27 INFO - no previously-included directories found matching 'dist' 07:12:27 INFO - no previously-included directories found matching '.git*' 07:12:27 INFO - Successfully installed jsonschema functools32 07:12:27 INFO - Cleaning up... 07:12:27 INFO - Return code: 0 07:12:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:12:27 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')]} 07:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 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')]} 07:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:12:27 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 0x104b02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b12420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa328cac430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, '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.xDywQxhl4g/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.1lqxmEWxQP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 07:12:27 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 07:12:27 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 07:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:12:27 INFO - 'HOME': '/Users/cltbld', 07:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:12:27 INFO - 'LOGNAME': 'cltbld', 07:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:27 INFO - 'MOZ_NO_REMOTE': '1', 07:12:27 INFO - 'NO_EM_RESTART': '1', 07:12:27 INFO - 'PAGER': '/bin/cat', 07:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:27 INFO - 'PWD': '/builds/slave/test', 07:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:12:27 INFO - 'SHELL': '/bin/bash', 07:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:12:27 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:12:27 INFO - 'USER': 'cltbld', 07:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:27 INFO - 'XPC_FLAGS': '0x0', 07:12:27 INFO - 'XPC_SERVICE_NAME': '0', 07:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:12:28 INFO - Downloading/unpacking flake8 07:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:12:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:12:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:12:33 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 07:12:33 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 07:12:33 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 07:12:33 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 07:12:33 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 07:12:33 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 07:12:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:12:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:34 INFO - no previously-included directories found matching 'docs/_build' 07:12:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:12:35 INFO - Running setup.py install for pep8 07:12:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:35 INFO - no previously-included directories found matching 'docs/_build' 07:12:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:35 INFO - Cleaning up... 07:12:35 INFO - Return code: 0 07:12:35 INFO - Running post-action listener: _resource_record_post_action 07:12:35 INFO - Running post-action listener: _start_resource_monitoring 07:12:35 INFO - Starting resource monitoring. 07:12:35 INFO - ##### 07:12:35 INFO - ##### Running install step. 07:12:35 INFO - ##### 07:12:35 INFO - Running pre-action listener: _resource_record_pre_action 07:12:35 INFO - Running main action method: install 07:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:35 INFO - Reading from file tmpfile_stdout 07:12:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:35 INFO - Reading from file tmpfile_stdout 07:12:35 INFO - Output received: 07:12:35 INFO - Usage: mozinstall [options] installer 07:12:35 INFO - Options: 07:12:35 INFO - -h, --help show this help message and exit 07:12:35 INFO - -d DEST, --destination=DEST 07:12:35 INFO - Directory to install application into. [default: 07:12:35 INFO - "/builds/slave/test"] 07:12:35 INFO - --app=APP Application being installed. [default: firefox] 07:12:35 INFO - mkdir: /builds/slave/test/build/application 07:12:35 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'] 07:12:35 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 07:13:09 INFO - Reading from file tmpfile_stdout 07:13:09 INFO - Output received: 07:13:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:13:09 INFO - Running post-action listener: _resource_record_post_action 07:13:09 INFO - ##### 07:13:09 INFO - ##### Running run-tests step. 07:13:09 INFO - ##### 07:13:09 INFO - Running pre-action listener: _resource_record_pre_action 07:13:09 INFO - Running main action method: run_tests 07:13:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:13:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:13:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:13:09 INFO - 2016-03-30 07:13:09.853 screenresolution[1650:7610] starting screenresolution argv=screenresolution get 07:13:09 INFO - 2016-03-30 07:13:09.855 screenresolution[1650:7610] Display 0: 1600x1200x32@60 07:13:09 INFO - 2016-03-30 07:13:09.860 screenresolution[1651:7612] starting screenresolution argv=screenresolution list 07:13:09 INFO - Available Modes on Display 0 07:13:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:13:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:13:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:13:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:13:10 INFO - Intel Iris: 07:13:10 INFO - Chipset Model: Intel Iris 07:13:10 INFO - Type: GPU 07:13:10 INFO - Bus: Built-In 07:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 07:13:10 INFO - Vendor: Intel (0x8086) 07:13:10 INFO - Device ID: 0x0a2e 07:13:10 INFO - Revision ID: 0x0009 07:13:10 INFO - Displays: 07:13:10 INFO - Display: 07:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:13:10 INFO - Display Serial Number: 1600x1200 60 07:13:10 INFO - Main Display: Yes 07:13:10 INFO - Mirror: Off 07:13:10 INFO - Online: Yes 07:13:10 INFO - Rotation: Supported 07:13:10 INFO - Return code: 0 07:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:10 INFO - Python 2.7.3 07:13:10 INFO - Return code: 0 07:13:10 INFO - grabbing minidump binary from tooltool 07:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:10 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 0x1049a1e00>, '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 0x10480adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10499cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:10 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 07:13:10 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 07:13:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:10 INFO - Return code: 0 07:13:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:13:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:13:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:13:11 INFO - Return code: 0 07:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xDywQxhl4g/Render', 07:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:13:11 INFO - 'HOME': '/Users/cltbld', 07:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:13:11 INFO - 'LOGNAME': 'cltbld', 07:13:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:11 INFO - 'MOZ_NO_REMOTE': '1', 07:13:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:11 INFO - 'NO_EM_RESTART': '1', 07:13:11 INFO - 'PAGER': '/bin/cat', 07:13:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:11 INFO - 'PWD': '/builds/slave/test', 07:13:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:13:11 INFO - 'SHELL': '/bin/bash', 07:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1lqxmEWxQP/Listeners', 07:13:11 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 07:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:13:11 INFO - 'USER': 'cltbld', 07:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:11 INFO - 'XPC_FLAGS': '0x0', 07:13:11 INFO - 'XPC_SERVICE_NAME': '0', 07:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:13:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:13:11 INFO - mozversion application_buildid: 20160330040937 07:13:11 INFO - mozversion application_changeset: 48d54c93dcf3c14dff0788b85703341b45e510a9 07:13:11 INFO - mozversion application_display_name: Nightly 07:13:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:11 INFO - mozversion application_name: Firefox 07:13:11 INFO - mozversion application_remotingname: firefox 07:13:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:13:11 INFO - mozversion application_vendor: Mozilla 07:13:11 INFO - mozversion application_version: 48.0a1 07:13:11 INFO - mozversion platform_buildid: 20160330040937 07:13:11 INFO - mozversion platform_changeset: 48d54c93dcf3c14dff0788b85703341b45e510a9 07:13:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:13:11 INFO - mozversion platform_version: 48.0a1 07:13:11 INFO - using testdate: 1459347191 07:13:11 INFO - actual date: 1459347191 07:13:11 INFO - starting webserver on 'localhost:49272' 07:13:11 INFO - SUITE-START | Running 2 tests 07:13:11 INFO - TEST-START | dromaeo_css 07:13:11 INFO - operating with platform_type : mac_ 07:13:11 INFO - Initialising browser for dromaeo_css test... 07:13:11 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp06Y_qC/profile http://localhost:49272/getInfo.html) 07:13:14 INFO - PROCESS | 1669 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:13:14 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 07:13:14 INFO - PROCESS | 1669 | colorDepth:24 07:13:14 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 07:13:14 INFO - PROCESS | 1669 | __metrics 07:13:14 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 07:13:15 INFO - TEST-INFO | 1669: exit 0 07:13:15 INFO - Browser initialized. 07:13:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:13:15 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp06Y_qC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:13:27 INFO - PROCESS | 1673 | RSS: Main: 254586880 07:13:27 INFO - PROCESS | 1673 | 07:14:16 INFO - PROCESS | 1673 | 1459347256986 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] 07:16:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 07:16:29 INFO - PROCESS | 1673 | RSS: Main: 268455936 07:16:29 INFO - PROCESS | 1673 | 07:19:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 07:19:31 INFO - PROCESS | 1673 | RSS: Main: 278892544 07:19:31 INFO - PROCESS | 1673 | 07:22:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 07:22:34 INFO - PROCESS | 1673 | RSS: Main: 280961024 07:22:34 INFO - PROCESS | 1673 | 07:25:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 07:25:36 INFO - PROCESS | 1673 | RSS: Main: 282505216 07:25:36 INFO - PROCESS | 1673 | 07:28:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 07:28:39 INFO - PROCESS | 1673 | RSS: Main: 285360128 07:28:39 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 07:31:42 INFO - PROCESS | 1673 | RSS: Main: 286388224 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | __start_tp_report 07:31:42 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 07:31:42 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 07:31:42 INFO - PROCESS | 1673 | |i|pagename|runs| 07:31:42 INFO - PROCESS | 1673 | |0;dojo.html;3507;3526.0479670488967;3554.2891421715663;3564.6791788739024;3602.6217247189043;5661.716914154296;5753.597248192628;5760.769569217232;5767.625104368213;5826.737796799143;5703.087505999041;5851.824445266649;5922.733476993535;5951.404859514047;6055.212822333102;4370.890727731817;4696.849271928374;4884.438289596706;5339.679619222839;5343.064963631368;613.2053778111633;5267.47325267474;5310.4424035476295;5375.865603359908;5389.461053894618;5245.108331583621;5261.947380526184;5263.34208223972;5295.443978382292;5301.257823904656;5216.426193118754;5297.231901374279;5328.280682107905;5334.5732341412595;5340.839774806762;5216.921746173811;5236.21456781482;5254.737263136828;5278.234655974862;5336.359636843565;5107.948920510822;5377.139657654757;5703.686297253649;5859.736311865976;5884.941150588482;6162.22972128484;6165.876682466371;6182.598131121463;6235.781747638811;6257.8748425031245;6200.782972595983;6295.779647712354;6297.937020629781;6302.369763023707;6312.747490100391;6015.518758499354;6061.121137435091;6064.757409703562;6068.059450785136;6088.086786981899;6191.102290167991;6358.713857876407;6388.137601423841;6404.839879002969;6422.839429014312;6187.443130118311;6227.750889964351;6244.687765611701;6247;6254.6872656366995;6229.750809967551;6290.874182516415;6300.086487459384;6304.65324407162;6317.842053948688;6135.416406698409;6144.986077297285;6206.906896396557;6220.688965551704;6255.40573645503;6141.915626108588;6162.137300777895;6225.564210505312;6232.59488133279;6236.251649802053;4941.258811178352;4993.151164302078;4999.700017998932;5005.449400565934;5011.824586139468;4410.735355878657;4415.962248871512;4419.712718673276;4464.419625448671;4531.365608814768;5111.642185047085;5850.53195744348;5850.678212698343;5859.121131830174;5895.734691938873;6214.906776398358;6250.531210159256;6251.74993000284;6266.937330626635;6293.874122517524;5778.8266352009505;5888.057910734262;5941.643501389931;5953.613015154001;5967.16459695643;4535.798013526418;5267.789288428497;5473.890522189534;5480.068388373907;5488.7530061147345;5270.683758974397;6306.527010474325;6443.323451037667;6496.805095847132;6498.3826536478955;6214;6283.622982621057;6289.6540690260645;6303.873922521616;6331.715072821642;6508.707108180049;6519.576227545194;6522.608643481406;6529.085927970183;6551.836204094745;6121.0818377241985;6152.692365381802;6238.625682459067;6244.0321750128805;6245.125682404558;5181.637285389987;6210.161628180138;6278.152449419453;6283.2774230962195;6291.496680265659;6183.474404675653;6206.410391012847;6207.255129384503;6242.469390101711;6252.218472690914;5296.470352964827;6116.731440059472;6152.923238433345;6197.0904087188965;6240.687965601793;5986.910196347146;5997.700114994145;6016.067509536029;6087.756489740361;6103.155845961239;6183.659898705614;6190.876182476235;6193.225846769154;6208.099825525183;6218.689065546795;6068.332483426908;6077.908831367445;6078.3617720138745;6120.877582448237;6155.815325540241 07:31:42 INFO - PROCESS | 1673 | |1;ext.html;535.3976776126857;568.9829305120847;604.7874012604732;628.5066223014934;649.7790751144612;37481.62518374819;38226.617733822655;38314.61685383145;38342.42486362707;38432;39705.610303639376;39774.005649858766;40066;40216.396754048714;40549.18901621966;9259.907400925971;9353.298502612297;9368.859467107965;9371.109744574254;9388.530573471333;9388.1081297277;9574.47340396278;9619.086186812241;9670.178034867045;9685.982971787966;9526.09502097303;9527.666531671393;9574.234061275081;9591.472469014201;9599.520023998806;9527.904720952805;9546.379485333431;9632.518374081337;9654.324197306192;9663.613455461773;8117.188281171894;9480.95259523698;9617.615295388176;9634.75913102171;9659.565319560566;36825.81587092074;37256.06859828499;37422.812885935666;37447.81276093602;37558.873233802755;2812.803103782736;3188.473901806199;3204.439223135942;3384.830758462067;3631.636836316374;27217.460633844887;27283.181504554697;27563.308835277137;28323.291917702016;28865;2676.9196924092307;2714.3485563464824;2715.7691596214345;2770.1551026936777;2796.189105159501;428146;430845;432632;433265;433412.8329358333;64204.35795641984;64545.67727161334;64581.70836583242;64637.030444542426;64666.35333646697;67391.60867130618;73266;74275.62862185655;74813.25186748063;75050.624746877;17155.57111072208;17179.226934787715;17206.225719842387;17258.654826903392;17338.219780109925;12860.549880754128;13046.086773925925;13157.473701051851;13163.276019819003;13163.407646655924;18309.90845045793;20751.377458676263;21069.683954740693;21244.89377553102;21676.34970950874;7956.602169891482;9288.513837785922;9541.666041688646;9567.665131720356;9568.282378821616;997.4613708597276;998.8563095256037;1055.2613170780485;1060.7825395793843;1073.6564299424265;27946.484816366217;28363.432731345256;28388.864445422365;28454.288642784097;28604;1001.8447140693204;1075.9569617215225;1165.2717051842599;1167;1179.7050737315672;14744.410223590936;14756.335964881606;14842.332095055748;15129.697406051817;15147.924260378848;626991;635979;639837;643885;645659;58876.11685824716;61624.69187654033;61763.38236617666;62131.68934155391;62461;1423.921684307373;1462.3200211901517;1468.155810409019;1486.7175236705207;1487.942789793279;28477.430451391272;28574.85712571424;29035.56446653344;29119.563206552342;29140.27149321284;47069.76465117653;47167;48020;48461;48477.7880552989;441115;441129;442093;443821;444875;30685.53971690382;31057.68942310548;32687.18282042968;34230.77499962495;34272.31455370829;45460.77269613631;45503.772481137385;45723.542764573256;45800.083998320515;47140.52859471498;37574.43638345482;37617;37958;38078.80960595179;38451.615483844806;34735.95676170736;36742;37055.444168338036;37685.81157094197;37755.244895101394;30475.2381190472;35338.76314328986;36485.90542283736;37065.444018340284;37386.8130659345;32059.519107213877;32871.67128328686;32962.17594560059;33106.17234569155;33166.834165829016;24375.878120609992;24665.506689865742;24710.752892470846;25186.49627007413;25250.36874078163 07:31:42 INFO - PROCESS | 1673 | |2;jquery.html;358.4998926497536;363.3514177193709;364.3041790180755;370.6812141558261;372.74466990111773;19381.127849246783;19932.70100948487;21207.469813254676;21339.25312614059;21457.819819909917;20692.275770348042;20732.963351832423;21042.789572104273;21257.893710531465;21479.67780483294;5650.632708873931;5870.002099643049;5894.557908156884;5901.704914754267;5911.290645122592;5681.176229446728;5783.98780213463;5888.293404791431;5891.705414729267;5893.793717219898;5560;5811.418858114197;5841.15303281024;5841.415858414146;5842.006858833987;4772;5732.656040637575;5794.072948328248;5849.356570777232;5854.063349864044;4992.8002879885125;5028.84913452597;5059.62052846038;5072.137736584789;5075.061113693979;25138.24585262445;25364.746352536422;25391.61912571313;25780.74219257802;26021.739782602122;2262.694536237603;2276.760940101282;2469.938251543726;2619.4499155177436;2636.9868150659318;10541;14439.205843678594;14812.185329806856;15258.542243732705;15309.311081001382;1689.7296432570852;1723.0523212233222;1799.0465053521655;1804.8917064976145;1829.4694538583929;77031.84452233165;94185;95185;97411;102590.81864269504;10289.742756431;10438.68683939483;10469.9476502617;10483.899190584878;10587.4706264688;12713.491460341667;12810.167339122927;12911.35443227835;12941.935290323489;12949.935250323688;8550.657973680984;8556.614952327036;8572.271356934605;8601.698940537051;8812.823743525221;7319;8786.956065219632;8938.24024957886;8955.328350373618;9008;6086.2087928569;6205.968970155211;6209.0996805462955;6216.818804427145;6286.18279623646;1818.145471628359;1844.778626564794;1858.5539470527247;1864.8787828791085;1883.359657716383;809.5021561739488;1048.8426735989663;1059.279689810936;1065.7815147894662;1090.4438736244572;20526.589468210554;21212;21296.25463108784;21328.680069798964;21381.358559243246;692.9826754331182;944.8299306124964;964.9614015439304;979.3046936674898;1006.1447769396101;10503.317284376491;10635.627753028606;11226.989570938655;11564.768704626029;11586.594469193538;619805;624896;635226;635480;637758;70337.29662703308;87229.25541489135;99258.50370748245;102218.48890755499;104162;968.8982656821073;1005.818952588541;1067.6370034188412;1081.5457507846722;1083.9349639021684;16412.425565105164;16802.57993550171;18532.444026679223;18647.44057678272;18940.905295473436;46803.765981169876;47296.76351618358;47998.280025798944;48488;48668;66535.66732166309;66731;67356.326436735;68671.96992045223;69147.30852691409;7587.848243035219;7704.075510938723;7795.727149549739;7882.330001949898;8075.676972921252;12483.001359891368;12530.436130374337;12922.83694467465;12939;13074.477020919057;10610.098141658045;10707.678769636923;10928.726781830517;11163.218574699693;11182;8194.180581941759;10693.732656683645;10851.728706782078;10874.510647021061;11017.944910275397;11085.722856928642;11114.944425278145;11218.214724969173;11268.267562608404;11532.481038353126;6628.53600247978;7788.961055194688;7835.216478352119;7884.802879927818;7939.880901786593;10556.736081598021;10910.23628346008;11115.44422778874;11246.04408625276;11308.83036754433 07:31:42 INFO - PROCESS | 1673 | |3;mootools.html;1558.368860611452;1566.1464501846492;1863.8508919286458;1890.8581856360777;1992.7409436773225;8112.553809540473;8171.713990010351;8737.257333126676;9052.04953479885;9069.455832650046;8683.91316086839;8716.215540601344;8740.781480462992;8746.037935827055;8852.716356128358;2422.273318004596;2448.5837407640656;2449.510097980402;2450.0444826517673;2459.213051823417;2424.46661734419;2429.0405289910473;2440.6217036359394;2441.414060625446;2512.0705339024585;2464.18681834994;2470.2465747946867;2478.5414698280783;2491.352248415407;2507.210228777929;2451.36264571211;2453.754624537541;2480.888360023803;2492.7881130103965;2510.460251046034;2072.4922394013565;2423.164008417093;2428.9312702410884;2436.50051739393;2459.754024597544;7624.428167887375;8708.651653933835;8914.242289405409;8926.598303076376;8962.507062111581;5427.728613569306;5444.373897001817;5472.370677372073;5521;5608.018596745554;3698.7041036716996;3721.7394782365245;3752.2683076800035;3755.4742336072973;3800.619938006205;1045.8901815309434;1071.8017166824084;1072.7157303314627;1075.139888089533;1080.9838751573495;10101.696949091465;11971.162018658697;12066.818997715041;12146.5748698796;12209.633710988595;4699.459562150397;4837.879053023703;4935.555799978019;4945.876353091202;4958.776855041532;10109.34289271195;10163.593456261815;10308.96910308963;10332.328398654063;10512.789744205225;5048.318477005557;5478.123500239943;5523.171524271392;5552.805651802168;5565.721713914288;4479.328100784908;4632.444106707149;4798.2082956311815;4888.5111488850835;4996.775145118479;3859.5754467008605;3930.508686414198;3937.42907278443;3953.486046813896;3967.2263908537557;1271.4405661508906;1312.3897387714567;1315.861834507363;1318.1168617026424;1324.6953200763878;1363.6727185475415;1386.5147198480452;1391.4684118982277;1421.0265967812081;1431.4703559682775;8047.195280471906;8115.837683246302;8214.63034163464;8327.417080804285;8331.708390206435;514.9450209075445;527.4962410897583;530.8646295194701;535.4404647143745;539.940606533281;6081.939180608226;6121.387861213932;6223.564350495421;6225.595336303126;6273.874522509615;10379.948100259451;10531.684049478528;10754.623588174376;10825.296355736851;10882.29265097766;10291.33106348085;10354.275200736027;10448.947755261175;10582.259241853151;10658.413787241621;8154.836903261901;8278.213569710868;8386.538740369338;8408.285295749807;8451.366147538836;7692.384609231136;7898.723544676139;7899.802504937423;7917.485363451357;7984.880226796487;9434.48110353937;9623.182029527568;9624.566894489624;9628.085331893459;9683.9031609683;8347.666093356198;9543.236541076558;9775.608975641178;9779.266555008546;9781.315307928377;7516.586587737727;7555.13115991646;8185.71350002747;8224.712135075482;8330.750077497685;8162.0613629431;8167.959160204161;8359.58202089881;8410.158984101541;8424.747257582283;7354.448416368687;7387.556746595222;7432.739854105081;7531.548107113591;7620;7242.420606351585;7274.272572742683;7385.667644955883;7437.665305061393;7489.438292128221;7792.649330780015;7798.6490607923915;7835.412344074103;7854.882176767239;7854.960725196337;5457.945420545744;5956.910646340221;6887.965560172167;7060.6469676517;7076;7122.964385178041;7150.856982860418;7163.391111755351;7229.024081748897;7244.927550724426 07:31:42 INFO - PROCESS | 1673 | |4;prototype.html;298.22164151564414;313.80857676817135;334.6636630186662;335.89587227959316;337.0478398524167;6732.360425759551;6808.863822723542;6809.897851532231;6828.658567071645;6863.7597684081065;6721.428678562328;6749.966250168743;6751.628660423675;6785.864282714343;6813.863722725555;4183.686223533232;4504.144212599612;4942.43162036365;4946.332245146913;4996.425411077727;3982;4937.185364414867;4943.752812359367;4967.552920237178;4983.651144419892;4319.006628475452;4358.716683415583;4891.290762839386;4892.5596696297325;4983.950160498385;4960.578350840183;4979.551840334388;4991.650584459089;5000.049990501811;5005.174146265862;4271.504973259365;4278.871633850989;4282.207791558571;4285.335772955197;4290.592393722592;5815.865906148303;6227.906581401283;6309.716062777186;6488.124103246048;6503.479721622306;5780.364159942403;5783.103618939072;5790.392008839053;5792.594518383715;5816.912746308809;7261.128664560287;7264.600446975414;7288.963555182243;7293.161286452073;7297.598632075234;4660.86017419478;4662.790174442158;4668.533146685339;4690.4605970313505;4713.764311784397;7571.810704732371;7650.158482566913;7654.502457340255;7664.65509052094;7669.5398276103615;4420.425344705168;4482.910341793146;4544.250198717241;4724.267738500538;4725.40932383452;3971.3645816669195;4801.351817504662;4812.903741925142;4817.349657796152;4834.057358815067;5648.209250704905;5766.625169363978;5798.362180160179;5805.390434004453;5838.153467747153;5824.621399609012;6852.458196905756;7289.307515785992;7297.197308296083;7301.160366557808;1645.4981230724504;1672.3310675729806;1672.757450169743;1679.3030892179609;1679.8744840956588;1019.4698756646651;1052.0478966535297;1066.1524088349781;1067.5409573883305;1081.0648788797632;5734.942650573441;6686.665666716644;6689.331066893272;6746.257911629717;6791.2869148739655;7522.811929701801;7589.354904833041;7594.7721568351935;7619.847603047908;7620.3522700571075;6734.730610775612;6741.8651626967185;6762.154730658668;6764.594124352555;6765.898511522331;3866.8839934802;3962.5641179470235;4001.9599804001587;4023.376376661622;4043.0700938784244;7841.255080767432;7842;7843.56860372685;7859.52842829432;7905.130435652074;7722.922770772333;7752.573608451589;7782.571958542221;7792.454528182972;7806.804829879185;7821.335186509096;7829.41279404047;7851.097123830718;7857;7860.685572577033;6151.50787936955;7331.486795924234;7473;7517.924820751941;7530.058742657168;7465.365443937326;7466.440016998638;7468.066491688539;7482.1021477423055;7549.849003020019;7299.759040963155;7602.4298177638;7991.4006449515355;7994.720184793504;8011.078725946591;4706.8117275308605;4710.670253082251;4756.571908528249;4757.215059515142;4778.546038126373;6404.295527492065;7300.63496825146;7380.741674041383;7532.887006694795;7653.464257501922;7285.453590980804;7331.230220826949;7345.816354590964;7351.338379545867;7383.963080184565;6350;7019.052427922165;7324.707011719472;7348.228436014356;7369.742059027908;7112.928870711226;7162.89255661155;7174.2108368078425;7196.604186769778;7197.424206063607;5890.293164820249;7094.219635840157;7437.921501382378;7438.702451901863;7441.8139546511775;7211.531250468703;7228.879523673839;7234.204237533972;7242.529235599669;7254.5647261164495 07:31:42 INFO - PROCESS | 1673 | |5;yui.html;659.8086554899082;699.8215455058959;725.4414101142124;768.101321453899;780.1145699630918;13979;13982.021258511895;14067.929660351683;14864.77702834457;15073.773893391608;14405.78391324131;14491.78262326066;14529.910256730735;14544.272786360667;14566.417343306282;746.2052913646976;912.2747415804452;913.2739472119648;915.4141349536285;925.3846192282158;924.4407133684125;928.7353104365258;930.3580529434669;932.1517419148577;932.995335023324;951.2722767083187;985.4727720669443;985.8225519406504;987.1609132237612;988.8813342398922;945.2768631996528;952.6903756279203;962.3359881681617;977.9608815647366;979.8971108033696;703.5110598134298;721.7365661533555;723.352599423513;727.8798998165296;729.2525161709237;14471;14477.71044579113;14679.266036698122;14761.630959225999;14930.10419374841;12584.748305033849;12603.991680665526;12645.241285522898;12835.294058826761;12835.807462888064;8336.208060234268;9904.801903961952;10015.198784097254;10744.946275268574;10841.349519028883;3472.131967008248;3472.28818092293;3516.226430185355;3538.5028493003733;3543.255916257589;63824.40438989016;70560.6471967642;81278;82212;82219.17780822235;8779.868301975475;8845.380823342304;9109.726708198765;9176.265898728087;9491.715248542554;20393;20540.794592054186;20689.17243310281;20735.792642073688;20885.37343879686;7227.385672217815;7264.164621068645;7269.454790890704;7286.70853165878;7489.550626962399;4050.41269015991;4094.6724262058965;4107.466029416157;4111.362738775495;4119.423280740699;3620.0587847159927;3643.2531331077066;3646.872359467459;3651.908702282411;3697.3159965406485;660.8579155481499;663.5653646861314;675.9797206083825;697.6197972105215;723.6743465440468;530.1517571884954;576.881739243454;590.1560768101656;602.1780269931512;617.5923890232425;7867.6459559319965;7981.880271795928;8111.472754270953;8129.634166462523;8269.875951860728;567.2512283785363;573.5803885383725;579.8347470970838;604.8246008657528;628.9276733175652;3710.9257814843554;3901.9609803902167;3905.984444044569;3911.06134527717;3985.382265748756;94173;94534;94671.0532894676;94863.57704634436;95112.0488795117;80847.5957620208;81287.5935620318;81443;81711.5914420436;81756.59121704353;67211;73127;73504;73626.26373736301;74250.628746857;8393.580320983805;8419.368547359096;8465.576721163794;8498.915010849812;8579.742607721779;49029.50970490249;50235.74882125712;50471;50642;52286;64288.39279018062;72801;76532;76798.6160069196;78859.60570197113;11131.777364452828;11609.975964541669;11684.240524365889;11712.824307635563;12051.33717645538;11904.523819047141;12041.09691773103;12061.336626485627;12193.756124877631;12309.753804923672;11332.660020199408;11592.6522204334;11901.285922844658;11930.463129159036;12134.696632584257;11567.537298507965;11736.295822250693;11795.41022948832;11954.10344224204;12161.209521381083;10576.735581610521;10622.044016038593;11133.83299250528;11346.489407976826;11602.47788849487;7866.9213307866185;9463.668771592962;9506.762330941781;9566.234701224024;9774.706758797247;8354.498730076215;9747.853782193415;9761.414315141114;9765.511724413609;9850.852237216304 07:31:42 INFO - PROCESS | 1673 | __end_tp_report 07:31:42 INFO - PROCESS | 1673 | __start_cc_report 07:31:42 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,369 07:31:42 INFO - PROCESS | 1673 | __end_cc_report 07:31:42 INFO - PROCESS | 1673 | __startTimestamp1459348302372__endTimestamp 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | ------- Summary: start ------- 07:31:42 INFO - PROCESS | 1673 | Number of tests: 6 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5761.82 Median:6087.76 stddev:769.65 (12.6%) stddev-sans-first:751.40 07:31:42 INFO - PROCESS | 1673 | Values: 3507.0 3526.0 3554.3 3564.7 3602.6 5661.7 5753.6 5760.8 5767.6 5826.7 5703.1 5851.8 5922.7 5951.4 6055.2 4370.9 4696.8 4884.4 5339.7 5343.1 613.2 5267.5 5310.4 5375.9 5389.5 5245.1 5261.9 5263.3 5295.4 5301.3 5216.4 5297.2 5328.3 5334.6 5340.8 5216.9 5236.2 5254.7 5278.2 5336.4 5107.9 5377.1 5703.7 5859.7 5884.9 6162.2 6165.9 6182.6 6235.8 6257.9 6200.8 6295.8 6297.9 6302.4 6312.7 6015.5 6061.1 6064.8 6068.1 6088.1 6191.1 6358.7 6388.1 6404.8 6422.8 6187.4 6227.8 6244.7 6247.0 6254.7 6229.8 6290.9 6300.1 6304.7 6317.8 6135.4 6145.0 6206.9 6220.7 6255.4 6141.9 6162.1 6225.6 6232.6 6236.3 4941.3 4993.2 4999.7 5005.4 5011.8 4410.7 4416.0 4419.7 4464.4 4531.4 5111.6 5850.5 5850.7 5859.1 5895.7 6214.9 6250.5 6251.7 6266.9 6293.9 5778.8 5888.1 5941.6 5953.6 5967.2 4535.8 5267.8 5473.9 5480.1 5488.8 5270.7 6306.5 6443.3 6496.8 6498.4 6214.0 6283.6 6289.7 6303.9 6331.7 6508.7 6519.6 6522.6 6529.1 6551.8 6121.1 6152.7 6238.6 6244.0 6245.1 5181.6 6210.2 6278.2 6283.3 6291.5 6183.5 6206.4 6207.3 6242.5 6252.2 5296.5 6116.7 6152.9 6197.1 6240.7 5986.9 5997.7 6016.1 6087.8 6103.2 6183.7 6190.9 6193.2 6208.1 6218.7 6068.3 6077.9 6078.4 6120.9 6155.8 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:64970.09 Median:37856.62 stddev:136902.86 (361.6%) stddev-sans-first:137201.43 07:31:42 INFO - PROCESS | 1673 | Values: 535.4 569.0 604.8 628.5 649.8 37481.6 38226.6 38314.6 38342.4 38432.0 39705.6 39774.0 40066.0 40216.4 40549.2 9259.9 9353.3 9368.9 9371.1 9388.5 9388.1 9574.5 9619.1 9670.2 9686.0 9526.1 9527.7 9574.2 9591.5 9599.5 9527.9 9546.4 9632.5 9654.3 9663.6 8117.2 9481.0 9617.6 9634.8 9659.6 36825.8 37256.1 37422.8 37447.8 37558.9 2812.8 3188.5 3204.4 3384.8 3631.6 27217.5 27283.2 27563.3 28323.3 28865.0 2676.9 2714.3 2715.8 2770.2 2796.2 428146.0 430845.0 432632.0 433265.0 433412.8 64204.4 64545.7 64581.7 64637.0 64666.4 67391.6 73266.0 74275.6 74813.3 75050.6 17155.6 17179.2 17206.2 17258.7 17338.2 12860.5 13046.1 13157.5 13163.3 13163.4 18309.9 20751.4 21069.7 21244.9 21676.3 7956.6 9288.5 9541.7 9567.7 9568.3 997.5 998.9 1055.3 1060.8 1073.7 27946.5 28363.4 28388.9 28454.3 28604.0 1001.8 1076.0 1165.3 1167.0 1179.7 14744.4 14756.3 14842.3 15129.7 15147.9 626991.0 635979.0 639837.0 643885.0 645659.0 58876.1 61624.7 61763.4 62131.7 62461.0 1423.9 1462.3 1468.2 1486.7 1487.9 28477.4 28574.9 29035.6 29119.6 29140.3 47069.8 47167.0 48020.0 48461.0 48477.8 441115.0 441129.0 442093.0 443821.0 444875.0 30685.5 31057.7 32687.2 34230.8 34272.3 45460.8 45503.8 45723.5 45800.1 47140.5 37574.4 37617.0 37958.0 38078.8 38451.6 34736.0 36742.0 37055.4 37685.8 37755.2 30475.2 35338.8 36485.9 37065.4 37386.8 32059.5 32871.7 32962.2 33106.2 33166.8 24375.9 24665.5 24710.8 25186.5 25250.4 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:33875.45 Median:25378.18 stddev:103680.21 (408.5%) stddev-sans-first:103940.52 07:31:42 INFO - PROCESS | 1673 | Values: 358.5 363.4 364.3 370.7 372.7 19381.1 19932.7 21207.5 21339.3 21457.8 20692.3 20733.0 21042.8 21257.9 21479.7 5650.6 5870.0 5894.6 5901.7 5911.3 5681.2 5784.0 5888.3 5891.7 5893.8 5560.0 5811.4 5841.2 5841.4 5842.0 4772.0 5732.7 5794.1 5849.4 5854.1 4992.8 5028.8 5059.6 5072.1 5075.1 25138.2 25364.7 25391.6 25780.7 26021.7 2262.7 2276.8 2469.9 2619.4 2637.0 10541.0 14439.2 14812.2 15258.5 15309.3 1689.7 1723.1 1799.0 1804.9 1829.5 77031.8 94185.0 95185.0 97411.0 102590.8 10289.7 10438.7 10469.9 10483.9 10587.5 12713.5 12810.2 12911.4 12941.9 12949.9 8550.7 8556.6 8572.3 8601.7 8812.8 7319.0 8787.0 8938.2 8955.3 9008.0 6086.2 6206.0 6209.1 6216.8 6286.2 1818.1 1844.8 1858.6 1864.9 1883.4 809.5 1048.8 1059.3 1065.8 1090.4 20526.6 21212.0 21296.3 21328.7 21381.4 693.0 944.8 965.0 979.3 1006.1 10503.3 10635.6 11227.0 11564.8 11586.6 619805.0 624896.0 635226.0 635480.0 637758.0 70337.3 87229.3 99258.5 102218.5 104162.0 968.9 1005.8 1067.6 1081.5 1083.9 16412.4 16802.6 18532.4 18647.4 18940.9 46803.8 47296.8 47998.3 48488.0 48668.0 66535.7 66731.0 67356.3 68672.0 69147.3 7587.8 7704.1 7795.7 7882.3 8075.7 12483.0 12530.4 12922.8 12939.0 13074.5 10610.1 10707.7 10928.7 11163.2 11182.0 8194.2 10693.7 10851.7 10874.5 11017.9 11085.7 11114.9 11218.2 11268.3 11532.5 6628.5 7789.0 7835.2 7884.8 7939.9 10556.7 10910.2 11115.4 11246.0 11308.8 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6053.24 Median:2983.83 stddev:3189.92 (106.9%) stddev-sans-first:3180.98 07:31:42 INFO - PROCESS | 1673 | Values: 1558.4 1566.1 1863.9 1890.9 1992.7 8112.6 8171.7 8737.3 9052.0 9069.5 8683.9 8716.2 8740.8 8746.0 8852.7 2422.3 2448.6 2449.5 2450.0 2459.2 2424.5 2429.0 2440.6 2441.4 2512.1 2464.2 2470.2 2478.5 2491.4 2507.2 2451.4 2453.8 2480.9 2492.8 2510.5 2072.5 2423.2 2428.9 2436.5 2459.8 7624.4 8708.7 8914.2 8926.6 8962.5 5427.7 5444.4 5472.4 5521.0 5608.0 3698.7 3721.7 3752.3 3755.5 3800.6 1045.9 1071.8 1072.7 1075.1 1081.0 10101.7 11971.2 12066.8 12146.6 12209.6 4699.5 4837.9 4935.6 4945.9 4958.8 10109.3 10163.6 10309.0 10332.3 10512.8 5048.3 5478.1 5523.2 5552.8 5565.7 4479.3 4632.4 4798.2 4888.5 4996.8 3859.6 3930.5 3937.4 3953.5 3967.2 1271.4 1312.4 1315.9 1318.1 1324.7 1363.7 1386.5 1391.5 1421.0 1431.5 8047.2 8115.8 8214.6 8327.4 8331.7 514.9 527.5 530.9 535.4 539.9 6081.9 6121.4 6223.6 6225.6 6273.9 10379.9 10531.7 10754.6 10825.3 10882.3 10291.3 10354.3 10448.9 10582.3 10658.4 8154.8 8278.2 8386.5 8408.3 8451.4 7692.4 7898.7 7899.8 7917.5 7984.9 9434.5 9623.2 9624.6 9628.1 9683.9 8347.7 9543.2 9775.6 9779.3 9781.3 7516.6 7555.1 8185.7 8224.7 8330.8 8162.1 8168.0 8359.6 8410.2 8424.7 7354.4 7387.6 7432.7 7531.5 7620.0 7242.4 7274.3 7385.7 7437.7 7489.4 7792.6 7798.6 7835.4 7854.9 7855.0 5457.9 5956.9 6888.0 7060.6 7076.0 7123.0 7150.9 7163.4 7229.0 7244.9 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5897.52 Median:6738.30 stddev:1924.39 (28.6%) stddev-sans-first:1883.34 07:31:42 INFO - PROCESS | 1673 | Values: 298.2 313.8 334.7 335.9 337.0 6732.4 6808.9 6809.9 6828.7 6863.8 6721.4 6750.0 6751.6 6785.9 6813.9 4183.7 4504.1 4942.4 4946.3 4996.4 3982.0 4937.2 4943.8 4967.6 4983.7 4319.0 4358.7 4891.3 4892.6 4984.0 4960.6 4979.6 4991.7 5000.0 5005.2 4271.5 4278.9 4282.2 4285.3 4290.6 5815.9 6227.9 6309.7 6488.1 6503.5 5780.4 5783.1 5790.4 5792.6 5816.9 7261.1 7264.6 7289.0 7293.2 7297.6 4660.9 4662.8 4668.5 4690.5 4713.8 7571.8 7650.2 7654.5 7664.7 7669.5 4420.4 4482.9 4544.3 4724.3 4725.4 3971.4 4801.4 4812.9 4817.3 4834.1 5648.2 5766.6 5798.4 5805.4 5838.2 5824.6 6852.5 7289.3 7297.2 7301.2 1645.5 1672.3 1672.8 1679.3 1679.9 1019.5 1052.0 1066.2 1067.5 1081.1 5734.9 6686.7 6689.3 6746.3 6791.3 7522.8 7589.4 7594.8 7619.8 7620.4 6734.7 6741.9 6762.2 6764.6 6765.9 3866.9 3962.6 4002.0 4023.4 4043.1 7841.3 7842.0 7843.6 7859.5 7905.1 7722.9 7752.6 7782.6 7792.5 7806.8 7821.3 7829.4 7851.1 7857.0 7860.7 6151.5 7331.5 7473.0 7517.9 7530.1 7465.4 7466.4 7468.1 7482.1 7549.8 7299.8 7602.4 7991.4 7994.7 8011.1 4706.8 4710.7 4756.6 4757.2 4778.5 6404.3 7300.6 7380.7 7532.9 7653.5 7285.5 7331.2 7345.8 7351.3 7384.0 6350.0 7019.1 7324.7 7348.2 7369.7 7112.9 7162.9 7174.2 7196.6 7197.4 5890.3 7094.2 7437.9 7438.7 7441.8 7211.5 7228.9 7234.2 7242.5 7254.6 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18555.50 Median:660.33 stddev:26332.55 (3987.8%) stddev-sans-first:26372.13 07:31:42 INFO - PROCESS | 1673 | Values: 659.8 699.8 725.4 768.1 780.1 13979.0 13982.0 14067.9 14864.8 15073.8 14405.8 14491.8 14529.9 14544.3 14566.4 746.2 912.3 913.3 915.4 925.4 924.4 928.7 930.4 932.2 933.0 951.3 985.5 985.8 987.2 988.9 945.3 952.7 962.3 978.0 979.9 703.5 721.7 723.4 727.9 729.3 14471.0 14477.7 14679.3 14761.6 14930.1 12584.7 12604.0 12645.2 12835.3 12835.8 8336.2 9904.8 10015.2 10744.9 10841.3 3472.1 3472.3 3516.2 3538.5 3543.3 63824.4 70560.6 81278.0 82212.0 82219.2 8779.9 8845.4 9109.7 9176.3 9491.7 20393.0 20540.8 20689.2 20735.8 20885.4 7227.4 7264.2 7269.5 7286.7 7489.6 4050.4 4094.7 4107.5 4111.4 4119.4 3620.1 3643.3 3646.9 3651.9 3697.3 660.9 663.6 676.0 697.6 723.7 530.2 576.9 590.2 602.2 617.6 7867.6 7981.9 8111.5 8129.6 8269.9 567.3 573.6 579.8 604.8 628.9 3710.9 3902.0 3906.0 3911.1 3985.4 94173.0 94534.0 94671.1 94863.6 95112.0 80847.6 81287.6 81443.0 81711.6 81756.6 67211.0 73127.0 73504.0 73626.3 74250.6 8393.6 8419.4 8465.6 8498.9 8579.7 49029.5 50235.7 50471.0 50642.0 52286.0 64288.4 72801.0 76532.0 76798.6 78859.6 11131.8 11610.0 11684.2 11712.8 12051.3 11904.5 12041.1 12061.3 12193.8 12309.8 11332.7 11592.7 11901.3 11930.5 12134.7 11567.5 11736.3 11795.4 11954.1 12161.2 10576.7 10622.0 11133.8 11346.5 11602.5 7866.9 9463.7 9506.8 9566.2 9774.7 8354.5 9747.9 9761.4 9765.5 9850.9 07:31:42 INFO - PROCESS | 1673 | -------- Summary: end -------- 07:31:42 INFO - PROCESS | 1673 | 07:31:42 INFO - TEST-INFO | 1673: exit 0 07:31:42 INFO - TEST-OK | dromaeo_css | took 1111208ms 07:31:42 INFO - TEST-START | kraken 07:31:42 INFO - operating with platform_type : mac_ 07:31:42 INFO - Initialising browser for kraken test... 07:31:42 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpKZ5Woo/profile http://localhost:49272/getInfo.html) 07:31:45 INFO - PROCESS | 1683 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 07:31:45 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 07:31:45 INFO - PROCESS | 1683 | colorDepth:24 07:31:45 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 07:31:45 INFO - PROCESS | 1683 | __metrics 07:31:45 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 07:31:46 INFO - TEST-INFO | 1683: exit 0 07:31:46 INFO - Browser initialized. 07:31:46 INFO - Running cycle 1/1 for kraken test... 07:31:46 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmpKZ5Woo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:58 INFO - PROCESS | 1686 | RSS: Main: 254537728 07:31:58 INFO - PROCESS | 1686 | 07:32:01 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:01 INFO - PROCESS | 1686 | RSS: Main: 266604544 07:32:01 INFO - PROCESS | 1686 | 07:32:04 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 07:32:05 INFO - PROCESS | 1686 | RSS: Main: 275501056 07:32:05 INFO - PROCESS | 1686 | 07:32:08 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 07:32:08 INFO - PROCESS | 1686 | RSS: Main: 279351296 07:32:08 INFO - PROCESS | 1686 | 07:32:10 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 07:32:11 INFO - PROCESS | 1686 | RSS: Main: 279867392 07:32:11 INFO - PROCESS | 1686 | 07:32:13 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:32:14 INFO - PROCESS | 1686 | RSS: Main: 280199168 07:32:14 INFO - PROCESS | 1686 | 07:32:16 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 07:32:17 INFO - PROCESS | 1686 | RSS: Main: 281665536 07:32:17 INFO - PROCESS | 1686 | 07:32:20 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 07:32:20 INFO - PROCESS | 1686 | RSS: Main: 281612288 07:32:20 INFO - PROCESS | 1686 | 07:32:24 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 07:32:24 INFO - PROCESS | 1686 | RSS: Main: 281444352 07:32:24 INFO - PROCESS | 1686 | 07:32:26 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:32:26 INFO - PROCESS | 1686 | RSS: Main: 281464832 07:32:26 INFO - PROCESS | 1686 | 07:32:28 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:32:29 INFO - PROCESS | 1686 | RSS: Main: 281550848 07:32:29 INFO - PROCESS | 1686 | 07:32:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:32:32 INFO - PROCESS | 1686 | RSS: Main: 282411008 07:32:32 INFO - PROCESS | 1686 | 07:32:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:32:35 INFO - PROCESS | 1686 | RSS: Main: 282058752 07:32:35 INFO - PROCESS | 1686 | 07:32:38 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:32:38 INFO - PROCESS | 1686 | RSS: Main: 282484736 07:32:38 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 07:32:40 INFO - PROCESS | 1686 | RSS: Main: 284364800 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | __start_tp_report 07:32:40 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 07:32:40 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 07:32:40 INFO - PROCESS | 1686 | |i|pagename|runs| 07:32:40 INFO - PROCESS | 1686 | |0;ai-astar;113;108;114;115;113;128;114;115;115;115 07:32:40 INFO - PROCESS | 1686 | |1;audio-beat-detection;147;136;130;180;147;171;142;146;192;117 07:32:40 INFO - PROCESS | 1686 | |2;audio-dft;191;199;198;207;222;265;246;197;202;195 07:32:40 INFO - PROCESS | 1686 | |3;audio-fft;56;57;72;76;97;142;55;57;67;87 07:32:40 INFO - PROCESS | 1686 | |4;audio-oscillator;83;85;119;80;78;82;114;81;78;117 07:32:40 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;89;87;90;88;90;88;112;112;91;101 07:32:40 INFO - PROCESS | 1686 | |6;imaging-darkroom;120;96;94;96;94;93;95;96;100;94 07:32:40 INFO - PROCESS | 1686 | |7;imaging-desaturate;125;96;140;147;99;145;124;90;92;91 07:32:40 INFO - PROCESS | 1686 | |8;json-parse-financial;57;58;56;59;60;83;62;66;52;60 07:32:40 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;58;95;64;77;107;108;105;71;64;85 07:32:40 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;86;86;83;84;85;85;85;88;74;99 07:32:40 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;162;135;153;134;143;143;136;148;148;117 07:32:40 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;131;140;144;181;190;140;144;138;145;130 07:32:40 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;65;66;69;68;83;88;101;69;67;68 07:32:40 INFO - PROCESS | 1686 | __end_tp_report 07:32:40 INFO - PROCESS | 1686 | __start_cc_report 07:32:40 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,958 07:32:40 INFO - PROCESS | 1686 | __end_cc_report 07:32:40 INFO - PROCESS | 1686 | __startTimestamp1459348360859__endTimestamp 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | ------- Summary: start ------- 07:32:40 INFO - PROCESS | 1686 | Number of tests: 14 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:5.03 (4.4%) stddev-sans-first:5.29 07:32:40 INFO - PROCESS | 1686 | Values: 113.0 108.0 114.0 115.0 113.0 128.0 114.0 115.0 115.0 115.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:147.00 stddev:23.29 (15.8%) stddev-sans-first:24.66 07:32:40 INFO - PROCESS | 1686 | Values: 147.0 136.0 130.0 180.0 147.0 171.0 142.0 146.0 192.0 117.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:212.20 Median:204.50 stddev:24.74 (12.1%) stddev-sans-first:25.03 07:32:40 INFO - PROCESS | 1686 | Values: 191.0 199.0 198.0 207.0 222.0 265.0 246.0 197.0 202.0 195.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:76.60 Median:69.50 stddev:27.03 (38.9%) stddev-sans-first:27.62 07:32:40 INFO - PROCESS | 1686 | Values: 56.0 57.0 72.0 76.0 97.0 142.0 55.0 57.0 67.0 87.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:80.50 stddev:17.40 (21.6%) stddev-sans-first:18.17 07:32:40 INFO - PROCESS | 1686 | Values: 83.0 85.0 119.0 80.0 78.0 82.0 114.0 81.0 78.0 117.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:88.50 stddev:9.87 (11.2%) stddev-sans-first:10.25 07:32:40 INFO - PROCESS | 1686 | Values: 89.0 87.0 90.0 88.0 90.0 88.0 112.0 112.0 91.0 101.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:94.50 stddev:8.04 (8.5%) stddev-sans-first:2.06 07:32:40 INFO - PROCESS | 1686 | Values: 120.0 96.0 94.0 96.0 94.0 93.0 95.0 96.0 100.0 94.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:114.90 Median:90.50 stddev:23.75 (26.2%) stddev-sans-first:24.91 07:32:40 INFO - PROCESS | 1686 | Values: 125.0 96.0 140.0 147.0 99.0 145.0 124.0 90.0 92.0 91.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.00 stddev:8.47 (14.1%) stddev-sans-first:8.84 07:32:40 INFO - PROCESS | 1686 | Values: 57.0 58.0 56.0 59.0 60.0 83.0 62.0 66.0 52.0 60.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:67.50 stddev:19.32 (28.6%) stddev-sans-first:18.17 07:32:40 INFO - PROCESS | 1686 | Values: 58.0 95.0 64.0 77.0 107.0 108.0 105.0 71.0 64.0 85.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:6.06 (7.1%) stddev-sans-first:6.42 07:32:40 INFO - PROCESS | 1686 | Values: 86.0 86.0 83.0 84.0 85.0 85.0 85.0 88.0 74.0 99.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:145.50 stddev:12.33 (8.5%) stddev-sans-first:10.72 07:32:40 INFO - PROCESS | 1686 | Values: 162.0 135.0 153.0 134.0 143.0 143.0 136.0 148.0 148.0 117.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:144.00 stddev:20.37 (14.1%) stddev-sans-first:20.62 07:32:40 INFO - PROCESS | 1686 | Values: 131.0 140.0 144.0 181.0 190.0 140.0 144.0 138.0 145.0 130.0 07:32:40 INFO - PROCESS | 1686 | 07:32:40 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:68.50 stddev:12.11 (17.7%) stddev-sans-first:12.36 07:32:40 INFO - PROCESS | 1686 | Values: 65.0 66.0 69.0 68.0 83.0 88.0 101.0 69.0 67.0 68.0 07:32:40 INFO - PROCESS | 1686 | -------- Summary: end -------- 07:32:40 INFO - PROCESS | 1686 | 07:32:41 INFO - TEST-INFO | 1686: exit 0 07:32:41 INFO - TEST-OK | kraken | took 58772ms 07:32:41 INFO - SUITE-END | took 1169s 07:32:42 INFO - Completed test suite (00:19:30) 07:32:42 INFO - javascript benchmark 07:32:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3507.0, 3526.0479670488967, 3554.2891421715663, 3564.6791788739024, 3602.6217247189043, 5661.716914154296, 5753.597248192628, 5760.769569217232, 5767.625104368213, 5826.737796799143, 5703.087505999041, 5851.824445266649, 5922.733476993535, 5951.404859514047, 6055.212822333102, 4370.890727731817, 4696.849271928374, 4884.438289596706, 5339.679619222839, 5343.064963631368, 613.2053778111633, 5267.47325267474, 5310.4424035476295, 5375.865603359908, 5389.461053894618, 5245.108331583621, 5261.947380526184, 5263.34208223972, 5295.443978382292, 5301.257823904656, 5216.426193118754, 5297.231901374279, 5328.280682107905, 5334.5732341412595, 5340.839774806762, 5216.921746173811, 5236.21456781482, 5254.737263136828, 5278.234655974862, 5336.359636843565, 5107.948920510822, 5377.139657654757, 5703.686297253649, 5859.736311865976, 5884.941150588482, 6162.22972128484, 6165.876682466371, 6182.598131121463, 6235.781747638811, 6257.8748425031245, 6200.782972595983, 6295.779647712354, 6297.937020629781, 6302.369763023707, 6312.747490100391, 6015.518758499354, 6061.121137435091, 6064.757409703562, 6068.059450785136, 6088.086786981899, 6191.102290167991, 6358.713857876407, 6388.137601423841, 6404.839879002969, 6422.839429014312, 6187.443130118311, 6227.750889964351, 6244.687765611701, 6247.0, 6254.6872656366995, 6229.750809967551, 6290.874182516415, 6300.086487459384, 6304.65324407162, 6317.842053948688, 6135.416406698409, 6144.986077297285, 6206.906896396557, 6220.688965551704, 6255.40573645503, 6141.915626108588, 6162.137300777895, 6225.564210505312, 6232.59488133279, 6236.251649802053, 4941.258811178352, 4993.151164302078, 4999.700017998932, 5005.449400565934, 5011.824586139468, 4410.735355878657, 4415.962248871512, 4419.712718673276, 4464.419625448671, 4531.365608814768, 5111.642185047085, 5850.53195744348, 5850.678212698343, 5859.121131830174, 5895.734691938873, 6214.906776398358, 6250.531210159256, 6251.74993000284, 6266.937330626635, 6293.874122517524, 5778.8266352009505, 5888.057910734262, 5941.643501389931, 5953.613015154001, 5967.16459695643, 4535.798013526418, 5267.789288428497, 5473.890522189534, 5480.068388373907, 5488.7530061147345, 5270.683758974397, 6306.527010474325, 6443.323451037667, 6496.805095847132, 6498.3826536478955, 6214.0, 6283.622982621057, 6289.6540690260645, 6303.873922521616, 6331.715072821642, 6508.707108180049, 6519.576227545194, 6522.608643481406, 6529.085927970183, 6551.836204094745, 6121.0818377241985, 6152.692365381802, 6238.625682459067, 6244.0321750128805, 6245.125682404558, 5181.637285389987, 6210.161628180138, 6278.152449419453, 6283.2774230962195, 6291.496680265659, 6183.474404675653, 6206.410391012847, 6207.255129384503, 6242.469390101711, 6252.218472690914, 5296.470352964827, 6116.731440059472, 6152.923238433345, 6197.0904087188965, 6240.687965601793, 5986.910196347146, 5997.700114994145, 6016.067509536029, 6087.756489740361, 6103.155845961239, 6183.659898705614, 6190.876182476235, 6193.225846769154, 6208.099825525183, 6218.689065546795, 6068.332483426908, 6077.908831367445, 6078.3617720138745, 6120.877582448237, 6155.815325540241], "unit": "score", "name": "dojo.html", "value": 5716.6719546833065}, {"lowerIsBetter": false, "replicates": [535.3976776126857, 568.9829305120847, 604.7874012604732, 628.5066223014934, 649.7790751144612, 37481.62518374819, 38226.617733822655, 38314.61685383145, 38342.42486362707, 38432.0, 39705.610303639376, 39774.005649858766, 40066.0, 40216.396754048714, 40549.18901621966, 9259.907400925971, 9353.298502612297, 9368.859467107965, 9371.109744574254, 9388.530573471333, 9388.1081297277, 9574.47340396278, 9619.086186812241, 9670.178034867045, 9685.982971787966, 9526.09502097303, 9527.666531671393, 9574.234061275081, 9591.472469014201, 9599.520023998806, 9527.904720952805, 9546.379485333431, 9632.518374081337, 9654.324197306192, 9663.613455461773, 8117.188281171894, 9480.95259523698, 9617.615295388176, 9634.75913102171, 9659.565319560566, 36825.81587092074, 37256.06859828499, 37422.812885935666, 37447.81276093602, 37558.873233802755, 2812.803103782736, 3188.473901806199, 3204.439223135942, 3384.830758462067, 3631.636836316374, 27217.460633844887, 27283.181504554697, 27563.308835277137, 28323.291917702016, 28865.0, 2676.9196924092307, 2714.3485563464824, 2715.7691596214345, 2770.1551026936777, 2796.189105159501, 428146.0, 430845.0, 432632.0, 433265.0, 433412.8329358333, 64204.35795641984, 64545.67727161334, 64581.70836583242, 64637.030444542426, 64666.35333646697, 67391.60867130618, 73266.0, 74275.62862185655, 74813.25186748063, 75050.624746877, 17155.57111072208, 17179.226934787715, 17206.225719842387, 17258.654826903392, 17338.219780109925, 12860.549880754128, 13046.086773925925, 13157.473701051851, 13163.276019819003, 13163.407646655924, 18309.90845045793, 20751.377458676263, 21069.683954740693, 21244.89377553102, 21676.34970950874, 7956.602169891482, 9288.513837785922, 9541.666041688646, 9567.665131720356, 9568.282378821616, 997.4613708597276, 998.8563095256037, 1055.2613170780485, 1060.7825395793843, 1073.6564299424265, 27946.484816366217, 28363.432731345256, 28388.864445422365, 28454.288642784097, 28604.0, 1001.8447140693204, 1075.9569617215225, 1165.2717051842599, 1167.0, 1179.7050737315672, 14744.410223590936, 14756.335964881606, 14842.332095055748, 15129.697406051817, 15147.924260378848, 626991.0, 635979.0, 639837.0, 643885.0, 645659.0, 58876.11685824716, 61624.69187654033, 61763.38236617666, 62131.68934155391, 62461.0, 1423.921684307373, 1462.3200211901517, 1468.155810409019, 1486.7175236705207, 1487.942789793279, 28477.430451391272, 28574.85712571424, 29035.56446653344, 29119.563206552342, 29140.27149321284, 47069.76465117653, 47167.0, 48020.0, 48461.0, 48477.7880552989, 441115.0, 441129.0, 442093.0, 443821.0, 444875.0, 30685.53971690382, 31057.68942310548, 32687.18282042968, 34230.77499962495, 34272.31455370829, 45460.77269613631, 45503.772481137385, 45723.542764573256, 45800.083998320515, 47140.52859471498, 37574.43638345482, 37617.0, 37958.0, 38078.80960595179, 38451.615483844806, 34735.95676170736, 36742.0, 37055.444168338036, 37685.81157094197, 37755.244895101394, 30475.2381190472, 35338.76314328986, 36485.90542283736, 37065.444018340284, 37386.8130659345, 32059.519107213877, 32871.67128328686, 32962.17594560059, 33106.17234569155, 33166.834165829016, 24375.878120609992, 24665.506689865742, 24710.752892470846, 25186.49627007413, 25250.36874078163], "unit": "score", "name": "ext.html", "value": 19908.21671187676}, {"lowerIsBetter": false, "replicates": [358.4998926497536, 363.3514177193709, 364.3041790180755, 370.6812141558261, 372.74466990111773, 19381.127849246783, 19932.70100948487, 21207.469813254676, 21339.25312614059, 21457.819819909917, 20692.275770348042, 20732.963351832423, 21042.789572104273, 21257.893710531465, 21479.67780483294, 5650.632708873931, 5870.002099643049, 5894.557908156884, 5901.704914754267, 5911.290645122592, 5681.176229446728, 5783.98780213463, 5888.293404791431, 5891.705414729267, 5893.793717219898, 5560.0, 5811.418858114197, 5841.15303281024, 5841.415858414146, 5842.006858833987, 4772.0, 5732.656040637575, 5794.072948328248, 5849.356570777232, 5854.063349864044, 4992.8002879885125, 5028.84913452597, 5059.62052846038, 5072.137736584789, 5075.061113693979, 25138.24585262445, 25364.746352536422, 25391.61912571313, 25780.74219257802, 26021.739782602122, 2262.694536237603, 2276.760940101282, 2469.938251543726, 2619.4499155177436, 2636.9868150659318, 10541.0, 14439.205843678594, 14812.185329806856, 15258.542243732705, 15309.311081001382, 1689.7296432570852, 1723.0523212233222, 1799.0465053521655, 1804.8917064976145, 1829.4694538583929, 77031.84452233165, 94185.0, 95185.0, 97411.0, 102590.81864269504, 10289.742756431, 10438.68683939483, 10469.9476502617, 10483.899190584878, 10587.4706264688, 12713.491460341667, 12810.167339122927, 12911.35443227835, 12941.935290323489, 12949.935250323688, 8550.657973680984, 8556.614952327036, 8572.271356934605, 8601.698940537051, 8812.823743525221, 7319.0, 8786.956065219632, 8938.24024957886, 8955.328350373618, 9008.0, 6086.2087928569, 6205.968970155211, 6209.0996805462955, 6216.818804427145, 6286.18279623646, 1818.145471628359, 1844.778626564794, 1858.5539470527247, 1864.8787828791085, 1883.359657716383, 809.5021561739488, 1048.8426735989663, 1059.279689810936, 1065.7815147894662, 1090.4438736244572, 20526.589468210554, 21212.0, 21296.25463108784, 21328.680069798964, 21381.358559243246, 692.9826754331182, 944.8299306124964, 964.9614015439304, 979.3046936674898, 1006.1447769396101, 10503.317284376491, 10635.627753028606, 11226.989570938655, 11564.768704626029, 11586.594469193538, 619805.0, 624896.0, 635226.0, 635480.0, 637758.0, 70337.29662703308, 87229.25541489135, 99258.50370748245, 102218.48890755499, 104162.0, 968.8982656821073, 1005.818952588541, 1067.6370034188412, 1081.5457507846722, 1083.9349639021684, 16412.425565105164, 16802.57993550171, 18532.444026679223, 18647.44057678272, 18940.905295473436, 46803.765981169876, 47296.76351618358, 47998.280025798944, 48488.0, 48668.0, 66535.66732166309, 66731.0, 67356.326436735, 68671.96992045223, 69147.30852691409, 7587.848243035219, 7704.075510938723, 7795.727149549739, 7882.330001949898, 8075.676972921252, 12483.001359891368, 12530.436130374337, 12922.83694467465, 12939.0, 13074.477020919057, 10610.098141658045, 10707.678769636923, 10928.726781830517, 11163.218574699693, 11182.0, 8194.180581941759, 10693.732656683645, 10851.728706782078, 10874.510647021061, 11017.944910275397, 11085.722856928642, 11114.944425278145, 11218.214724969173, 11268.267562608404, 11532.481038353126, 6628.53600247978, 7788.961055194688, 7835.216478352119, 7884.802879927818, 7939.880901786593, 10556.736081598021, 10910.23628346008, 11115.44422778874, 11246.04408625276, 11308.83036754433], "unit": "score", "name": "jquery.html", "value": 9431.542596908674}, {"lowerIsBetter": false, "replicates": [1558.368860611452, 1566.1464501846492, 1863.8508919286458, 1890.8581856360777, 1992.7409436773225, 8112.553809540473, 8171.713990010351, 8737.257333126676, 9052.04953479885, 9069.455832650046, 8683.91316086839, 8716.215540601344, 8740.781480462992, 8746.037935827055, 8852.716356128358, 2422.273318004596, 2448.5837407640656, 2449.510097980402, 2450.0444826517673, 2459.213051823417, 2424.46661734419, 2429.0405289910473, 2440.6217036359394, 2441.414060625446, 2512.0705339024585, 2464.18681834994, 2470.2465747946867, 2478.5414698280783, 2491.352248415407, 2507.210228777929, 2451.36264571211, 2453.754624537541, 2480.888360023803, 2492.7881130103965, 2510.460251046034, 2072.4922394013565, 2423.164008417093, 2428.9312702410884, 2436.50051739393, 2459.754024597544, 7624.428167887375, 8708.651653933835, 8914.242289405409, 8926.598303076376, 8962.507062111581, 5427.728613569306, 5444.373897001817, 5472.370677372073, 5521.0, 5608.018596745554, 3698.7041036716996, 3721.7394782365245, 3752.2683076800035, 3755.4742336072973, 3800.619938006205, 1045.8901815309434, 1071.8017166824084, 1072.7157303314627, 1075.139888089533, 1080.9838751573495, 10101.696949091465, 11971.162018658697, 12066.818997715041, 12146.5748698796, 12209.633710988595, 4699.459562150397, 4837.879053023703, 4935.555799978019, 4945.876353091202, 4958.776855041532, 10109.34289271195, 10163.593456261815, 10308.96910308963, 10332.328398654063, 10512.789744205225, 5048.318477005557, 5478.123500239943, 5523.171524271392, 5552.805651802168, 5565.721713914288, 4479.328100784908, 4632.444106707149, 4798.2082956311815, 4888.5111488850835, 4996.775145118479, 3859.5754467008605, 3930.508686414198, 3937.42907278443, 3953.486046813896, 3967.2263908537557, 1271.4405661508906, 1312.3897387714567, 1315.861834507363, 1318.1168617026424, 1324.6953200763878, 1363.6727185475415, 1386.5147198480452, 1391.4684118982277, 1421.0265967812081, 1431.4703559682775, 8047.195280471906, 8115.837683246302, 8214.63034163464, 8327.417080804285, 8331.708390206435, 514.9450209075445, 527.4962410897583, 530.8646295194701, 535.4404647143745, 539.940606533281, 6081.939180608226, 6121.387861213932, 6223.564350495421, 6225.595336303126, 6273.874522509615, 10379.948100259451, 10531.684049478528, 10754.623588174376, 10825.296355736851, 10882.29265097766, 10291.33106348085, 10354.275200736027, 10448.947755261175, 10582.259241853151, 10658.413787241621, 8154.836903261901, 8278.213569710868, 8386.538740369338, 8408.285295749807, 8451.366147538836, 7692.384609231136, 7898.723544676139, 7899.802504937423, 7917.485363451357, 7984.880226796487, 9434.48110353937, 9623.182029527568, 9624.566894489624, 9628.085331893459, 9683.9031609683, 8347.666093356198, 9543.236541076558, 9775.608975641178, 9779.266555008546, 9781.315307928377, 7516.586587737727, 7555.13115991646, 8185.71350002747, 8224.712135075482, 8330.750077497685, 8162.0613629431, 8167.959160204161, 8359.58202089881, 8410.158984101541, 8424.747257582283, 7354.448416368687, 7387.556746595222, 7432.739854105081, 7531.548107113591, 7620.0, 7242.420606351585, 7274.272572742683, 7385.667644955883, 7437.665305061393, 7489.438292128221, 7792.649330780015, 7798.6490607923915, 7835.412344074103, 7854.882176767239, 7854.960725196337, 5457.945420545744, 5956.910646340221, 6887.965560172167, 7060.6469676517, 7076.0, 7122.964385178041, 7150.856982860418, 7163.391111755351, 7229.024081748897, 7244.927550724426], "unit": "score", "name": "mootools.html", "value": 4872.812551720644}, {"lowerIsBetter": false, "replicates": [298.22164151564414, 313.80857676817135, 334.6636630186662, 335.89587227959316, 337.0478398524167, 6732.360425759551, 6808.863822723542, 6809.897851532231, 6828.658567071645, 6863.7597684081065, 6721.428678562328, 6749.966250168743, 6751.628660423675, 6785.864282714343, 6813.863722725555, 4183.686223533232, 4504.144212599612, 4942.43162036365, 4946.332245146913, 4996.425411077727, 3982.0, 4937.185364414867, 4943.752812359367, 4967.552920237178, 4983.651144419892, 4319.006628475452, 4358.716683415583, 4891.290762839386, 4892.5596696297325, 4983.950160498385, 4960.578350840183, 4979.551840334388, 4991.650584459089, 5000.049990501811, 5005.174146265862, 4271.504973259365, 4278.871633850989, 4282.207791558571, 4285.335772955197, 4290.592393722592, 5815.865906148303, 6227.906581401283, 6309.716062777186, 6488.124103246048, 6503.479721622306, 5780.364159942403, 5783.103618939072, 5790.392008839053, 5792.594518383715, 5816.912746308809, 7261.128664560287, 7264.600446975414, 7288.963555182243, 7293.161286452073, 7297.598632075234, 4660.86017419478, 4662.790174442158, 4668.533146685339, 4690.4605970313505, 4713.764311784397, 7571.810704732371, 7650.158482566913, 7654.502457340255, 7664.65509052094, 7669.5398276103615, 4420.425344705168, 4482.910341793146, 4544.250198717241, 4724.267738500538, 4725.40932383452, 3971.3645816669195, 4801.351817504662, 4812.903741925142, 4817.349657796152, 4834.057358815067, 5648.209250704905, 5766.625169363978, 5798.362180160179, 5805.390434004453, 5838.153467747153, 5824.621399609012, 6852.458196905756, 7289.307515785992, 7297.197308296083, 7301.160366557808, 1645.4981230724504, 1672.3310675729806, 1672.757450169743, 1679.3030892179609, 1679.8744840956588, 1019.4698756646651, 1052.0478966535297, 1066.1524088349781, 1067.5409573883305, 1081.0648788797632, 5734.942650573441, 6686.665666716644, 6689.331066893272, 6746.257911629717, 6791.2869148739655, 7522.811929701801, 7589.354904833041, 7594.7721568351935, 7619.847603047908, 7620.3522700571075, 6734.730610775612, 6741.8651626967185, 6762.154730658668, 6764.594124352555, 6765.898511522331, 3866.8839934802, 3962.5641179470235, 4001.9599804001587, 4023.376376661622, 4043.0700938784244, 7841.255080767432, 7842.0, 7843.56860372685, 7859.52842829432, 7905.130435652074, 7722.922770772333, 7752.573608451589, 7782.571958542221, 7792.454528182972, 7806.804829879185, 7821.335186509096, 7829.41279404047, 7851.097123830718, 7857.0, 7860.685572577033, 6151.50787936955, 7331.486795924234, 7473.0, 7517.924820751941, 7530.058742657168, 7465.365443937326, 7466.440016998638, 7468.066491688539, 7482.1021477423055, 7549.849003020019, 7299.759040963155, 7602.4298177638, 7991.4006449515355, 7994.720184793504, 8011.078725946591, 4706.8117275308605, 4710.670253082251, 4756.571908528249, 4757.215059515142, 4778.546038126373, 6404.295527492065, 7300.63496825146, 7380.741674041383, 7532.887006694795, 7653.464257501922, 7285.453590980804, 7331.230220826949, 7345.816354590964, 7351.338379545867, 7383.963080184565, 6350.0, 7019.052427922165, 7324.707011719472, 7348.228436014356, 7369.742059027908, 7112.928870711226, 7162.89255661155, 7174.2108368078425, 7196.604186769778, 7197.424206063607, 5890.293164820249, 7094.219635840157, 7437.921501382378, 7438.702451901863, 7441.8139546511775, 7211.531250468703, 7228.879523673839, 7234.204237533972, 7242.529235599669, 7254.5647261164495], "unit": "score", "name": "prototype.html", "value": 5248.78851815434}, {"lowerIsBetter": false, "replicates": [659.8086554899082, 699.8215455058959, 725.4414101142124, 768.101321453899, 780.1145699630918, 13979.0, 13982.021258511895, 14067.929660351683, 14864.77702834457, 15073.773893391608, 14405.78391324131, 14491.78262326066, 14529.910256730735, 14544.272786360667, 14566.417343306282, 746.2052913646976, 912.2747415804452, 913.2739472119648, 915.4141349536285, 925.3846192282158, 924.4407133684125, 928.7353104365258, 930.3580529434669, 932.1517419148577, 932.995335023324, 951.2722767083187, 985.4727720669443, 985.8225519406504, 987.1609132237612, 988.8813342398922, 945.2768631996528, 952.6903756279203, 962.3359881681617, 977.9608815647366, 979.8971108033696, 703.5110598134298, 721.7365661533555, 723.352599423513, 727.8798998165296, 729.2525161709237, 14471.0, 14477.71044579113, 14679.266036698122, 14761.630959225999, 14930.10419374841, 12584.748305033849, 12603.991680665526, 12645.241285522898, 12835.294058826761, 12835.807462888064, 8336.208060234268, 9904.801903961952, 10015.198784097254, 10744.946275268574, 10841.349519028883, 3472.131967008248, 3472.28818092293, 3516.226430185355, 3538.5028493003733, 3543.255916257589, 63824.40438989016, 70560.6471967642, 81278.0, 82212.0, 82219.17780822235, 8779.868301975475, 8845.380823342304, 9109.726708198765, 9176.265898728087, 9491.715248542554, 20393.0, 20540.794592054186, 20689.17243310281, 20735.792642073688, 20885.37343879686, 7227.385672217815, 7264.164621068645, 7269.454790890704, 7286.70853165878, 7489.550626962399, 4050.41269015991, 4094.6724262058965, 4107.466029416157, 4111.362738775495, 4119.423280740699, 3620.0587847159927, 3643.2531331077066, 3646.872359467459, 3651.908702282411, 3697.3159965406485, 660.8579155481499, 663.5653646861314, 675.9797206083825, 697.6197972105215, 723.6743465440468, 530.1517571884954, 576.881739243454, 590.1560768101656, 602.1780269931512, 617.5923890232425, 7867.6459559319965, 7981.880271795928, 8111.472754270953, 8129.634166462523, 8269.875951860728, 567.2512283785363, 573.5803885383725, 579.8347470970838, 604.8246008657528, 628.9276733175652, 3710.9257814843554, 3901.9609803902167, 3905.984444044569, 3911.06134527717, 3985.382265748756, 94173.0, 94534.0, 94671.0532894676, 94863.57704634436, 95112.0488795117, 80847.5957620208, 81287.5935620318, 81443.0, 81711.5914420436, 81756.59121704353, 67211.0, 73127.0, 73504.0, 73626.26373736301, 74250.628746857, 8393.580320983805, 8419.368547359096, 8465.576721163794, 8498.915010849812, 8579.742607721779, 49029.50970490249, 50235.74882125712, 50471.0, 50642.0, 52286.0, 64288.39279018062, 72801.0, 76532.0, 76798.6160069196, 78859.60570197113, 11131.777364452828, 11609.975964541669, 11684.240524365889, 11712.824307635563, 12051.33717645538, 11904.523819047141, 12041.09691773103, 12061.336626485627, 12193.756124877631, 12309.753804923672, 11332.660020199408, 11592.6522204334, 11901.285922844658, 11930.463129159036, 12134.696632584257, 11567.537298507965, 11736.295822250693, 11795.41022948832, 11954.10344224204, 12161.209521381083, 10576.735581610521, 10622.044016038593, 11133.83299250528, 11346.489407976826, 11602.47788849487, 7866.9213307866185, 9463.668771592962, 9506.762330941781, 9566.234701224024, 9774.706758797247, 8354.498730076215, 9747.853782193415, 9761.414315141114, 9765.511724413609, 9850.852237216304], "unit": "score", "name": "yui.html", "value": 6959.9371808558935}], "name": "dromaeo_css", "value": 7589.378301013528}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 114.0, 115.0, 113.0, 128.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 130.0, 180.0, 147.0, 171.0, 142.0, 146.0, 192.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [191.0, 199.0, 198.0, 207.0, 222.0, 265.0, 246.0, 197.0, 202.0, 195.0], "unit": "score", "name": "audio-dft", "value": 212.2}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 72.0, 76.0, 97.0, 142.0, 55.0, 57.0, 67.0, 87.0], "unit": "score", "name": "audio-fft", "value": 76.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 119.0, 80.0, 78.0, 82.0, 114.0, 81.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 91.7}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 90.0, 88.0, 90.0, 88.0, 112.0, 112.0, 91.0, 101.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [120.0, 96.0, 94.0, 96.0, 94.0, 93.0, 95.0, 96.0, 100.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 97.8}, {"lowerIsBetter": true, "replicates": [125.0, 96.0, 140.0, 147.0, 99.0, 145.0, 124.0, 90.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 114.9}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 59.0, 60.0, 83.0, 62.0, 66.0, 52.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [58.0, 95.0, 64.0, 77.0, 107.0, 108.0, 105.0, 71.0, 64.0, 85.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 83.4}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 83.0, 84.0, 85.0, 85.0, 85.0, 88.0, 74.0, 99.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [162.0, 135.0, 153.0, 134.0, 143.0, 143.0, 136.0, 148.0, 148.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 141.9}, {"lowerIsBetter": true, "replicates": [131.0, 140.0, 144.0, 181.0, 190.0, 140.0, 144.0, 138.0, 145.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 69.0, 68.0, 83.0, 88.0, 101.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.4}], "name": "kraken", "value": 1548.6000000000001}]} 07:32:42 INFO - Return code: 0 07:32:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:32:42 ERROR - # TBPL SUCCESS # 07:32:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:32:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:32:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:32:42 INFO - 2016-03-30 07:32:42.178 screenresolution[1691:10432] starting screenresolution argv=screenresolution get 07:32:42 INFO - 2016-03-30 07:32:42.181 screenresolution[1691:10432] Display 0: 1600x1200x32@60 07:32:42 INFO - 2016-03-30 07:32:42.187 screenresolution[1692:10435] starting screenresolution argv=screenresolution list 07:32:42 INFO - Available Modes on Display 0 07:32:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:32:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:32:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:32:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:32:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:32:42 INFO - Intel Iris: 07:32:42 INFO - Chipset Model: Intel Iris 07:32:42 INFO - Type: GPU 07:32:42 INFO - Bus: Built-In 07:32:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:32:42 INFO - Vendor: Intel (0x8086) 07:32:42 INFO - Device ID: 0x0a2e 07:32:42 INFO - Revision ID: 0x0009 07:32:42 INFO - Displays: 07:32:42 INFO - Display: 07:32:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:32:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:32:42 INFO - Display Serial Number: 1600x1200 60 07:32:42 INFO - Main Display: Yes 07:32:42 INFO - Mirror: Off 07:32:42 INFO - Online: Yes 07:32:42 INFO - Rotation: Supported 07:32:42 INFO - Return code: 0 07:32:42 INFO - Running post-action listener: _resource_record_post_action 07:32:42 INFO - Running post-run listener: _resource_record_post_run 07:32:43 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 39585280; Write bytes: 708704256; Read time: 424; Write time: 1896 07:32:43 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399581696; Write bytes: 388085760; Read time: 30197; Write time: 729 07:32:43 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32472576; Write bytes: 303230976; Read time: 337; Write time: 1124 07:32:43 INFO - Running post-run listener: _upload_blobber_files 07:32:43 INFO - Blob upload gear active. 07:32:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:32:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:32:43 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'] 07:32:43 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 07:32:44 INFO - (blobuploader) - INFO - Open directory for files ... 07:32:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:32:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:32:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:45 INFO - (blobuploader) - INFO - Done attempting. 07:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:32:47 INFO - (blobuploader) - INFO - Done attempting. 07:32:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:32:47 INFO - Return code: 0 07:32:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:32:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:32:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcfeb2f46ed7b973ac5ae9fbe262dd3ccc0515f7ec7d625b1de73b86ad7e65bed33390483fd1af8914547f9f9958d1399d125fe7cd3d454e93e124eb09f2905c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f8048190e96e319ac88380bcadb4eb3710bc81c9cf2f7d2046ef83d723daccef543c86b8f89745b8004e465b134a1315a2b44cc41aec509bd550fc6ce7b3ba"} 07:32:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:32:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:32:47 INFO - Contents: 07:32:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcfeb2f46ed7b973ac5ae9fbe262dd3ccc0515f7ec7d625b1de73b86ad7e65bed33390483fd1af8914547f9f9958d1399d125fe7cd3d454e93e124eb09f2905c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f8048190e96e319ac88380bcadb4eb3710bc81c9cf2f7d2046ef83d723daccef543c86b8f89745b8004e465b134a1315a2b44cc41aec509bd550fc6ce7b3ba"} 07:32:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:32:47 INFO - Copying logs to upload dir... 07:32:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:32:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.472727 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-30 07:32:48.094661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 07:32:48.097829) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcfeb2f46ed7b973ac5ae9fbe262dd3ccc0515f7ec7d625b1de73b86ad7e65bed33390483fd1af8914547f9f9958d1399d125fe7cd3d454e93e124eb09f2905c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f8048190e96e319ac88380bcadb4eb3710bc81c9cf2f7d2046ef83d723daccef543c86b8f89745b8004e465b134a1315a2b44cc41aec509bd550fc6ce7b3ba"} build_url:https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010993 build_url: 'https://queue.taskcluster.net/v1/task/dPzsJe5OS-mWjJAqYmt4mA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcfeb2f46ed7b973ac5ae9fbe262dd3ccc0515f7ec7d625b1de73b86ad7e65bed33390483fd1af8914547f9f9958d1399d125fe7cd3d454e93e124eb09f2905c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f8048190e96e319ac88380bcadb4eb3710bc81c9cf2f7d2046ef83d723daccef543c86b8f89745b8004e465b134a1315a2b44cc41aec509bd550fc6ce7b3ba"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 07:32:48.253333) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:32:48.253642) ========= 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.xDywQxhl4g/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.1lqxmEWxQP/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005197 ========= master_lag: 0.70 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 07:32:48.961833) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 07:32:48.962149) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 07:32:48.962502) ========= ========= Total master_lag: 3.33 =========