builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1447893083.54 results: success (0) buildid: 20151118135239 builduid: 93db3188fd6a487786193605ffd65c29 revision: 24c5d435977da94d3986c89085496d8ddef6f1b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.542146) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.542932) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.543312) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005279 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.571555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.571874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.588416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.589161) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005207 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.639178) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.639521) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.639910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.640262) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 --2015-11-18 16:31:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.33M=0.001s 2015-11-18 16:31:23 (8.33 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189450 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.844116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.844566) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.019619 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.894910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:23.895337) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 24c5d435977da94d3986c89085496d8ddef6f1b2 --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 24c5d435977da94d3986c89085496d8ddef6f1b2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 2015-11-18 16:31:23,962 truncating revision to first 12 chars 2015-11-18 16:31:23,963 Setting DEBUG logging. 2015-11-18 16:31:23,963 attempt 1/10 2015-11-18 16:31:23,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/24c5d435977d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 16:31:24,556 unpacking tar archive at: fx-team-24c5d435977d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.834727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:24.745124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:24.745515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:24.757119) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:24.757445) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 16:31:24.757885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-18 16:31:24.758224) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:31:24 INFO - MultiFileLogger online at 20151118 16:31:24 in /builds/slave/test 16:31:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:31:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:24 INFO - {'append_to_log': False, 16:31:24 INFO - 'base_work_dir': '/builds/slave/test', 16:31:24 INFO - 'blob_upload_branch': 'Fx-Team', 16:31:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:24 INFO - 'branch': 'Fx-Team', 16:31:24 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:24 INFO - 'config_files': ('talos/mac_config.py',), 16:31:24 INFO - 'default_actions': ('clobber', 16:31:24 INFO - 'read-buildbot-config', 16:31:24 INFO - 'download-and-extract', 16:31:24 INFO - 'populate-webroot', 16:31:24 INFO - 'create-virtualenv', 16:31:24 INFO - 'install', 16:31:24 INFO - 'run-tests'), 16:31:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:24 INFO - 'download_minidump_stackwalk': True, 16:31:24 INFO - 'download_symbols': 'ondemand', 16:31:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:24 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:24 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:24 INFO - 'installer_path': 'installer.exe', 16:31:24 INFO - 'log_level': 'info', 16:31:24 INFO - 'log_name': 'talos', 16:31:24 INFO - 'log_to_console': True, 16:31:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:31:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:31:24 INFO - 'opt_config_files': (), 16:31:24 INFO - 'pip_index': False, 16:31:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:24 INFO - 'cmd': ('bash', 16:31:24 INFO - '-c', 16:31:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:24 INFO - 'enabled': True, 16:31:24 INFO - 'halt_on_failure': False, 16:31:24 INFO - 'name': 'check_screen_resolution'},), 16:31:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:31:24 INFO - 'cmd': ('bash', 16:31:24 INFO - '-c', 16:31:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:31:24 INFO - 'enabled': True, 16:31:24 INFO - 'halt_on_failure': False, 16:31:24 INFO - 'name': 'check_screen_resolution'},), 16:31:24 INFO - 'run_cmd_checks_enabled': True, 16:31:24 INFO - 'sps_profile': False, 16:31:24 INFO - 'sps_profile_interval': 0, 16:31:24 INFO - 'suite': 'dromaeojs-e10s', 16:31:24 INFO - 'system_bits': '64', 16:31:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:24 INFO - 'title': 't-yosemite-r7-0029', 16:31:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:24 INFO - 'use_talos_json': True, 16:31:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:24 INFO - 'work_dir': 'build'} 16:31:24 INFO - ##### 16:31:24 INFO - ##### Running clobber step. 16:31:24 INFO - ##### 16:31:24 INFO - Running pre-action listener: _resource_record_pre_action 16:31:24 INFO - Running main action method: clobber 16:31:24 INFO - rmtree: /builds/slave/test/build 16:31:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:25 INFO - Running post-action listener: _resource_record_post_action 16:31:25 INFO - ##### 16:31:25 INFO - ##### Running read-buildbot-config step. 16:31:25 INFO - ##### 16:31:25 INFO - Running pre-action listener: _resource_record_pre_action 16:31:25 INFO - Running main action method: read_buildbot_config 16:31:25 INFO - Using buildbot properties: 16:31:25 INFO - { 16:31:25 INFO - "properties": { 16:31:25 INFO - "buildnumber": 5, 16:31:25 INFO - "product": "firefox", 16:31:25 INFO - "script_repo_revision": "production", 16:31:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:31:25 INFO - "repository": "", 16:31:25 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:31:25 INFO - "buildid": "20151118135239", 16:31:25 INFO - "slavename": "t-yosemite-r7-0029", 16:31:25 INFO - "pgo_build": "False", 16:31:25 INFO - "basedir": "/builds/slave/test", 16:31:25 INFO - "project": "", 16:31:25 INFO - "platform": "yosemite_r7", 16:31:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:31:25 INFO - "slavebuilddir": "test", 16:31:25 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:31:25 INFO - "branch": "fx-team", 16:31:25 INFO - "repo_path": "integration/fx-team", 16:31:25 INFO - "stage_platform": "macosx64", 16:31:25 INFO - "builduid": "93db3188fd6a487786193605ffd65c29", 16:31:25 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 16:31:25 INFO - }, 16:31:25 INFO - "sourcestamp": { 16:31:25 INFO - "repository": "", 16:31:25 INFO - "hasPatch": false, 16:31:25 INFO - "project": "", 16:31:25 INFO - "branch": "fx-team-macosx64-talos", 16:31:25 INFO - "changes": [ 16:31:25 INFO - { 16:31:25 INFO - "category": null, 16:31:25 INFO - "files": [ 16:31:25 INFO - { 16:31:25 INFO - "url": null, 16:31:25 INFO - "name": "https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:31:25 INFO - } 16:31:25 INFO - ], 16:31:25 INFO - "repository": "", 16:31:25 INFO - "rev": "24c5d435977da94d3986c89085496d8ddef6f1b2", 16:31:25 INFO - "who": "jwein@mozilla.com", 16:31:25 INFO - "when": 1447889152, 16:31:25 INFO - "number": 6679360, 16:31:25 INFO - "comments": "Bug 1213421 - Add a test that verifies the body text of a notification is present. r=MattN", 16:31:25 INFO - "project": "", 16:31:25 INFO - "at": "Wed 18 Nov 2015 15:25:52", 16:31:25 INFO - "branch": "fx-team-macosx64-talos", 16:31:25 INFO - "revlink": "", 16:31:25 INFO - "properties": [ 16:31:25 INFO - [ 16:31:25 INFO - "buildid", 16:31:25 INFO - "20151118135239", 16:31:25 INFO - "Change" 16:31:25 INFO - ], 16:31:25 INFO - [ 16:31:25 INFO - "builduid", 16:31:25 INFO - "93db3188fd6a487786193605ffd65c29", 16:31:25 INFO - "Change" 16:31:25 INFO - ], 16:31:25 INFO - [ 16:31:25 INFO - "pgo_build", 16:31:25 INFO - "False", 16:31:25 INFO - "Change" 16:31:25 INFO - ] 16:31:25 INFO - ], 16:31:25 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 16:31:25 INFO - } 16:31:25 INFO - ], 16:31:25 INFO - "revision": "24c5d435977da94d3986c89085496d8ddef6f1b2" 16:31:25 INFO - } 16:31:25 INFO - } 16:31:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:31:25 INFO - Running post-action listener: _resource_record_post_action 16:31:25 INFO - ##### 16:31:25 INFO - ##### Running download-and-extract step. 16:31:25 INFO - ##### 16:31:25 INFO - Running pre-action listener: _resource_record_pre_action 16:31:25 INFO - Running main action method: download_and_extract 16:31:25 INFO - mkdir: /builds/slave/test/build/tests 16:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:25 INFO - https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:31:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/test_packages.json 16:31:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/test_packages.json 16:31:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:31:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:31:26 INFO - Downloaded 1149 bytes. 16:31:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:31:26 INFO - Using the following test package requirements: 16:31:26 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:26 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:31:26 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'jsshell-mac.zip'], 16:31:26 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:31:26 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:26 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:31:26 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:31:26 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:31:26 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:31:26 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:31:26 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:31:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:31:27 INFO - Downloaded 17477412 bytes. 16:31:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:31:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:31:30 INFO - Return code: 0 16:31:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:31: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')]} 16:31:30 INFO - https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:31:31 INFO - Downloaded 17477412 bytes. 16:31:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:31:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:31:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:31:34 INFO - Return code: 0 16:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:34 INFO - https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:31:35 INFO - Downloaded 11130997 bytes. 16:31:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 16:31:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:31:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:31:36 INFO - Return code: 0 16:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:36 INFO - https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:31:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:31:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 16:31:39 INFO - Downloaded 108853496 bytes. 16:31:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:39 INFO - mkdir: /builds/slave/test/properties 16:31:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:39 INFO - Contents: 16:31:39 INFO - build_url:https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:31:39 INFO - Running post-action listener: _resource_record_post_action 16:31:39 INFO - Running post-action listener: set_extra_try_arguments 16:31:39 INFO - ##### 16:31:39 INFO - ##### Running populate-webroot step. 16:31:39 INFO - ##### 16:31:39 INFO - Running pre-action listener: _resource_record_pre_action 16:31:39 INFO - Running main action method: populate_webroot 16:31:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:31:39 INFO - '../fennec_ids.txt'], 16:31:39 INFO - 'tests': ['tcheck2']}, 16:31:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:39 INFO - '--tppagecycles', 16:31:39 INFO - '7'], 16:31:39 INFO - 'tests': ['tsvgm']}}, 16:31:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:31:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:31:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'tests': ['damp', 'tps']}, 16:31:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['damp', 'tps']}, 16:31:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:31:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:39 INFO - 'other': {'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'other_l64': {'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'other_nol64': {'tests': ['a11yr', 16:31:39 INFO - 'ts_paint', 16:31:39 INFO - 'tpaint', 16:31:39 INFO - 'sessionrestore', 16:31:39 INFO - 'sessionrestore_no_auto_restore']}, 16:31:39 INFO - 'svgr': {'tests': ['tsvgx', 16:31:39 INFO - 'tsvgr_opacity', 16:31:39 INFO - 'tart', 16:31:39 INFO - 'tscrollx', 16:31:39 INFO - 'cart']}, 16:31:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['tsvgx', 16:31:39 INFO - 'tsvgr_opacity', 16:31:39 INFO - 'tart', 16:31:39 INFO - 'tscrollx', 16:31:39 INFO - 'cart']}, 16:31:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'tests': ['tp5o']}, 16:31:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'talos_options': ['--e10s'], 16:31:39 INFO - 'tests': ['tp5o']}, 16:31:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'talos_options': ['--xperf_path', 16:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:39 INFO - 'tests': ['tp5n']}, 16:31:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:39 INFO - 'talos_options': ['--e10s', 16:31:39 INFO - '--xperf_path', 16:31:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:39 INFO - 'tests': ['tp5n']}}, 16:31:39 INFO - 'talos.zip': {'path': '', 16:31:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:39 INFO - Running post-action listener: _resource_record_post_action 16:31:39 INFO - ##### 16:31:39 INFO - ##### Running create-virtualenv step. 16:31:39 INFO - ##### 16:31:39 INFO - Running pre-action listener: _resource_record_pre_action 16:31:39 INFO - Running main action method: create_virtualenv 16:31:39 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:31:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:39 INFO - Using real prefix '/tools/python27' 16:31:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:43 INFO - Installing pip.................done. 16:31:43 INFO - Return code: 0 16:31:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:43 INFO - 'HOME': '/Users/cltbld', 16:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:43 INFO - 'LOGNAME': 'cltbld', 16:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:43 INFO - 'MOZ_NO_REMOTE': '1', 16:31:43 INFO - 'NO_EM_RESTART': '1', 16:31:43 INFO - 'PAGER': '/bin/cat', 16:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:43 INFO - 'PWD': '/builds/slave/test', 16:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:43 INFO - 'SHELL': '/bin/bash', 16:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:43 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:43 INFO - 'USER': 'cltbld', 16:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:43 INFO - 'XPC_FLAGS': '0x0', 16:31:43 INFO - 'XPC_SERVICE_NAME': '0', 16:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:31:43 INFO - Cleaning up... 16:31:43 INFO - Return code: 0 16:31:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:43 INFO - 'HOME': '/Users/cltbld', 16:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:43 INFO - 'LOGNAME': 'cltbld', 16:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:43 INFO - 'MOZ_NO_REMOTE': '1', 16:31:43 INFO - 'NO_EM_RESTART': '1', 16:31:43 INFO - 'PAGER': '/bin/cat', 16:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:43 INFO - 'PWD': '/builds/slave/test', 16:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:43 INFO - 'SHELL': '/bin/bash', 16:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:43 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:43 INFO - 'USER': 'cltbld', 16:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:43 INFO - 'XPC_FLAGS': '0x0', 16:31:43 INFO - 'XPC_SERVICE_NAME': '0', 16:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:43 INFO - Downloading/unpacking psutil>=0.7.1 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:46 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:31:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:46 INFO - Installing collected packages: psutil 16:31:46 INFO - Running setup.py install for psutil 16:31:46 INFO - building 'psutil._psutil_osx' extension 16:31:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:31:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:31:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:31:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:31:46 INFO - building 'psutil._psutil_posix' extension 16:31:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:31:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:46 INFO - ^ 16:31:47 INFO - 1 warning generated. 16:31:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:31:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:47 INFO - Successfully installed psutil 16:31:47 INFO - Cleaning up... 16:31:47 INFO - Return code: 0 16:31:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:31:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:47 INFO - 'HOME': '/Users/cltbld', 16:31:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:47 INFO - 'LOGNAME': 'cltbld', 16:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:47 INFO - 'MOZ_NO_REMOTE': '1', 16:31:47 INFO - 'NO_EM_RESTART': '1', 16:31:47 INFO - 'PAGER': '/bin/cat', 16:31:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:47 INFO - 'PWD': '/builds/slave/test', 16:31:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:47 INFO - 'SHELL': '/bin/bash', 16:31:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:47 INFO - 'USER': 'cltbld', 16:31:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:47 INFO - 'XPC_FLAGS': '0x0', 16:31:47 INFO - 'XPC_SERVICE_NAME': '0', 16:31:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:31:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:31:49 INFO - Installing collected packages: mozsystemmonitor 16:31:49 INFO - Running setup.py install for mozsystemmonitor 16:31:49 INFO - Successfully installed mozsystemmonitor 16:31:49 INFO - Cleaning up... 16:31:49 INFO - Return code: 0 16:31:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:49 INFO - 'HOME': '/Users/cltbld', 16:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:49 INFO - 'LOGNAME': 'cltbld', 16:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:49 INFO - 'MOZ_NO_REMOTE': '1', 16:31:49 INFO - 'NO_EM_RESTART': '1', 16:31:49 INFO - 'PAGER': '/bin/cat', 16:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:49 INFO - 'PWD': '/builds/slave/test', 16:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:49 INFO - 'SHELL': '/bin/bash', 16:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:49 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:49 INFO - 'USER': 'cltbld', 16:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:49 INFO - 'XPC_FLAGS': '0x0', 16:31:49 INFO - 'XPC_SERVICE_NAME': '0', 16:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:53 INFO - Downloading docopt-0.6.1.tar.gz 16:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:53 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:53 INFO - Running setup.py install for blobuploader 16:31:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:53 INFO - Running setup.py install for requests 16:31:54 INFO - Running setup.py install for docopt 16:31:54 INFO - Successfully installed blobuploader requests docopt 16:31:54 INFO - Cleaning up... 16:31:54 INFO - Return code: 0 16:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:31:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:54 INFO - 'HOME': '/Users/cltbld', 16:31:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:54 INFO - 'LOGNAME': 'cltbld', 16:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:54 INFO - 'MOZ_NO_REMOTE': '1', 16:31:54 INFO - 'NO_EM_RESTART': '1', 16:31:54 INFO - 'PAGER': '/bin/cat', 16:31:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:54 INFO - 'PWD': '/builds/slave/test', 16:31:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:54 INFO - 'SHELL': '/bin/bash', 16:31:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:54 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:54 INFO - 'USER': 'cltbld', 16:31:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:54 INFO - 'XPC_FLAGS': '0x0', 16:31:54 INFO - 'XPC_SERVICE_NAME': '0', 16:31:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:54 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4uoarF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:54 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_ls3dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:54 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-UrWWCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:54 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-FYt0ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:54 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VRXvzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4MqjZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-9DOxGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ZH3_tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-tzyiUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ZDEabR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-9I2HOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-hX87CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-8DpTK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:55 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Mjw3Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-h18xGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-r0LLZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:56 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NB6_yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:56 INFO - Running setup.py install for manifestparser 16:31:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:56 INFO - Running setup.py install for mozcrash 16:31:56 INFO - Running setup.py install for mozdebug 16:31:56 INFO - Running setup.py install for mozdevice 16:31:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:56 INFO - Running setup.py install for mozfile 16:31:57 INFO - Running setup.py install for mozhttpd 16:31:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Running setup.py install for mozinfo 16:31:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Running setup.py install for mozInstall 16:31:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Running setup.py install for mozleak 16:31:57 INFO - Running setup.py install for mozlog 16:31:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Running setup.py install for moznetwork 16:31:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:57 INFO - Running setup.py install for mozprocess 16:31:58 INFO - Running setup.py install for mozprofile 16:31:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:58 INFO - Running setup.py install for mozrunner 16:31:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:58 INFO - Running setup.py install for mozscreenshot 16:31:58 INFO - Running setup.py install for moztest 16:31:58 INFO - Running setup.py install for mozversion 16:31:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:58 INFO - Cleaning up... 16:31:58 INFO - Return code: 0 16:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:31:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:31:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:31:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:58 INFO - 'HOME': '/Users/cltbld', 16:31:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:58 INFO - 'LOGNAME': 'cltbld', 16:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:58 INFO - 'MOZ_NO_REMOTE': '1', 16:31:58 INFO - 'NO_EM_RESTART': '1', 16:31:58 INFO - 'PAGER': '/bin/cat', 16:31:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:58 INFO - 'PWD': '/builds/slave/test', 16:31:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:58 INFO - 'SHELL': '/bin/bash', 16:31:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:31:58 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:31:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:58 INFO - 'USER': 'cltbld', 16:31:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:58 INFO - 'XPC_FLAGS': '0x0', 16:31:58 INFO - 'XPC_SERVICE_NAME': '0', 16:31:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Q7KjoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-baRSKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-E5Y3lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-4usljz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jBS5GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VLiYEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rjmsRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:59 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-40SlSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-s6rSaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-pVGtir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-cVohlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Atq43E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Gq8W_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-iZuTpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0sJBSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nqpjH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:00 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-T_QUhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:32:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:03 INFO - Downloading blessings-1.5.1.tar.gz 16:32:03 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:03 INFO - Installing collected packages: blessings 16:32:03 INFO - Running setup.py install for blessings 16:32:03 INFO - Successfully installed blessings 16:32:03 INFO - Cleaning up... 16:32:03 INFO - Return code: 0 16:32:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:03 INFO - Reading from file tmpfile_stdout 16:32:03 INFO - Current package versions: 16:32:03 INFO - blessings == 1.5.1 16:32:03 INFO - blobuploader == 1.2.4 16:32:03 INFO - docopt == 0.6.1 16:32:03 INFO - manifestparser == 1.1 16:32:03 INFO - mozInstall == 1.12 16:32:03 INFO - mozcrash == 0.16 16:32:03 INFO - mozdebug == 0.1 16:32:03 INFO - mozdevice == 0.47 16:32:03 INFO - mozfile == 1.2 16:32:03 INFO - mozhttpd == 0.7 16:32:03 INFO - mozinfo == 0.9 16:32:03 INFO - mozleak == 0.1 16:32:03 INFO - mozlog == 3.0 16:32:03 INFO - moznetwork == 0.27 16:32:03 INFO - mozprocess == 0.22 16:32:03 INFO - mozprofile == 0.27 16:32:03 INFO - mozrunner == 6.11 16:32:03 INFO - mozscreenshot == 0.1 16:32:03 INFO - mozsystemmonitor == 0.0 16:32:03 INFO - moztest == 0.7 16:32:03 INFO - mozversion == 1.4 16:32:03 INFO - psutil == 3.1.1 16:32:03 INFO - requests == 1.2.3 16:32:03 INFO - wsgiref == 0.1.2 16:32:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x10ad03490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ace0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5f2d540e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, '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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:03 INFO - 'HOME': '/Users/cltbld', 16:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:03 INFO - 'LOGNAME': 'cltbld', 16:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:03 INFO - 'MOZ_NO_REMOTE': '1', 16:32:03 INFO - 'NO_EM_RESTART': '1', 16:32:03 INFO - 'PAGER': '/bin/cat', 16:32:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:03 INFO - 'PWD': '/builds/slave/test', 16:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:03 INFO - 'SHELL': '/bin/bash', 16:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:32:03 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:03 INFO - 'USER': 'cltbld', 16:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:03 INFO - 'XPC_FLAGS': '0x0', 16:32:03 INFO - 'XPC_SERVICE_NAME': '0', 16:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:32:03 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:32:03 INFO - Cleaning up... 16:32:03 INFO - Return code: 0 16:32:03 INFO - Running post-action listener: _resource_record_post_action 16:32:03 INFO - Running post-action listener: _start_resource_monitoring 16:32:03 INFO - Starting resource monitoring. 16:32:03 INFO - ##### 16:32:03 INFO - ##### Running install step. 16:32:03 INFO - ##### 16:32:03 INFO - Running pre-action listener: _resource_record_pre_action 16:32:03 INFO - Running main action method: install 16:32:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:04 INFO - Reading from file tmpfile_stdout 16:32:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:04 INFO - Reading from file tmpfile_stdout 16:32:04 INFO - Output received: 16:32:04 INFO - Usage: mozinstall [options] installer 16:32:04 INFO - Options: 16:32:04 INFO - -h, --help show this help message and exit 16:32:04 INFO - -d DEST, --destination=DEST 16:32:04 INFO - Directory to install application into. [default: 16:32:04 INFO - "/builds/slave/test"] 16:32:04 INFO - --app=APP Application being installed. [default: firefox] 16:32:04 INFO - mkdir: /builds/slave/test/build/application 16:32:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:32:34 INFO - Reading from file tmpfile_stdout 16:32:34 INFO - Output received: 16:32:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:32:34 INFO - Running post-action listener: _resource_record_post_action 16:32:34 INFO - ##### 16:32:34 INFO - ##### Running run-tests step. 16:32:34 INFO - ##### 16:32:34 INFO - Running pre-action listener: _resource_record_pre_action 16:32:34 INFO - Running main action method: run_tests 16:32:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:34 INFO - 2015-11-18 16:32:34.738 screenresolution[1946:11687] starting screenresolution argv=screenresolution get 16:32:34 INFO - 2015-11-18 16:32:34.740 screenresolution[1946:11687] Display 0: 1600x1200x32@60 16:32:34 INFO - 2015-11-18 16:32:34.746 screenresolution[1947:11689] starting screenresolution argv=screenresolution list 16:32:34 INFO - Available Modes on Display 0 16:32:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:34 INFO - Intel Iris: 16:32:34 INFO - Chipset Model: Intel Iris 16:32:34 INFO - Type: GPU 16:32:34 INFO - Bus: Built-In 16:32:34 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:34 INFO - Vendor: Intel (0x8086) 16:32:34 INFO - Device ID: 0x0a2e 16:32:34 INFO - Revision ID: 0x0009 16:32:34 INFO - Displays: 16:32:34 INFO - Display: 16:32:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:34 INFO - Display Serial Number: 1600x1200 60 16:32:34 INFO - Main Display: Yes 16:32:34 INFO - Mirror: Off 16:32:34 INFO - Online: Yes 16:32:34 INFO - Rotation: Supported 16:32:34 INFO - Return code: 0 16:32:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:34 INFO - Python 2.7.3 16:32:34 INFO - Return code: 0 16:32:34 INFO - grabbing minidump binary from tooltool 16:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:34 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 0x10ac279f0>, '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 0x10a986db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac1a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:32:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:32:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:35 INFO - Return code: 0 16:32:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost'] in /builds/slave/test/build 16:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost 16:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4IhyJzOJ9K/Render', 16:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:32:35 INFO - 'HOME': '/Users/cltbld', 16:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:32:35 INFO - 'LOGNAME': 'cltbld', 16:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:35 INFO - 'MOZ_NO_REMOTE': '1', 16:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:35 INFO - 'NO_EM_RESTART': '1', 16:32:35 INFO - 'PAGER': '/bin/cat', 16:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:35 INFO - 'PWD': '/builds/slave/test', 16:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:32:35 INFO - 'SHELL': '/bin/bash', 16:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pXHZnmA3aV/Listeners', 16:32:35 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 16:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:32:35 INFO - 'USER': 'cltbld', 16:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:35 INFO - 'XPC_FLAGS': '0x0', 16:32:35 INFO - 'XPC_SERVICE_NAME': '0', 16:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:32:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost'] with output_timeout 3600 16:32:35 INFO - mozversion INFO | application_buildid: 20151118135239 16:32:35 INFO - mozversion INFO | application_changeset: 24c5d435977da94d3986c89085496d8ddef6f1b2 16:32:35 INFO - mozversion INFO | application_display_name: Nightly 16:32:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:35 INFO - mozversion INFO | application_name: Firefox 16:32:35 INFO - mozversion INFO | application_remotingname: firefox 16:32:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:32:35 INFO - mozversion INFO | application_vendor: Mozilla 16:32:35 INFO - mozversion INFO | application_version: 45.0a1 16:32:35 INFO - mozversion INFO | platform_buildid: 20151118135239 16:32:35 INFO - mozversion INFO | platform_changeset: 24c5d435977da94d3986c89085496d8ddef6f1b2 16:32:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:32:35 INFO - mozversion INFO | platform_version: 45.0a1 16:32:35 INFO - 2015-11-18 16:32:35,283 DEBUG : using testdate: 1447893155 16:32:35 INFO - 2015-11-18 16:32:35,283 DEBUG : actual date: 1447893155 16:32:35 INFO - 2015-11-18 16:32:35,632 INFO : starting webserver on 'localhost:49708' 16:32:35 INFO - 2015-11-18 16:32:35,633 INFO : Starting test suite t-yosemite-r7-0029.e 16:32:35 INFO - 2015-11-18 16:32:35,633 INFO : Starting test dromaeo_css 16:32:35 INFO - 2015-11-18 16:32:35,634 DEBUG : operating with platform_type : mac_ 16:32:35 INFO - 2015-11-18 16:32:35,635 INFO : Initialising browser for dromaeo_css test... 16:32:35 INFO - 2015-11-18 16:32:35,646 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpMfBW9t/profile http://localhost:49708/getInfo.html 16:32:38 INFO - 2015-11-18 16:32:38,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:32:38 INFO - 2015-11-18 16:32:38,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:32:38 INFO - 2015-11-18 16:32:38,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:32:38 INFO - 2015-11-18 16:32:38,227 DEBUG : BROWSER_OUTPUT: __metrics 16:32:38 INFO - 2015-11-18 16:32:38,798 INFO : Browser initialized. 16:32:38 INFO - 2015-11-18 16:32:38,799 INFO : Running cycle 1/1 for dromaeo_css test... 16:32:38 INFO - 2015-11-18 16:32:38,799 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpMfBW9t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:32:50 INFO - 2015-11-18 16:32:50,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 237109248 16:32:50 INFO - 2015-11-18 16:32:50,899 DEBUG : BROWSER_OUTPUT: 16:33:40 INFO - 2015-11-18 16:33:40,566 DEBUG : BROWSER_OUTPUT: 1447893220564 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:35:50 INFO - 2015-11-18 16:35:50,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49708/tests/dromaeo/cssquery-ext.html) 16:35:51 INFO - 2015-11-18 16:35:51,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 253702144 16:35:51 INFO - 2015-11-18 16:35:51,586 DEBUG : BROWSER_OUTPUT: 16:38:53 INFO - 2015-11-18 16:38:53,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-ext.html (next: http://localhost:49708/tests/dromaeo/cssquery-jquery.html) 16:38:54 INFO - 2015-11-18 16:38:54,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 263348224 16:38:54 INFO - 2015-11-18 16:38:54,092 DEBUG : BROWSER_OUTPUT: 16:41:55 INFO - 2015-11-18 16:41:55,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49708/tests/dromaeo/cssquery-mootools.html) 16:41:56 INFO - 2015-11-18 16:41:56,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 263196672 16:41:56 INFO - 2015-11-18 16:41:56,307 DEBUG : BROWSER_OUTPUT: 16:44:57 INFO - 2015-11-18 16:44:57,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49708/tests/dromaeo/cssquery-prototype.html) 16:44:58 INFO - 2015-11-18 16:44:58,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 265641984 16:44:58 INFO - 2015-11-18 16:44:58,488 DEBUG : BROWSER_OUTPUT: 16:48:01 INFO - 2015-11-18 16:48:01,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49708/tests/dromaeo/cssquery-yui.html) 16:48:01 INFO - 2015-11-18 16:48:01,730 DEBUG : BROWSER_OUTPUT: RSS: Main: 270258176 16:48:01 INFO - 2015-11-18 16:48:01,730 DEBUG : BROWSER_OUTPUT: 16:51:03 INFO - 2015-11-18 16:51:03,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/dromaeo/cssquery-yui.html (next: http://localhost:49708/tests/dromaeo/cssquery-dojo.html) 16:51:04 INFO - 2015-11-18 16:51:04,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 271904768 16:51:04 INFO - 2015-11-18 16:51:04,222 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,222 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:51:04 INFO - 2015-11-18 16:51:04,222 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:51:04 INFO - 2015-11-18 16:51:04,223 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:51:04 INFO - 2015-11-18 16:51:04,223 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:51:04 INFO - 2015-11-18 16:51:04,223 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2965.5848181254614;3463.255400088981;3497.318022985519;3536.5225694531264;3545.5922568904566;5772.9999999999945;5787.47912687858;5798.855028624276;5824.359320474744;5864.794732184374;5597;5685.431456854323;5707.6290041147295;5721.084626459768;5721.599488035839;5171.482851714817;5226.24219488173;5239.187925871496;5240.44975277596;5376.38171610264;4381.693281470282;5361.249425080492;5376.569874410057;5402.78388864445;5414.702191379472;4823.9035219295765;4833.806647734086;5124.743762811844;5239.056969745444;5459.3994660587305;5318.574514038867;5319.936012797456;5326.547243484309;5328.227407025959;5340.49265319794;4994.400671919357;5111.693298402108;5293.682379057269;5325.360956685184;5366.577856867933;4992.950070499285;5164.664296820694;5235.6073294502685;5725.742341594639;5750.338711048241;6252.18721566198;6254.9650460756675;6301.338359472281;6312.053192021188;6332.4934005279465;6326.778562750328;6340.112384266206;6356.872862542723;6357.872842543124;6368.172137622126;5657.688827114507;5773.364929857712;5782.768689252425;5888;5901.262342207224;6273.686315684197;6321.209848768904;6356.491480681534;6373.776917807947;6378.298387177407;6067.75728970845;6203.47270482005;6276.089966954857;6280.2777680566405;6309.33751956038;6163.9383606164265;6247.406496382836;6290.308066112724;6330.177076980055;6355.682215889279;6248.375162483806;6269.247690277196;6307.558470906993;6336.081268216083;6347.079673447417;5917.615355001911;6060.424259695322;6295.338989406138;6337.8732425352155;6358.982562789932;4952.876178095505;4998.950010499849;4999.575036121898;5000.799968001312;5033.672811267256;4471.821127154943;4475.239209334421;4490.865274041784;4536.546345365503;4567.19595759673;5639.605227634026;5712.771489140471;5750.856228594235;5803.071508558694;5829.271341082364;6305.621662700252;6319.24169099711;6324.841878952971;6328.778492752824;6335.841603959846;5805.245318108703;5942.524598032147;5945.078512830518;5949.137375080589;5993.130996005555;4887.511248875084;5121.820736274212;5316.787328506816;5459.863503412367;5528.806491772769;6263.404976527223;6317.557770955989;6335.3981371769605;6344.904826427607;6356.300806911236;6287;6306.243250809932;6306.905396418965;6319.24169099711;6324.557280990287;5340.866478338073;6176.536759743127;6319.336469670802;6366.395192456709;6387.904181437189;6262.749490020348;6299.96850015747;6312.400321969406;6316.715747791269;6327.936720632735;6327.746890124344;6338.207724034496;6367.649779262185;6372.330905254881;6382.138411314413;4466.352378904976;4989.950100499093;5904.527637789052;5927.762889484372;6186.876262474635;6113.694315284307;6114.449699527064;6122.112293717297;6125.724342404692;6127.479164271087;4376.9124617508105;5950.285965683973;5991.221141251609;6004.459598635969;6011.489023433057;5472.288602481811;6098.817035488943;6139.201903752483;6224.751009959551;6250.312465628868;6053.334133245251;6126.693665316806;6136.754529818757;6142.416470435302;6167.074938759042 16:51:04 INFO - 2015-11-18 16:51:04,224 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.250299592554;560.39459509075;570.500811789684;578.6528083150108;610.5115907274181;41297.79351103244;41381.37927931084;41466.17067658645;41628.37557436641;41755.58244417555;43280;43840.3423948641;43936.780316098455;44008.559914400845;44015;9767.658131965383;9843.163331116864;9927.751806204866;9959.502024898762;9966.252531060163;9705.126538611523;9784;9803.509824508781;9808.50957452128;9846.080014397196;9653.71038868835;9735.51322433879;9769.658061967833;9783.902160978407;9784.315097943147;9635.373700709431;9726.076022777825;9729.416235025885;9749.658761943298;9754.658586949457;9540.856887146698;9701.369410988264;9712.660056897974;9721;9724.367916085432;41418.792906035276;41424.79287603573;41453;41525;41753;3133.9529907051415;3167.5090360993854;3190.5054716518976;3246.172226082334;3257.8933219161213;28765;29191.686374113215;29325.560116598055;29377.706222937926;29565.191306825818;2411.770881766229;2507.8119141064312;2514.673092497982;2572.1383336582267;2638.0503018913178;422375;505453;510221;511112;517680;60684.393156068756;62299;63209.36790632127;69655.65172174107;69795;59791;75949;76903.61548192223;77199.61400192963;77653.44693106106;16551.172441377883;16614.25235864389;16697.248623811956;16812.579685507717;16818.831811681972;12468.127231093737;12568.434420451102;12569.93715031419;12677.809832852514;12678.936605316914;22168.672289409704;22183.889080554494;22273.55452890933;22525.88737056337;22533.88733056324;8094.345751193087;9497.382670126419;9740.46427446483;9745.220382369393;9746.512674366253;936.9672061477816;944.3436811416137;958.9328746987784;1038.984415233772;1110.9777804443866;30186;30240.546391804142;30529.69470305313;31004.22489437782;31201.375972480422;1053.262716098734;1088.983665245022;1162.412981444382;1193.9223950443193;1246.3643541793751;15224.314905829264;15276.694466110837;15644.452444164399;15726;16955.57611059709;678921.4485348171;683879;683938;684940;685006;50658.74670626623;61354.69322653358;62659;62857;62866.37133628605;1450.6808502129516;1464.8168978877854;1481.7925490431348;1482.384810303712;1484.4359143525392;28484.776166895273;31402.900898468444;31451.52822707707;31566;32098.51852222172;52614.473855260956;52737;52761.7361913188;53207;53551.19673204983;462771;465864.6706766444;466236;467620;474651;28709.56935645925;29211.269718257212;33000;45715.31427028664;48936.510634893195;47951.28073078837;48329.5167048325;49522.25716614326;50061;50286.74856625694;39682.20635587214;39956.801295961166;40290;40945.38581921214;42806;39096.2180756389;39477;39775.80112099421;39929;40302.798486007385;38711.6128838708;39790.60209397869;39943.00142496461;40110.59889401068;40117.79941100276;34290.48564271488;35531.644683553866;35935.64064359428;36044.91865244047;36231.63768362282;26429.7357026435;26727.732722672525;26886.865565672048;27051.9599811327;27095 16:51:04 INFO - 2015-11-18 16:51:04,228 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.2925295987148;359.16852486493764;364.0806962419888;364.60258318432903;366.6480179028133;15981.360745570164;19929.701054484176;20218.59562808743;20993.895030524844;21571.029303681335;12361.876381236185;14831.851681483182;19363.966783487744;19624.41126766199;19847.503812404662;4759.809607615691;4871.4154301483695;4882.487338829407;4889.633277504184;4897;3718.7954662493553;3811.790351530665;4860.538248866352;5226.999999999981;5360.142377219646;5204.661696989702;5241.135212689902;5249.658772179815;5256.237845512398;5268.104422248208;4267.637250833683;5183.222516622499;5193.169092945149;5203.505666961632;5225.79096836128;4295.506016808075;4373.781310934441;4381.18947994622;4392.758398288093;4405.735655860659;13952.16287022782;14020.018598698096;14217.075890067112;14340.56978290653;14380;1874.4470381237568;1908.8377487913544;1948.3083505355678;1950.6781381072105;2012.909419076145;10223.591056357736;10284.537195826206;10311.793764124675;10459.006394392596;10566.049055584957;1581.2172974377643;1653.875959303057;1660.0703605980568;1680.7983042035034;1723.2159367487764;89433;93666.53166734123;93734;93966.06033939641;94555;6790.8641827164165;6875.346842049998;6877.415419689282;6952.443804495628;6958.060661810692;7788.376929845599;7842.490238134503;7848.254415830487;7873.881891771628;7885.881711774328;4771.260454629469;5730;5734.856628584235;5788.450097240755;5846.327672317653;6167.784127555514;6196.721147548371;6197.845053873599;6213.471854892295;6235.189425374672;3064.7548196144253;3066.47869862124;3093.0256969054676;3109.595752552199;3112.673169317234;926.9073092690812;991.3655260633201;1098.4617537406614;1128.1031579894004;1131.9490622921824;343.90370696205105;425.34284530400606;441.8115269923894;450.1492179780218;451.80120746871273;10222.284440089123;10463.790724185474;10885.510152043176;11729.296242225322;12489.50041998328;451.9604908709954;464.6863367227108;472.79433446450906;476.07166026248956;505.1841276338687;6601;6697.531172817856;6739.797806065826;6769.559978601375;6774.932250677529;622452;631975;644544;812832;830142;122745;125959.74040259664;126129.10806337913;127501;127785;519.5220397234554;530.3794560364383;534.2013689534093;535.1811728056081;537.3766430940091;11178.27341222818;11549.88450115488;11754.05967522579;12014.939925300318;12071.818922715991;32828.835855820565;52187;52648.73675631597;53078.4692153089;53250.20124698055;74242.62878685573;74973.625131874;75259;75888;76636;17034.318627254772;17386.652266954843;17617.207225674618;17801.287948482433;17811.554711132325;11473.254238474472;11798.705032374259;21546.353609391743;22135.335939921828;22165.556688866454;9965.40207587547;10114.342567733074;10175.542100605639;10307.793844123225;10318.948405257926;8799.34004949644;9900.950495247478;10091.495425228855;10186.286959912735;10220.386776793417;9891.35706179096;10328.173746100143;10338.948305258426;10354.844677329695;10478.056974872297;16092.758608620647;16383.59041023984;16586.917065414596;16785.496435106965;17024.914875425544;16550.841441099008;16572.50282491527;16723.247453864362;17097;17129.828701712824 16:51:04 INFO - 2015-11-18 16:51:04,229 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1546.5824227458586;1584.8335924727903;1717.8110407855133;1852.9253033240723;1887.7357169996194;6691.397774200321;7321.524100933449;7980.2019798020165;8084.959575202123;8102.594870256486;7180.67686954087;7859.489133206352;7951.165127661599;7957.681692732298;7957.960210198941;1985.4837742186992;2290.977090229093;2333.0667732906804;2335.2060299498166;2341.8243631727687;2336.4742932840145;2363.291012696193;2396.0535588442553;2410.1203060882826;2410.1323523531514;2319.5476882008015;2346.4837735698206;2377.037299893546;2381.6427535869584;2382.5354055959097;2305.5734689082574;2313.7570555091643;2327.650852372141;2332.3469428559947;2348;2182.3562049195366;2309.734380546242;2381.404648837791;2404.651325557802;2410.6745589345387;7338;7487.363574096208;8059.194080591952;8065.717699880476;8093.069297030858;4197.727147735387;4271.722338048017;5029.1450453423;5041.991601679642;5044.848654540369;2883.408901175254;3365.9831700841582;3377.4427219508752;3458.6368431314854;3463.0649724574223;999.6751055906786;1018.9235807314407;1021.1932573267185;1026.1021606094666;1036.1917704190744;10352.792944141074;10390.532426040847;10391.896081039244;10414.27100102993;10422.739431514197;4485.887852803641;4540.523245059221;4578.702384345073;4624.9768751156025;4629.120467111238;9061.954690226507;9088.909110908939;9089.50007749567;9108.225800807006;9126.634934602542;5039.067772462033;5050.949490505048;5061.139606266944;5064.164412871909;5071.137906555894;4067.3695577185586;4181.121964387452;4542.364069030338;4589.908201835945;4648.48866624671;3168.8098714077228;3700.111973126484;3737.5514938207043;3847.0574709196426;3849.6920246380223;1287.845458544962;1296.9818692326478;1300.3758196065942;1301.3298151452009;1317.5783749200164;1028.5165971993301;1050.0077426831572;1054.926155169146;1216.4525963316544;1400.2998500749625;7395.075615548057;7438.516496427715;7483.513571617827;7487.700491980259;7517.548947063194;495.49459551258235;496.55558275343367;498.8827625508003;501.66889852697045;506.29624821498146;5916.674582897896;5970.910436343458;5986.102084687332;5989;6062.878742425127;9076.319276054322;9404.38871473352;9444.574994125282;9478.857817132748;9489.572969216402;9234.492102934402;9337.253019758404;9339.299552533586;9353.064693530592;9438;6110.969445152746;6636.668166591651;7197.812360960383;7297.379722723628;7397.112346518452;6398.680065996588;6841.905295152752;7089.36195742365;7148.821279468055;7158;8247.505149691038;8412.663493460193;8433.451825631315;8546.700865469678;8557.229849313591;8533.232009119209;8724.43291186071;8735.825283494421;8757.343199259954;8839;5707.400722924033;6222.564420490522;6380.9361906380345;6935.7225710971;6967.268436814062;6267.811965641038;7573.091229052549;7619.542827430372;7620.69517219305;7642.312191902755;6991.300869912968;7071.434285257064;7097.361237488651;7150.713971441084;7241.963790181016;6829.89755153683;7021.368076873106;7031.542949708252;7032.753853615303;7161.4628902831455;6818.829529261808;7122.430205583644;7146.606936618536;7198.352148306678;7205.891911621435;6555.639439830855;6588.538802283986;6589.5387322888855;6594.637294948632;6607.240167380621;5649.293838270216;6541.8691626166255;6631.436327912182;6635.5355125142705;6706.83232919181 16:51:04 INFO - 2015-11-18 16:51:04,231 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.2951630844128;318.44590412681936;322.43251876697013;332.62579597952305;335.15373681454327;5315.681059136445;6770.593764374141;6902.551334163282;6959.234484206733;7015.543989640682;6700.363465470772;6877.209120951092;6900.6204658743745;6907.378335949764;6923.723051077964;5164.561012313958;5168.586513078944;5176.482351764831;5178.792848286064;5185.274061631356;4825.710457372551;5150.536451719345;5153.974230128844;5176.7929282828645;5186.988537235241;4993.425756038066;5028.6982781033075;5052.823151189709;5053.166227572447;5054.3176671149295;5032.345795046639;5035;5036.84889453317;5037.748112594392;5039.344885164942;3610.9708733010966;3816.370298900678;4015.217032678629;4113;4255.255330317213;6605.207375114969;6608.768693095719;6662.300458451841;6669.899951500732;6692.263850976388;5849.186752106861;5932.851678708067;5936.762529498815;5939.940600593982;5941.405859414067;5903.763849446017;7103.289671032855;7319.890201646979;7385.9261407385775;7389.113306403212;4692.436907571079;4707.71753694776;4738.8341408050555;4741.881452963669;4742.146413645542;7764.805879852993;7818.33544148748;7855.096663883669;7861;7878.975733154711;3529.0942890839174;4704.200285951328;4771.902462433591;4812.181929072066;4824.986752781955;4775.689580177277;4798.808047678054;4800.927986080212;4815.277708343777;4818.590419814355;5759.078547432391;5791.710414479259;5799.449052340021;5807.941920580824;5809.302883653904;7277.818054548678;7293.927060729325;7304.853902921912;7304.853902921912;7330.450216233804;1647.4645740134504;1709.829017098305;1712.9400470983705;1713.2804222226694;1714.9399771007954;1082.426314053553;1090.3948308688755;1095.0473088413132;1102.9283096598695;1106.67353130825;6977.267386924402;6995.965020174866;6998.335158160068;7003.824904377329;7016.403605693471;7676.923230767732;7694.153643099255;7708.537487750641;7719.343855772322;7741.380689544823;5979.9402005980255;6782.457403407716;6939.6877140528795;7006.75476358325;7034.030471467997;3216.6461689214166;3982.761034337891;4060.0864805419137;4072.3077076897;4094.897627559335;8059.597020148969;8070.071941726659;8072.919270807217;8093.838123237502;8097.797555061171;7780.961095194488;7999.520028798291;8019.318357939641;8020.919790802134;8079.313258372987;7990;7999.600019999093;8009.7997550060545;8049.356051515864;8053.798655033671;6210.3168651449205;6299.4487232670845;7632.923670763222;7706.653200606098;7722.652480638497;6446.709898054505;7327.340539351484;7432.368248698921;7575.356094732009;7676.270754278335;8101.432899696964;8120.472169308976;8122.83754324922;8144.267015968591;8180.059293181361;4764.618830493483;4795.520447955316;4801.95198048015;4816.831410900601;4825.951740482691;6544.920088185587;7147.999280100894;7169.856602868018;7726.690932362642;7757.185495522889;6543.345665433419;7423.331900129015;7423.740169094272;7431.182569917197;7459.179490256176;6862.691178896862;7414.55416193837;7428.182899880901;7429.257074292527;7463.3656139226605;6301.338359472189;7179.569225846466;7239.624471350427;7245.311695388929;7247;5998.460138587374;7387.335139837225;7403.14863790671;7405.074365704287;7418.629068546659;7064.717411303491;7250;7257.891131633135;7305.963470182615;7313.341799237881 16:51:04 INFO - 2015-11-18 16:51:04,234 DEBUG : BROWSER_OUTPUT: |5;yui.html;705.5519744961948;705.6295444891431;713.9107611548557;756.9280918312759;769.4921351907742;11981;15055.096694198355;15094.547163585083;15182;15186.696266074685;14110.506132285373;15684.76472852908;15947.282372293246;15994.84005159948;15998;732.8864026075967;911.1708345405699;916.8670542771295;919.9926080941359;920.6593560382635;733.5195446982209;911.0752586125088;922.3359181389422;926.1201858234704;926.536731634183;942.726609283307;960.9855852162189;964.778101036762;966.7051549277468;966.7776411425376;929.5677509957902;948.8861336639578;955.5986485676033;956.4691596164126;961.7932144588912;690.9619970901598;691.7647999680082;693.3482526425145;701.5124488480508;713.6182142553761;15004.549863504113;15073.321700523502;15153.696926061417;15261.38954441821;15343.07941523512;10233.232507561888;10341.431221282826;10364.119049880694;10367.63713270032;10887.401192934385;9632.566534505893;9749.807582739419;10024.699259022242;10067.496625168786;10491.108255798266;2764.3089227693076;3049.8932537361306;3137.294108825519;3153.7477001839798;3164.2089477630593;77720.61139694322;77789.61105194438;77993.61003195004;78141.43717125682;78968;7123.536970096927;7149.785506434815;7209.71161153548;7247.565146091251;7307.817304567428;12626.36868156607;12660.303683297507;12667.936660316824;12683.429245683781;12722.936385318015;5471.5896307777075;5778.335491418541;6337.207849018872;6453.709583068773;6621.86756264872;3870.3613903706137;3944.5069366329208;3964.1873415949663;3996.960030399659;4041.9595804041583;3056.938861222763;3067.1871953932227;3074;3080.553319768666;3083.722464978163;482.4283224379122;484.82303959055395;486.10313970723956;492.5517778821255;539.078176318492;512.229095211704;533.2188344075947;576.9221155144086;589.3929252869466;593.9635336338031;8243.711470098518;8608.139186081467;8665.653373865101;8816.25556449304;8936.731898043068;509.21834983300454;539.8812261302508;554.5092593055094;602.16299343912;616.6331033035336;3942.802859856996;4002.5797291284;4065.8780236592947;4138.813753381105;4165.625093741578;92409;93256;93965.53017235007;94204;98947;76367.85448218281;80434.79347809787;82892.58553707313;83512.58243708743;86310.70533941996;76490.23509764831;78770;79275.8108628371;79766.4046719074;80180.59909700415;7403.666834992546;8981.775455613662;9076.546172691471;9385.296102792454;9403.247740180906;49243.26135108048;49760.751196243786;54672;54852.99999999841;56110.71944640251;74214.62892685719;76001.47997039917;76997.61501192459;77564;78808.60595696984;7948.16544262844;8028.197180281925;8048.637811298388;8056.154103819014;8241.134680858424;12114.091443141975;12271.386430678609;12476.438560264629;12525.311107889154;12867.549635762703;11591.710207244549;12240.510379584717;12267;12452.377381131088;12469;9823.557939892578;10038.899611003797;10527.73680657959;12174.330411827434;12502;11299.43502824872;11471.885281147082;11777.941110294736;11813.586524471602;12340.938295308466;9826.312158148861;9863.457509837028;9916.157126644315;10003.199744020607;10749.301295415773;9088.454692718458;9176.174144327042;9532.904670953201;10135.797284054424;10213.489325533843 16:51:04 INFO - 2015-11-18 16:51:04,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,317 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894264219__endTimestamp 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5750.19 Median:5950.29 stddev:683.48 (11.5%) stddev-sans-first:649.74 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: Values: 2965.6 3463.3 3497.3 3536.5 3545.6 5773.0 5787.5 5798.9 5824.4 5864.8 5597.0 5685.4 5707.6 5721.1 5721.6 5171.5 5226.2 5239.2 5240.4 5376.4 4381.7 5361.2 5376.6 5402.8 5414.7 4823.9 4833.8 5124.7 5239.1 5459.4 5318.6 5319.9 5326.5 5328.2 5340.5 4994.4 5111.7 5293.7 5325.4 5366.6 4993.0 5164.7 5235.6 5725.7 5750.3 6252.2 6255.0 6301.3 6312.1 6332.5 6326.8 6340.1 6356.9 6357.9 6368.2 5657.7 5773.4 5782.8 5888.0 5901.3 6273.7 6321.2 6356.5 6373.8 6378.3 6067.8 6203.5 6276.1 6280.3 6309.3 6163.9 6247.4 6290.3 6330.2 6355.7 6248.4 6269.2 6307.6 6336.1 6347.1 5917.6 6060.4 6295.3 6337.9 6359.0 4952.9 4999.0 4999.6 5000.8 5033.7 4471.8 4475.2 4490.9 4536.5 4567.2 5639.6 5712.8 5750.9 5803.1 5829.3 6305.6 6319.2 6324.8 6328.8 6335.8 5805.2 5942.5 5945.1 5949.1 5993.1 4887.5 5121.8 5316.8 5459.9 5528.8 6263.4 6317.6 6335.4 6344.9 6356.3 6287.0 6306.2 6306.9 6319.2 6324.6 5340.9 6176.5 6319.3 6366.4 6387.9 6262.7 6300.0 6312.4 6316.7 6327.9 6327.7 6338.2 6367.6 6372.3 6382.1 4466.4 4990.0 5904.5 5927.8 6186.9 6113.7 6114.4 6122.1 6125.7 6127.5 4376.9 5950.3 5991.2 6004.5 6011.5 5472.3 6098.8 6139.2 6224.8 6250.3 6053.3 6126.7 6136.8 6142.4 6167.1 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,235 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:69944.86 Median:41576.69 stddev:148619.74 (357.5%) stddev-sans-first:148945.33 16:51:04 INFO - 2015-11-18 16:51:04,236 DEBUG : BROWSER_OUTPUT: Values: 551.3 560.4 570.5 578.7 610.5 41297.8 41381.4 41466.2 41628.4 41755.6 43280.0 43840.3 43936.8 44008.6 44015.0 9767.7 9843.2 9927.8 9959.5 9966.3 9705.1 9784.0 9803.5 9808.5 9846.1 9653.7 9735.5 9769.7 9783.9 9784.3 9635.4 9726.1 9729.4 9749.7 9754.7 9540.9 9701.4 9712.7 9721.0 9724.4 41418.8 41424.8 41453.0 41525.0 41753.0 3134.0 3167.5 3190.5 3246.2 3257.9 28765.0 29191.7 29325.6 29377.7 29565.2 2411.8 2507.8 2514.7 2572.1 2638.1 422375.0 505453.0 510221.0 511112.0 517680.0 60684.4 62299.0 63209.4 69655.7 69795.0 59791.0 75949.0 76903.6 77199.6 77653.4 16551.2 16614.3 16697.2 16812.6 16818.8 12468.1 12568.4 12569.9 12677.8 12678.9 22168.7 22183.9 22273.6 22525.9 22533.9 8094.3 9497.4 9740.5 9745.2 9746.5 937.0 944.3 958.9 1039.0 1111.0 30186.0 30240.5 30529.7 31004.2 31201.4 1053.3 1089.0 1162.4 1193.9 1246.4 15224.3 15276.7 15644.5 15726.0 16955.6 678921.4 683879.0 683938.0 684940.0 685006.0 50658.7 61354.7 62659.0 62857.0 62866.4 1450.7 1464.8 1481.8 1482.4 1484.4 28484.8 31402.9 31451.5 31566.0 32098.5 52614.5 52737.0 52761.7 53207.0 53551.2 462771.0 465864.7 466236.0 467620.0 474651.0 28709.6 29211.3 33000.0 45715.3 48936.5 47951.3 48329.5 49522.3 50061.0 50286.7 39682.2 39956.8 40290.0 40945.4 42806.0 39096.2 39477.0 39775.8 39929.0 40302.8 38711.6 39790.6 39943.0 40110.6 40117.8 34290.5 35531.6 35935.6 36044.9 36231.6 26429.7 26727.7 26886.9 27052.0 27095.0 16:51:04 INFO - 2015-11-18 16:51:04,236 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,236 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:36164.77 Median:2042.72 stddev:118080.91 (5780.6%) stddev-sans-first:118381.49 16:51:04 INFO - 2015-11-18 16:51:04,238 DEBUG : BROWSER_OUTPUT: Values: 328.3 359.2 364.1 364.6 366.6 15981.4 19929.7 20218.6 20993.9 21571.0 12361.9 14831.9 19364.0 19624.4 19847.5 4759.8 4871.4 4882.5 4889.6 4897.0 3718.8 3811.8 4860.5 5227.0 5360.1 5204.7 5241.1 5249.7 5256.2 5268.1 4267.6 5183.2 5193.2 5203.5 5225.8 4295.5 4373.8 4381.2 4392.8 4405.7 13952.2 14020.0 14217.1 14340.6 14380.0 1874.4 1908.8 1948.3 1950.7 2012.9 10223.6 10284.5 10311.8 10459.0 10566.0 1581.2 1653.9 1660.1 1680.8 1723.2 89433.0 93666.5 93734.0 93966.1 94555.0 6790.9 6875.3 6877.4 6952.4 6958.1 7788.4 7842.5 7848.3 7873.9 7885.9 4771.3 5730.0 5734.9 5788.5 5846.3 6167.8 6196.7 6197.8 6213.5 6235.2 3064.8 3066.5 3093.0 3109.6 3112.7 926.9 991.4 1098.5 1128.1 1131.9 343.9 425.3 441.8 450.1 451.8 10222.3 10463.8 10885.5 11729.3 12489.5 452.0 464.7 472.8 476.1 505.2 6601.0 6697.5 6739.8 6769.6 6774.9 622452.0 631975.0 644544.0 812832.0 830142.0 122745.0 125959.7 126129.1 127501.0 127785.0 519.5 530.4 534.2 535.2 537.4 11178.3 11549.9 11754.1 12014.9 12071.8 32828.8 52187.0 52648.7 53078.5 53250.2 74242.6 74973.6 75259.0 75888.0 76636.0 17034.3 17386.7 17617.2 17801.3 17811.6 11473.3 11798.7 21546.4 22135.3 22165.6 9965.4 10114.3 10175.5 10307.8 10318.9 8799.3 9901.0 10091.5 10186.3 10220.4 9891.4 10328.2 10338.9 10354.8 10478.1 16092.8 16383.6 16586.9 16785.5 17024.9 16550.8 16572.5 16723.2 17097.0 17129.8 16:51:04 INFO - 2015-11-18 16:51:04,238 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,238 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5472.39 Median:6086.92 stddev:2805.68 (46.1%) stddev-sans-first:2798.04 16:51:04 INFO - 2015-11-18 16:51:04,239 DEBUG : BROWSER_OUTPUT: Values: 1546.6 1584.8 1717.8 1852.9 1887.7 6691.4 7321.5 7980.2 8085.0 8102.6 7180.7 7859.5 7951.2 7957.7 7958.0 1985.5 2291.0 2333.1 2335.2 2341.8 2336.5 2363.3 2396.1 2410.1 2410.1 2319.5 2346.5 2377.0 2381.6 2382.5 2305.6 2313.8 2327.7 2332.3 2348.0 2182.4 2309.7 2381.4 2404.7 2410.7 7338.0 7487.4 8059.2 8065.7 8093.1 4197.7 4271.7 5029.1 5042.0 5044.8 2883.4 3366.0 3377.4 3458.6 3463.1 999.7 1018.9 1021.2 1026.1 1036.2 10352.8 10390.5 10391.9 10414.3 10422.7 4485.9 4540.5 4578.7 4625.0 4629.1 9062.0 9088.9 9089.5 9108.2 9126.6 5039.1 5050.9 5061.1 5064.2 5071.1 4067.4 4181.1 4542.4 4589.9 4648.5 3168.8 3700.1 3737.6 3847.1 3849.7 1287.8 1297.0 1300.4 1301.3 1317.6 1028.5 1050.0 1054.9 1216.5 1400.3 7395.1 7438.5 7483.5 7487.7 7517.5 495.5 496.6 498.9 501.7 506.3 5916.7 5970.9 5986.1 5989.0 6062.9 9076.3 9404.4 9444.6 9478.9 9489.6 9234.5 9337.3 9339.3 9353.1 9438.0 6111.0 6636.7 7197.8 7297.4 7397.1 6398.7 6841.9 7089.4 7148.8 7158.0 8247.5 8412.7 8433.5 8546.7 8557.2 8533.2 8724.4 8735.8 8757.3 8839.0 5707.4 6222.6 6380.9 6935.7 6967.3 6267.8 7573.1 7619.5 7620.7 7642.3 6991.3 7071.4 7097.4 7150.7 7242.0 6829.9 7021.4 7031.5 7032.8 7161.5 6818.8 7122.4 7146.6 7198.4 7205.9 6555.6 6588.5 6589.5 6594.6 6607.2 5649.3 6541.9 6631.4 6635.5 6706.8 16:51:04 INFO - 2015-11-18 16:51:04,239 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,239 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5985.07 Median:6735.48 stddev:1956.65 (29.0%) stddev-sans-first:1914.95 16:51:04 INFO - 2015-11-18 16:51:04,240 DEBUG : BROWSER_OUTPUT: Values: 294.3 318.4 322.4 332.6 335.2 5315.7 6770.6 6902.6 6959.2 7015.5 6700.4 6877.2 6900.6 6907.4 6923.7 5164.6 5168.6 5176.5 5178.8 5185.3 4825.7 5150.5 5154.0 5176.8 5187.0 4993.4 5028.7 5052.8 5053.2 5054.3 5032.3 5035.0 5036.8 5037.7 5039.3 3611.0 3816.4 4015.2 4113.0 4255.3 6605.2 6608.8 6662.3 6669.9 6692.3 5849.2 5932.9 5936.8 5939.9 5941.4 5903.8 7103.3 7319.9 7385.9 7389.1 4692.4 4707.7 4738.8 4741.9 4742.1 7764.8 7818.3 7855.1 7861.0 7879.0 3529.1 4704.2 4771.9 4812.2 4825.0 4775.7 4798.8 4800.9 4815.3 4818.6 5759.1 5791.7 5799.4 5807.9 5809.3 7277.8 7293.9 7304.9 7304.9 7330.5 1647.5 1709.8 1712.9 1713.3 1714.9 1082.4 1090.4 1095.0 1102.9 1106.7 6977.3 6996.0 6998.3 7003.8 7016.4 7676.9 7694.2 7708.5 7719.3 7741.4 5979.9 6782.5 6939.7 7006.8 7034.0 3216.6 3982.8 4060.1 4072.3 4094.9 8059.6 8070.1 8072.9 8093.8 8097.8 7781.0 7999.5 8019.3 8020.9 8079.3 7990.0 7999.6 8009.8 8049.4 8053.8 6210.3 6299.4 7632.9 7706.7 7722.7 6446.7 7327.3 7432.4 7575.4 7676.3 8101.4 8120.5 8122.8 8144.3 8180.1 4764.6 4795.5 4802.0 4816.8 4826.0 6544.9 7148.0 7169.9 7726.7 7757.2 6543.3 7423.3 7423.7 7431.2 7459.2 6862.7 7414.6 7428.2 7429.3 7463.4 6301.3 7179.6 7239.6 7245.3 7247.0 5998.5 7387.3 7403.1 7405.1 7418.6 7064.7 7250.0 7257.9 7306.0 7313.3 16:51:04 INFO - 2015-11-18 16:51:04,241 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,241 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18565.03 Median:598.06 stddev:27187.82 (4546.0%) stddev-sans-first:27231.02 16:51:04 INFO - 2015-11-18 16:51:04,241 DEBUG : BROWSER_OUTPUT: Values: 705.6 705.6 713.9 756.9 769.5 11981.0 15055.1 15094.5 15182.0 15186.7 14110.5 15684.8 15947.3 15994.8 15998.0 732.9 911.2 916.9 920.0 920.7 733.5 911.1 922.3 926.1 926.5 942.7 961.0 964.8 966.7 966.8 929.6 948.9 955.6 956.5 961.8 691.0 691.8 693.3 701.5 713.6 15004.5 15073.3 15153.7 15261.4 15343.1 10233.2 10341.4 10364.1 10367.6 10887.4 9632.6 9749.8 10024.7 10067.5 10491.1 2764.3 3049.9 3137.3 3153.7 3164.2 77720.6 77789.6 77993.6 78141.4 78968.0 7123.5 7149.8 7209.7 7247.6 7307.8 12626.4 12660.3 12667.9 12683.4 12722.9 5471.6 5778.3 6337.2 6453.7 6621.9 3870.4 3944.5 3964.2 3997.0 4042.0 3056.9 3067.2 3074.0 3080.6 3083.7 482.4 484.8 486.1 492.6 539.1 512.2 533.2 576.9 589.4 594.0 8243.7 8608.1 8665.7 8816.3 8936.7 509.2 539.9 554.5 602.2 616.6 3942.8 4002.6 4065.9 4138.8 4165.6 92409.0 93256.0 93965.5 94204.0 98947.0 76367.9 80434.8 82892.6 83512.6 86310.7 76490.2 78770.0 79275.8 79766.4 80180.6 7403.7 8981.8 9076.5 9385.3 9403.2 49243.3 49760.8 54672.0 54853.0 56110.7 74214.6 76001.5 76997.6 77564.0 78808.6 7948.2 8028.2 8048.6 8056.2 8241.1 12114.1 12271.4 12476.4 12525.3 12867.5 11591.7 12240.5 12267.0 12452.4 12469.0 9823.6 10038.9 10527.7 12174.3 12502.0 11299.4 11471.9 11777.9 11813.6 12340.9 9826.3 9863.5 9916.2 10003.2 10749.3 9088.5 9176.2 9532.9 10135.8 10213.5 16:51:04 INFO - 2015-11-18 16:51:04,241 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:51:04 INFO - 2015-11-18 16:51:04,241 DEBUG : BROWSER_OUTPUT: 16:51:04 INFO - 2015-11-18 16:51:04,644 INFO : Browser exited with error code: 0 16:51:04 INFO - 2015-11-18 16:51:04,669 INFO : Completed test dromaeo_css (00:18:29) 16:51:04 INFO - 2015-11-18 16:51:04,669 INFO : Starting test kraken 16:51:04 INFO - 2015-11-18 16:51:04,669 DEBUG : operating with platform_type : mac_ 16:51:04 INFO - 2015-11-18 16:51:04,669 INFO : Initialising browser for kraken test... 16:51:04 INFO - 2015-11-18 16:51:04,681 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpaoWLHv/profile http://localhost:49708/getInfo.html 16:51:07 INFO - 2015-11-18 16:51:07,132 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:51:07 INFO - 2015-11-18 16:51:07,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:51:07 INFO - 2015-11-18 16:51:07,133 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:51:07 INFO - 2015-11-18 16:51:07,133 DEBUG : BROWSER_OUTPUT: __metrics 16:51:07 INFO - 2015-11-18 16:51:07,866 INFO : Browser initialized. 16:51:07 INFO - 2015-11-18 16:51:07,866 INFO : Running cycle 1/1 for kraken test... 16:51:07 INFO - 2015-11-18 16:51:07,866 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpaoWLHv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:51:19 INFO - 2015-11-18 16:51:19,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 237072384 16:51:19 INFO - 2015-11-18 16:51:19,870 DEBUG : BROWSER_OUTPUT: 16:51:22 INFO - 2015-11-18 16:51:22,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:23 INFO - 2015-11-18 16:51:23,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 248614912 16:51:23 INFO - 2015-11-18 16:51:23,035 DEBUG : BROWSER_OUTPUT: 16:51:25 INFO - 2015-11-18 16:51:25,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-dft) 16:51:26 INFO - 2015-11-18 16:51:26,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 259080192 16:51:26 INFO - 2015-11-18 16:51:26,361 DEBUG : BROWSER_OUTPUT: 16:51:29 INFO - 2015-11-18 16:51:29,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-fft) 16:51:30 INFO - 2015-11-18 16:51:30,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 260960256 16:51:30 INFO - 2015-11-18 16:51:30,312 DEBUG : BROWSER_OUTPUT: 16:51:32 INFO - 2015-11-18 16:51:32,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator) 16:51:32 INFO - 2015-11-18 16:51:32,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 262348800 16:51:32 INFO - 2015-11-18 16:51:32,886 DEBUG : BROWSER_OUTPUT: 16:51:35 INFO - 2015-11-18 16:51:35,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:35 INFO - 2015-11-18 16:51:35,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 264482816 16:51:35 INFO - 2015-11-18 16:51:35,582 DEBUG : BROWSER_OUTPUT: 16:51:38 INFO - 2015-11-18 16:51:38,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:38 INFO - 2015-11-18 16:51:38,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 263143424 16:51:38 INFO - 2015-11-18 16:51:38,923 DEBUG : BROWSER_OUTPUT: 16:51:41 INFO - 2015-11-18 16:51:41,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:42 INFO - 2015-11-18 16:51:42,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 263065600 16:51:42 INFO - 2015-11-18 16:51:42,461 DEBUG : BROWSER_OUTPUT: 16:51:45 INFO - 2015-11-18 16:51:45,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial) 16:51:45 INFO - 2015-11-18 16:51:45,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 263135232 16:51:45 INFO - 2015-11-18 16:51:45,749 DEBUG : BROWSER_OUTPUT: 16:51:47 INFO - 2015-11-18 16:51:47,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:47 INFO - 2015-11-18 16:51:47,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 264986624 16:51:47 INFO - 2015-11-18 16:51:47,870 DEBUG : BROWSER_OUTPUT: 16:51:49 INFO - 2015-11-18 16:51:49,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:50 INFO - 2015-11-18 16:51:50,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 264458240 16:51:50 INFO - 2015-11-18 16:51:50,251 DEBUG : BROWSER_OUTPUT: 16:51:52 INFO - 2015-11-18 16:51:52,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:52 INFO - 2015-11-18 16:51:52,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 264593408 16:51:52 INFO - 2015-11-18 16:51:52,978 DEBUG : BROWSER_OUTPUT: 16:51:55 INFO - 2015-11-18 16:51:55,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:56 INFO - 2015-11-18 16:51:56,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 264273920 16:51:56 INFO - 2015-11-18 16:51:56,199 DEBUG : BROWSER_OUTPUT: 16:51:58 INFO - 2015-11-18 16:51:58,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:59 INFO - 2015-11-18 16:51:59,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 265142272 16:51:59 INFO - 2015-11-18 16:51:59,281 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49708/tests/kraken/driver.html?testName=ai-astar) 16:52:01 INFO - 2015-11-18 16:52:01,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 265166848 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;115;115;115;130;116;116;117;116 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;131;145;169;152;147;167;121;196;141 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |2;audio-dft;189;197;195;196;205;224;225;273;247;198 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |3;audio-fft;63;62;70;107;57;64;86;85;142;81 16:52:01 INFO - 2015-11-18 16:52:01,297 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;79;113;75;79;62;125;111;115;130 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;87;87;87;99;132;87;88;88;93 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;116;95;153;154;95;95;96;95;95;95 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;92;90;90;93;92;92;90;94;93 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;60;59;60;61;61;68;60;59 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;67;65;68;67;68;68;69;69 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;97;108;112;111;84;83;85;84;87;85 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;136;146;104;146;134;113;127;150;134 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;168;170;137;134;139;141;139;139;128 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;68;70;83;86;89;76;83;90 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,810 16:52:01 INFO - 2015-11-18 16:52:01,298 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894321290__endTimestamp 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.40 Median:116.00 stddev:5.40 (4.7%) stddev-sans-first:5.73 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 115.0 115.0 115.0 130.0 116.0 116.0 117.0 116.0 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:151.50 stddev:21.21 (14.0%) stddev-sans-first:22.49 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: Values: 151.0 131.0 145.0 169.0 152.0 147.0 167.0 121.0 196.0 141.0 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:214.90 Median:214.50 stddev:27.32 (12.7%) stddev-sans-first:27.33 16:52:01 INFO - 2015-11-18 16:52:01,299 DEBUG : BROWSER_OUTPUT: Values: 189.0 197.0 195.0 196.0 205.0 224.0 225.0 273.0 247.0 198.0 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:67.00 stddev:26.04 (38.9%) stddev-sans-first:26.73 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 70.0 107.0 57.0 64.0 86.0 85.0 142.0 81.0 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:99.60 Median:96.00 stddev:23.66 (24.6%) stddev-sans-first:24.94 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: Values: 107.0 79.0 113.0 75.0 79.0 62.0 125.0 111.0 115.0 130.0 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:87.50 stddev:14.14 (16.2%) stddev-sans-first:14.74 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 87.0 87.0 99.0 132.0 87.0 88.0 88.0 93.0 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:108.90 Median:95.00 stddev:24.39 (25.7%) stddev-sans-first:25.74 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: Values: 116.0 95.0 153.0 154.0 95.0 95.0 96.0 95.0 95.0 95.0 16:52:01 INFO - 2015-11-18 16:52:01,300 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:91.90 Median:92.50 stddev:1.45 (1.6%) stddev-sans-first:1.48 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 90.0 90.0 93.0 92.0 92.0 90.0 94.0 93.0 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.50 stddev:2.60 (4.3%) stddev-sans-first:2.76 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 60.0 59.0 60.0 61.0 61.0 68.0 60.0 59.0 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.50 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 65.0 68.0 67.0 68.0 68.0 69.0 69.0 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:84.50 stddev:12.24 (14.5%) stddev-sans-first:12.92 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: Values: 97.0 108.0 112.0 111.0 84.0 83.0 85.0 84.0 87.0 85.0 16:52:01 INFO - 2015-11-18 16:52:01,301 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:135.00 stddev:14.60 (10.8%) stddev-sans-first:15.45 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: Values: 129.0 136.0 146.0 104.0 146.0 134.0 113.0 127.0 150.0 134.0 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:139.00 stddev:14.08 (10.1%) stddev-sans-first:14.75 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: Values: 137.0 168.0 170.0 137.0 134.0 139.0 141.0 139.0 139.0 128.0 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:83.00 stddev:9.63 (11.6%) stddev-sans-first:9.23 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 68.0 70.0 83.0 86.0 89.0 76.0 83.0 90.0 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:52:01 INFO - 2015-11-18 16:52:01,302 DEBUG : BROWSER_OUTPUT: 16:52:01 INFO - 2015-11-18 16:52:01,929 INFO : Browser exited with error code: 0 16:52:01 INFO - 2015-11-18 16:52:01,975 INFO : Completed test kraken (00:00:57) 16:52:01 INFO - 2015-11-18 16:52:01,975 INFO : Starting test v8_7 16:52:01 INFO - 2015-11-18 16:52:01,975 DEBUG : operating with platform_type : mac_ 16:52:01 INFO - 2015-11-18 16:52:01,975 INFO : Initialising browser for v8_7 test... 16:52:01 INFO - 2015-11-18 16:52:01,988 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpV42GOv/profile http://localhost:49708/getInfo.html 16:52:04 INFO - 2015-11-18 16:52:04,401 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:52:04 INFO - 2015-11-18 16:52:04,401 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:52:04 INFO - 2015-11-18 16:52:04,401 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:52:04 INFO - 2015-11-18 16:52:04,401 DEBUG : BROWSER_OUTPUT: __metrics 16:52:05 INFO - 2015-11-18 16:52:05,007 INFO : Browser initialized. 16:52:05 INFO - 2015-11-18 16:52:05,007 INFO : Running cycle 1/1 for v8_7 test... 16:52:05 INFO - 2015-11-18 16:52:05,007 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpV42GOv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:52:16 INFO - 2015-11-18 16:52:16,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 237252608 16:52:16 INFO - 2015-11-18 16:52:16,852 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,281 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49708/tests/v8_7/run.html (next: http://localhost:49708/tests/v8_7/run.html) 16:52:38 INFO - 2015-11-18 16:52:38,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 247439360 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |0;Richards;633.7135614702155 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.2079861656972 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.4389192296637 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4758.293838862559 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |4;RayTrace;962.4639076034649 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |5;Earley;743.4944237918215 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |6;Boyer;12575 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 16:52:38 INFO - 2015-11-18 16:52:38,538 DEBUG : BROWSER_OUTPUT: |8;Splay;634.5177664974619 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4524.886877828054 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: __startTimestamp1447894358532__endTimestamp 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:633.71 Median:633.71 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: Values: 633.7 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.21 Median:157.21 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: Values: 157.2 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,539 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.44 Median:287.44 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: Values: 287.4 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4758.29 Median:4758.29 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: Values: 4758.3 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: Values: 962.5 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:743.49 Median:743.49 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: Values: 743.5 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12575.00 Median:12575.00 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: Values: 12575.0 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,540 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: Values: 26763.2 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:634.52 Median:634.52 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: Values: 634.5 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4524.89 Median:4524.89 stddev:0.00 (0.0%) 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: Values: 4524.9 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:52:38 INFO - 2015-11-18 16:52:38,541 DEBUG : BROWSER_OUTPUT: 16:52:39 INFO - 2015-11-18 16:52:39,133 INFO : Browser exited with error code: 0 16:52:39 INFO - 2015-11-18 16:52:39,151 INFO : Completed test v8_7 (00:00:37) 16:52:39 INFO - 2015-11-18 16:52:39,583 INFO : Completed test suite (00:20:03) 16:52:39 INFO - 2015-11-18 16:52:39,584 DEBUG : Working with test: dromaeo_css 16:52:39 INFO - 2015-11-18 16:52:39,584 DEBUG : Generating results file: dromaeo_css 16:52:39 INFO - 2015-11-18 16:52:39,585 DEBUG : Working with test: kraken 16:52:39 INFO - 2015-11-18 16:52:39,585 DEBUG : Generating results file: kraken 16:52:39 INFO - 2015-11-18 16:52:39,585 INFO : javascript benchmark 16:52:39 INFO - 2015-11-18 16:52:39,585 DEBUG : Working with test: v8_7 16:52:39 INFO - 2015-11-18 16:52:39,585 DEBUG : Generating results file: v8_7 16:52:39 INFO - 2015-11-18 16:52:39,585 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:39 INFO - 2015-11-18 16:52:39,639 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 16:52:39 INFO - 2015-11-18 16:52:39,639 DEBUG : process_Request line: dromaeo_css 7273.83 graph.html#tests=[[72,64,61]] 16:52:39 INFO - 2015-11-18 16:52:39,639 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:39 INFO - 2015-11-18 16:52:39,665 DEBUG : process_Request line: kraken 1533.30 graph.html#tests=[[232,64,61]] 16:52:39 INFO - 2015-11-18 16:52:39,665 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:52:39 INFO - 2015-11-18 16:52:39,694 DEBUG : process_Request line: v8_7 19159.88 graph.html#tests=[[230,64,61]] 16:52:39 INFO - 2015-11-18 16:52:39,695 INFO : javascript benchmark 16:52:39 INFO - 2015-11-18 16:52:39,697 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2965.5848181254614, 3463.255400088981, 3497.318022985519, 3536.5225694531264, 3545.5922568904566, 5772.9999999999945, 5787.47912687858, 5798.855028624276, 5824.359320474744, 5864.794732184374, 5597.0, 5685.431456854323, 5707.6290041147295, 5721.084626459768, 5721.599488035839, 5171.482851714817, 5226.24219488173, 5239.187925871496, 5240.44975277596, 5376.38171610264, 4381.693281470282, 5361.249425080492, 5376.569874410057, 5402.78388864445, 5414.702191379472, 4823.9035219295765, 4833.806647734086, 5124.743762811844, 5239.056969745444, 5459.3994660587305, 5318.574514038867, 5319.936012797456, 5326.547243484309, 5328.227407025959, 5340.49265319794, 4994.400671919357, 5111.693298402108, 5293.682379057269, 5325.360956685184, 5366.577856867933, 4992.950070499285, 5164.664296820694, 5235.6073294502685, 5725.742341594639, 5750.338711048241, 6252.18721566198, 6254.9650460756675, 6301.338359472281, 6312.053192021188, 6332.4934005279465, 6326.778562750328, 6340.112384266206, 6356.872862542723, 6357.872842543124, 6368.172137622126, 5657.688827114507, 5773.364929857712, 5782.768689252425, 5888.0, 5901.262342207224, 6273.686315684197, 6321.209848768904, 6356.491480681534, 6373.776917807947, 6378.298387177407, 6067.75728970845, 6203.47270482005, 6276.089966954857, 6280.2777680566405, 6309.33751956038, 6163.9383606164265, 6247.406496382836, 6290.308066112724, 6330.177076980055, 6355.682215889279, 6248.375162483806, 6269.247690277196, 6307.558470906993, 6336.081268216083, 6347.079673447417, 5917.615355001911, 6060.424259695322, 6295.338989406138, 6337.8732425352155, 6358.982562789932, 4952.876178095505, 4998.950010499849, 4999.575036121898, 5000.799968001312, 5033.672811267256, 4471.821127154943, 4475.239209334421, 4490.865274041784, 4536.546345365503, 4567.19595759673, 5639.605227634026, 5712.771489140471, 5750.856228594235, 5803.071508558694, 5829.271341082364, 6305.621662700252, 6319.24169099711, 6324.841878952971, 6328.778492752824, 6335.841603959846, 5805.245318108703, 5942.524598032147, 5945.078512830518, 5949.137375080589, 5993.130996005555, 4887.511248875084, 5121.820736274212, 5316.787328506816, 5459.863503412367, 5528.806491772769, 6263.404976527223, 6317.557770955989, 6335.3981371769605, 6344.904826427607, 6356.300806911236, 6287.0, 6306.243250809932, 6306.905396418965, 6319.24169099711, 6324.557280990287, 5340.866478338073, 6176.536759743127, 6319.336469670802, 6366.395192456709, 6387.904181437189, 6262.749490020348, 6299.96850015747, 6312.400321969406, 6316.715747791269, 6327.936720632735, 6327.746890124344, 6338.207724034496, 6367.649779262185, 6372.330905254881, 6382.138411314413, 4466.352378904976, 4989.950100499093, 5904.527637789052, 5927.762889484372, 6186.876262474635, 6113.694315284307, 6114.449699527064, 6122.112293717297, 6125.724342404692, 6127.479164271087, 4376.9124617508105, 5950.285965683973, 5991.221141251609, 6004.459598635969, 6011.489023433057, 5472.288602481811, 6098.817035488943, 6139.201903752483, 6224.751009959551, 6250.312465628868, 6053.334133245251, 6126.693665316806, 6136.754529818757, 6142.416470435302, 6167.074938759042], "unit": "ms", "name": "dojo.html", "value": 5707.886821549376}, {"lowerIsBetter": false, "replicates": [551.250299592554, 560.39459509075, 570.500811789684, 578.6528083150108, 610.5115907274181, 41297.79351103244, 41381.37927931084, 41466.17067658645, 41628.37557436641, 41755.58244417555, 43280.0, 43840.3423948641, 43936.780316098455, 44008.559914400845, 44015.0, 9767.658131965383, 9843.163331116864, 9927.751806204866, 9959.502024898762, 9966.252531060163, 9705.126538611523, 9784.0, 9803.509824508781, 9808.50957452128, 9846.080014397196, 9653.71038868835, 9735.51322433879, 9769.658061967833, 9783.902160978407, 9784.315097943147, 9635.373700709431, 9726.076022777825, 9729.416235025885, 9749.658761943298, 9754.658586949457, 9540.856887146698, 9701.369410988264, 9712.660056897974, 9721.0, 9724.367916085432, 41418.792906035276, 41424.79287603573, 41453.0, 41525.0, 41753.0, 3133.9529907051415, 3167.5090360993854, 3190.5054716518976, 3246.172226082334, 3257.8933219161213, 28765.0, 29191.686374113215, 29325.560116598055, 29377.706222937926, 29565.191306825818, 2411.770881766229, 2507.8119141064312, 2514.673092497982, 2572.1383336582267, 2638.0503018913178, 422375.0, 505453.0, 510221.0, 511112.0, 517680.0, 60684.393156068756, 62299.0, 63209.36790632127, 69655.65172174107, 69795.0, 59791.0, 75949.0, 76903.61548192223, 77199.61400192963, 77653.44693106106, 16551.172441377883, 16614.25235864389, 16697.248623811956, 16812.579685507717, 16818.831811681972, 12468.127231093737, 12568.434420451102, 12569.93715031419, 12677.809832852514, 12678.936605316914, 22168.672289409704, 22183.889080554494, 22273.55452890933, 22525.88737056337, 22533.88733056324, 8094.345751193087, 9497.382670126419, 9740.46427446483, 9745.220382369393, 9746.512674366253, 936.9672061477816, 944.3436811416137, 958.9328746987784, 1038.984415233772, 1110.9777804443866, 30186.0, 30240.546391804142, 30529.69470305313, 31004.22489437782, 31201.375972480422, 1053.262716098734, 1088.983665245022, 1162.412981444382, 1193.9223950443193, 1246.3643541793751, 15224.314905829264, 15276.694466110837, 15644.452444164399, 15726.0, 16955.57611059709, 678921.4485348171, 683879.0, 683938.0, 684940.0, 685006.0, 50658.74670626623, 61354.69322653358, 62659.0, 62857.0, 62866.37133628605, 1450.6808502129516, 1464.8168978877854, 1481.7925490431348, 1482.384810303712, 1484.4359143525392, 28484.776166895273, 31402.900898468444, 31451.52822707707, 31566.0, 32098.51852222172, 52614.473855260956, 52737.0, 52761.7361913188, 53207.0, 53551.19673204983, 462771.0, 465864.6706766444, 466236.0, 467620.0, 474651.0, 28709.56935645925, 29211.269718257212, 33000.0, 45715.31427028664, 48936.510634893195, 47951.28073078837, 48329.5167048325, 49522.25716614326, 50061.0, 50286.74856625694, 39682.20635587214, 39956.801295961166, 40290.0, 40945.38581921214, 42806.0, 39096.2180756389, 39477.0, 39775.80112099421, 39929.0, 40302.798486007385, 38711.6128838708, 39790.60209397869, 39943.00142496461, 40110.59889401068, 40117.79941100276, 34290.48564271488, 35531.644683553866, 35935.64064359428, 36044.91865244047, 36231.63768362282, 26429.7357026435, 26727.732722672525, 26886.865565672048, 27051.9599811327, 27095.0], "unit": "ms", "name": "ext.html", "value": 20783.923484263523}, {"lowerIsBetter": false, "replicates": [328.2925295987148, 359.16852486493764, 364.0806962419888, 364.60258318432903, 366.6480179028133, 15981.360745570164, 19929.701054484176, 20218.59562808743, 20993.895030524844, 21571.029303681335, 12361.876381236185, 14831.851681483182, 19363.966783487744, 19624.41126766199, 19847.503812404662, 4759.809607615691, 4871.4154301483695, 4882.487338829407, 4889.633277504184, 4897.0, 3718.7954662493553, 3811.790351530665, 4860.538248866352, 5226.999999999981, 5360.142377219646, 5204.661696989702, 5241.135212689902, 5249.658772179815, 5256.237845512398, 5268.104422248208, 4267.637250833683, 5183.222516622499, 5193.169092945149, 5203.505666961632, 5225.79096836128, 4295.506016808075, 4373.781310934441, 4381.18947994622, 4392.758398288093, 4405.735655860659, 13952.16287022782, 14020.018598698096, 14217.075890067112, 14340.56978290653, 14380.0, 1874.4470381237568, 1908.8377487913544, 1948.3083505355678, 1950.6781381072105, 2012.909419076145, 10223.591056357736, 10284.537195826206, 10311.793764124675, 10459.006394392596, 10566.049055584957, 1581.2172974377643, 1653.875959303057, 1660.0703605980568, 1680.7983042035034, 1723.2159367487764, 89433.0, 93666.53166734123, 93734.0, 93966.06033939641, 94555.0, 6790.8641827164165, 6875.346842049998, 6877.415419689282, 6952.443804495628, 6958.060661810692, 7788.376929845599, 7842.490238134503, 7848.254415830487, 7873.881891771628, 7885.881711774328, 4771.260454629469, 5730.0, 5734.856628584235, 5788.450097240755, 5846.327672317653, 6167.784127555514, 6196.721147548371, 6197.845053873599, 6213.471854892295, 6235.189425374672, 3064.7548196144253, 3066.47869862124, 3093.0256969054676, 3109.595752552199, 3112.673169317234, 926.9073092690812, 991.3655260633201, 1098.4617537406614, 1128.1031579894004, 1131.9490622921824, 343.90370696205105, 425.34284530400606, 441.8115269923894, 450.1492179780218, 451.80120746871273, 10222.284440089123, 10463.790724185474, 10885.510152043176, 11729.296242225322, 12489.50041998328, 451.9604908709954, 464.6863367227108, 472.79433446450906, 476.07166026248956, 505.1841276338687, 6601.0, 6697.531172817856, 6739.797806065826, 6769.559978601375, 6774.932250677529, 622452.0, 631975.0, 644544.0, 812832.0, 830142.0, 122745.0, 125959.74040259664, 126129.10806337913, 127501.0, 127785.0, 519.5220397234554, 530.3794560364383, 534.2013689534093, 535.1811728056081, 537.3766430940091, 11178.27341222818, 11549.88450115488, 11754.05967522579, 12014.939925300318, 12071.818922715991, 32828.835855820565, 52187.0, 52648.73675631597, 53078.4692153089, 53250.20124698055, 74242.62878685573, 74973.625131874, 75259.0, 75888.0, 76636.0, 17034.318627254772, 17386.652266954843, 17617.207225674618, 17801.287948482433, 17811.554711132325, 11473.254238474472, 11798.705032374259, 21546.353609391743, 22135.335939921828, 22165.556688866454, 9965.40207587547, 10114.342567733074, 10175.542100605639, 10307.793844123225, 10318.948405257926, 8799.34004949644, 9900.950495247478, 10091.495425228855, 10186.286959912735, 10220.386776793417, 9891.35706179096, 10328.173746100143, 10338.948305258426, 10354.844677329695, 10478.056974872297, 16092.758608620647, 16383.59041023984, 16586.917065414596, 16785.496435106965, 17024.914875425544, 16550.841441099008, 16572.50282491527, 16723.247453864362, 17097.0, 17129.828701712824], "unit": "ms", "name": "jquery.html", "value": 7925.651959099854}, {"lowerIsBetter": false, "replicates": [1546.5824227458586, 1584.8335924727903, 1717.8110407855133, 1852.9253033240723, 1887.7357169996194, 6691.397774200321, 7321.524100933449, 7980.2019798020165, 8084.959575202123, 8102.594870256486, 7180.67686954087, 7859.489133206352, 7951.165127661599, 7957.681692732298, 7957.960210198941, 1985.4837742186992, 2290.977090229093, 2333.0667732906804, 2335.2060299498166, 2341.8243631727687, 2336.4742932840145, 2363.291012696193, 2396.0535588442553, 2410.1203060882826, 2410.1323523531514, 2319.5476882008015, 2346.4837735698206, 2377.037299893546, 2381.6427535869584, 2382.5354055959097, 2305.5734689082574, 2313.7570555091643, 2327.650852372141, 2332.3469428559947, 2348.0, 2182.3562049195366, 2309.734380546242, 2381.404648837791, 2404.651325557802, 2410.6745589345387, 7338.0, 7487.363574096208, 8059.194080591952, 8065.717699880476, 8093.069297030858, 4197.727147735387, 4271.722338048017, 5029.1450453423, 5041.991601679642, 5044.848654540369, 2883.408901175254, 3365.9831700841582, 3377.4427219508752, 3458.6368431314854, 3463.0649724574223, 999.6751055906786, 1018.9235807314407, 1021.1932573267185, 1026.1021606094666, 1036.1917704190744, 10352.792944141074, 10390.532426040847, 10391.896081039244, 10414.27100102993, 10422.739431514197, 4485.887852803641, 4540.523245059221, 4578.702384345073, 4624.9768751156025, 4629.120467111238, 9061.954690226507, 9088.909110908939, 9089.50007749567, 9108.225800807006, 9126.634934602542, 5039.067772462033, 5050.949490505048, 5061.139606266944, 5064.164412871909, 5071.137906555894, 4067.3695577185586, 4181.121964387452, 4542.364069030338, 4589.908201835945, 4648.48866624671, 3168.8098714077228, 3700.111973126484, 3737.5514938207043, 3847.0574709196426, 3849.6920246380223, 1287.845458544962, 1296.9818692326478, 1300.3758196065942, 1301.3298151452009, 1317.5783749200164, 1028.5165971993301, 1050.0077426831572, 1054.926155169146, 1216.4525963316544, 1400.2998500749625, 7395.075615548057, 7438.516496427715, 7483.513571617827, 7487.700491980259, 7517.548947063194, 495.49459551258235, 496.55558275343367, 498.8827625508003, 501.66889852697045, 506.29624821498146, 5916.674582897896, 5970.910436343458, 5986.102084687332, 5989.0, 6062.878742425127, 9076.319276054322, 9404.38871473352, 9444.574994125282, 9478.857817132748, 9489.572969216402, 9234.492102934402, 9337.253019758404, 9339.299552533586, 9353.064693530592, 9438.0, 6110.969445152746, 6636.668166591651, 7197.812360960383, 7297.379722723628, 7397.112346518452, 6398.680065996588, 6841.905295152752, 7089.36195742365, 7148.821279468055, 7158.0, 8247.505149691038, 8412.663493460193, 8433.451825631315, 8546.700865469678, 8557.229849313591, 8533.232009119209, 8724.43291186071, 8735.825283494421, 8757.343199259954, 8839.0, 5707.400722924033, 6222.564420490522, 6380.9361906380345, 6935.7225710971, 6967.268436814062, 6267.811965641038, 7573.091229052549, 7619.542827430372, 7620.69517219305, 7642.312191902755, 6991.300869912968, 7071.434285257064, 7097.361237488651, 7150.713971441084, 7241.963790181016, 6829.89755153683, 7021.368076873106, 7031.542949708252, 7032.753853615303, 7161.4628902831455, 6818.829529261808, 7122.430205583644, 7146.606936618536, 7198.352148306678, 7205.891911621435, 6555.639439830855, 6588.538802283986, 6589.5387322888855, 6594.637294948632, 6607.240167380621, 5649.293838270216, 6541.8691626166255, 6631.436327912182, 6635.5355125142705, 6706.83232919181], "unit": "ms", "name": "mootools.html", "value": 4454.607032730547}, {"lowerIsBetter": false, "replicates": [294.2951630844128, 318.44590412681936, 322.43251876697013, 332.62579597952305, 335.15373681454327, 5315.681059136445, 6770.593764374141, 6902.551334163282, 6959.234484206733, 7015.543989640682, 6700.363465470772, 6877.209120951092, 6900.6204658743745, 6907.378335949764, 6923.723051077964, 5164.561012313958, 5168.586513078944, 5176.482351764831, 5178.792848286064, 5185.274061631356, 4825.710457372551, 5150.536451719345, 5153.974230128844, 5176.7929282828645, 5186.988537235241, 4993.425756038066, 5028.6982781033075, 5052.823151189709, 5053.166227572447, 5054.3176671149295, 5032.345795046639, 5035.0, 5036.84889453317, 5037.748112594392, 5039.344885164942, 3610.9708733010966, 3816.370298900678, 4015.217032678629, 4113.0, 4255.255330317213, 6605.207375114969, 6608.768693095719, 6662.300458451841, 6669.899951500732, 6692.263850976388, 5849.186752106861, 5932.851678708067, 5936.762529498815, 5939.940600593982, 5941.405859414067, 5903.763849446017, 7103.289671032855, 7319.890201646979, 7385.9261407385775, 7389.113306403212, 4692.436907571079, 4707.71753694776, 4738.8341408050555, 4741.881452963669, 4742.146413645542, 7764.805879852993, 7818.33544148748, 7855.096663883669, 7861.0, 7878.975733154711, 3529.0942890839174, 4704.200285951328, 4771.902462433591, 4812.181929072066, 4824.986752781955, 4775.689580177277, 4798.808047678054, 4800.927986080212, 4815.277708343777, 4818.590419814355, 5759.078547432391, 5791.710414479259, 5799.449052340021, 5807.941920580824, 5809.302883653904, 7277.818054548678, 7293.927060729325, 7304.853902921912, 7304.853902921912, 7330.450216233804, 1647.4645740134504, 1709.829017098305, 1712.9400470983705, 1713.2804222226694, 1714.9399771007954, 1082.426314053553, 1090.3948308688755, 1095.0473088413132, 1102.9283096598695, 1106.67353130825, 6977.267386924402, 6995.965020174866, 6998.335158160068, 7003.824904377329, 7016.403605693471, 7676.923230767732, 7694.153643099255, 7708.537487750641, 7719.343855772322, 7741.380689544823, 5979.9402005980255, 6782.457403407716, 6939.6877140528795, 7006.75476358325, 7034.030471467997, 3216.6461689214166, 3982.761034337891, 4060.0864805419137, 4072.3077076897, 4094.897627559335, 8059.597020148969, 8070.071941726659, 8072.919270807217, 8093.838123237502, 8097.797555061171, 7780.961095194488, 7999.520028798291, 8019.318357939641, 8020.919790802134, 8079.313258372987, 7990.0, 7999.600019999093, 8009.7997550060545, 8049.356051515864, 8053.798655033671, 6210.3168651449205, 6299.4487232670845, 7632.923670763222, 7706.653200606098, 7722.652480638497, 6446.709898054505, 7327.340539351484, 7432.368248698921, 7575.356094732009, 7676.270754278335, 8101.432899696964, 8120.472169308976, 8122.83754324922, 8144.267015968591, 8180.059293181361, 4764.618830493483, 4795.520447955316, 4801.95198048015, 4816.831410900601, 4825.951740482691, 6544.920088185587, 7147.999280100894, 7169.856602868018, 7726.690932362642, 7757.185495522889, 6543.345665433419, 7423.331900129015, 7423.740169094272, 7431.182569917197, 7459.179490256176, 6862.691178896862, 7414.55416193837, 7428.182899880901, 7429.257074292527, 7463.3656139226605, 6301.338359472189, 7179.569225846466, 7239.624471350427, 7245.311695388929, 7247.0, 5998.460138587374, 7387.335139837225, 7403.14863790671, 7405.074365704287, 7418.629068546659, 7064.717411303491, 7250.0, 7257.891131633135, 7305.963470182615, 7313.341799237881], "unit": "ms", "name": "prototype.html", "value": 5324.944383644683}, {"lowerIsBetter": false, "replicates": [705.5519744961948, 705.6295444891431, 713.9107611548557, 756.9280918312759, 769.4921351907742, 11981.0, 15055.096694198355, 15094.547163585083, 15182.0, 15186.696266074685, 14110.506132285373, 15684.76472852908, 15947.282372293246, 15994.84005159948, 15998.0, 732.8864026075967, 911.1708345405699, 916.8670542771295, 919.9926080941359, 920.6593560382635, 733.5195446982209, 911.0752586125088, 922.3359181389422, 926.1201858234704, 926.536731634183, 942.726609283307, 960.9855852162189, 964.778101036762, 966.7051549277468, 966.7776411425376, 929.5677509957902, 948.8861336639578, 955.5986485676033, 956.4691596164126, 961.7932144588912, 690.9619970901598, 691.7647999680082, 693.3482526425145, 701.5124488480508, 713.6182142553761, 15004.549863504113, 15073.321700523502, 15153.696926061417, 15261.38954441821, 15343.07941523512, 10233.232507561888, 10341.431221282826, 10364.119049880694, 10367.63713270032, 10887.401192934385, 9632.566534505893, 9749.807582739419, 10024.699259022242, 10067.496625168786, 10491.108255798266, 2764.3089227693076, 3049.8932537361306, 3137.294108825519, 3153.7477001839798, 3164.2089477630593, 77720.61139694322, 77789.61105194438, 77993.61003195004, 78141.43717125682, 78968.0, 7123.536970096927, 7149.785506434815, 7209.71161153548, 7247.565146091251, 7307.817304567428, 12626.36868156607, 12660.303683297507, 12667.936660316824, 12683.429245683781, 12722.936385318015, 5471.5896307777075, 5778.335491418541, 6337.207849018872, 6453.709583068773, 6621.86756264872, 3870.3613903706137, 3944.5069366329208, 3964.1873415949663, 3996.960030399659, 4041.9595804041583, 3056.938861222763, 3067.1871953932227, 3074.0, 3080.553319768666, 3083.722464978163, 482.4283224379122, 484.82303959055395, 486.10313970723956, 492.5517778821255, 539.078176318492, 512.229095211704, 533.2188344075947, 576.9221155144086, 589.3929252869466, 593.9635336338031, 8243.711470098518, 8608.139186081467, 8665.653373865101, 8816.25556449304, 8936.731898043068, 509.21834983300454, 539.8812261302508, 554.5092593055094, 602.16299343912, 616.6331033035336, 3942.802859856996, 4002.5797291284, 4065.8780236592947, 4138.813753381105, 4165.625093741578, 92409.0, 93256.0, 93965.53017235007, 94204.0, 98947.0, 76367.85448218281, 80434.79347809787, 82892.58553707313, 83512.58243708743, 86310.70533941996, 76490.23509764831, 78770.0, 79275.8108628371, 79766.4046719074, 80180.59909700415, 7403.666834992546, 8981.775455613662, 9076.546172691471, 9385.296102792454, 9403.247740180906, 49243.26135108048, 49760.751196243786, 54672.0, 54852.99999999841, 56110.71944640251, 74214.62892685719, 76001.47997039917, 76997.61501192459, 77564.0, 78808.60595696984, 7948.16544262844, 8028.197180281925, 8048.637811298388, 8056.154103819014, 8241.134680858424, 12114.091443141975, 12271.386430678609, 12476.438560264629, 12525.311107889154, 12867.549635762703, 11591.710207244549, 12240.510379584717, 12267.0, 12452.377381131088, 12469.0, 9823.557939892578, 10038.899611003797, 10527.73680657959, 12174.330411827434, 12502.0, 11299.43502824872, 11471.885281147082, 11777.941110294736, 11813.586524471602, 12340.938295308466, 9826.312158148861, 9863.457509837028, 9916.157126644315, 10003.199744020607, 10749.301295415773, 9088.454692718458, 9176.174144327042, 9532.904670953201, 10135.797284054424, 10213.489325533843], "unit": "ms", "name": "yui.html", "value": 6640.181067036731}], "name": "dromaeo_css", "value": 7273.833873548738}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 115.0, 115.0, 115.0, 130.0, 116.0, 116.0, 117.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 116.4}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 145.0, 169.0, 152.0, 147.0, 167.0, 121.0, 196.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [189.0, 197.0, 195.0, 196.0, 205.0, 224.0, 225.0, 273.0, 247.0, 198.0], "unit": "ms", "name": "audio-dft", "value": 214.9}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 70.0, 107.0, 57.0, 64.0, 86.0, 85.0, 142.0, 81.0], "unit": "ms", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [107.0, 79.0, 113.0, 75.0, 79.0, 62.0, 125.0, 111.0, 115.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 99.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 87.0, 99.0, 132.0, 87.0, 88.0, 88.0, 93.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 93.4}, {"lowerIsBetter": true, "replicates": [116.0, 95.0, 153.0, 154.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-darkroom", "value": 108.9}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 90.0, 90.0, 93.0, 92.0, 92.0, 90.0, 94.0, 93.0], "unit": "ms", "name": "imaging-desaturate", "value": 91.9}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 61.0, 61.0, 68.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 65.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [97.0, 108.0, 112.0, 111.0, 84.0, 83.0, 85.0, 84.0, 87.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [129.0, 136.0, 146.0, 104.0, 146.0, 134.0, 113.0, 127.0, 150.0, 134.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.9}, {"lowerIsBetter": true, "replicates": [137.0, 168.0, 170.0, 137.0, 134.0, 139.0, 141.0, 139.0, 139.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 70.0, 83.0, 86.0, 89.0, 76.0, 83.0, 90.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 77.7}], "name": "kraken", "value": 1533.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [633.7135614702155], "unit": "score", "name": "Richards", "value": 55.706555999999985}, {"lowerIsBetter": false, "replicates": [157.2079861656972], "unit": "score", "name": "DeltaBlue", "value": 420.57659800000005}, {"lowerIsBetter": false, "replicates": [287.4389192296637], "unit": "score", "name": "Encrypt", "value": 926.0436990000001}, {"lowerIsBetter": false, "replicates": [4758.293838862559], "unit": "score", "name": "Decrypt", "value": 55.94042928286857}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [743.4944237918215], "unit": "score", "name": "Earley", "value": 896.3927350000001}, {"lowerIsBetter": false, "replicates": [12575.0], "unit": "score", "name": "Boyer", "value": 52.99904572564615}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [634.5177664974619], "unit": "score", "name": "Splay", "value": 128.429816}, {"lowerIsBetter": false, "replicates": [4524.886877828054], "unit": "score", "name": "NavierStokes", "value": 327.9640000000003}], "name": "v8_7", "value": 19159.88201501826}]} 16:52:39 INFO - RETURN: dromaeo_css: 7273.83 16:52:39 INFO - RETURN: kraken: 1533.30 16:52:39 INFO - RETURN: v8_7: 19159.88 16:52:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "19159.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1533.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7273.83"}}} 16:52:39 INFO - Return code: 0 16:52:39 INFO - # TBPL SUCCESS # 16:52:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:52:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:52:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:52:39 INFO - 2015-11-18 16:52:39.796 screenresolution[1980:14804] starting screenresolution argv=screenresolution get 16:52:39 INFO - 2015-11-18 16:52:39.799 screenresolution[1980:14804] Display 0: 1600x1200x32@60 16:52:39 INFO - 2015-11-18 16:52:39.804 screenresolution[1981:14807] starting screenresolution argv=screenresolution list 16:52:39 INFO - Available Modes on Display 0 16:52:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:52:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:52:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:52:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:52:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:52:40 INFO - Intel Iris: 16:52:40 INFO - Chipset Model: Intel Iris 16:52:40 INFO - Type: GPU 16:52:40 INFO - Bus: Built-In 16:52:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:52:40 INFO - Vendor: Intel (0x8086) 16:52:40 INFO - Device ID: 0x0a2e 16:52:40 INFO - Revision ID: 0x0009 16:52:40 INFO - Displays: 16:52:40 INFO - Display: 16:52:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:52:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:52:40 INFO - Display Serial Number: 1600x1200 60 16:52:40 INFO - Main Display: Yes 16:52:40 INFO - Mirror: Off 16:52:40 INFO - Online: Yes 16:52:40 INFO - Rotation: Supported 16:52:40 INFO - Return code: 0 16:52:40 INFO - Running post-action listener: _resource_record_post_action 16:52:40 INFO - Running post-run listener: _resource_record_post_run 16:52:41 INFO - Total resource usage - Wall time: 1235s; CPU: 53.0%; Read bytes: 479232; Write bytes: 690946560; Read time: 8; Write time: 2075 16:52:41 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 335047168; Write bytes: 335365632; Read time: 25829; Write time: 612 16:52:41 INFO - run-tests - Wall time: 1205s; CPU: 53.0%; Read bytes: 479232; Write bytes: 345213952; Read time: 8; Write time: 1430 16:52:41 INFO - Running post-run listener: _upload_blobber_files 16:52:41 INFO - Blob upload gear active. 16:52:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:52:41 INFO - Copying logs to upload dir... 16:52:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.373008 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-18 16:52:41.162099) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:52:41.165721) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 build_url:https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009362 build_url: 'https://queue.taskcluster.net/v1/task/QQt9Lp5CRWamjCu0f2jupQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 16:52:41.188587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:52:41.188913) ========= 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.4IhyJzOJ9K/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.pXHZnmA3aV/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 16:52:41.237372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 16:52:41.237713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 16:52:41.238204) ========= ========= Total master_lag: 0.22 =========