builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0077 starttime: 1447295683.05 results: success (0) buildid: 20151111163445 builduid: fdd9671c17154f89a16dd014d1da741a revision: 8bf46ba0297dfecfdbae08edc1166d8a10bbadf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.046772) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.047253) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.047580) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006042 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.075645) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.075956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.091372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.091776) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005465 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.140639) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.141003) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.141387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.141704) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False --2015-11-11 18:34:43-- 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% 1.41G=0s 2015-11-11 18:34:43 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.275125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.275454) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.019986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.325874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.326462) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8bf46ba0297dfecfdbae08edc1166d8a10bbadf8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8bf46ba0297dfecfdbae08edc1166d8a10bbadf8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False 2015-11-11 18:34:43,403 truncating revision to first 12 chars 2015-11-11 18:34:43,403 Setting DEBUG logging. 2015-11-11 18:34:43,403 attempt 1/10 2015-11-11 18:34:43,403 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8bf46ba0297d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 18:34:43,658 unpacking tar archive at: mozilla-central-8bf46ba0297d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.848585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.848956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.864334) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.864739) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:34:43.865186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2015-11-11 18:34:43.865479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False 18:34:44 INFO - MultiFileLogger online at 20151111 18:34:44 in /builds/slave/test 18:34:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:34:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:34:44 INFO - {'append_to_log': False, 18:34:44 INFO - 'base_work_dir': '/builds/slave/test', 18:34:44 INFO - 'blob_upload_branch': 'Firefox', 18:34:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:34:44 INFO - 'branch': 'Firefox', 18:34:44 INFO - 'buildbot_json_path': 'buildprops.json', 18:34:44 INFO - 'config_files': ('talos/mac_config.py',), 18:34:44 INFO - 'default_actions': ('clobber', 18:34:44 INFO - 'read-buildbot-config', 18:34:44 INFO - 'download-and-extract', 18:34:44 INFO - 'populate-webroot', 18:34:44 INFO - 'create-virtualenv', 18:34:44 INFO - 'install', 18:34:44 INFO - 'run-tests'), 18:34:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:34:44 INFO - 'download_minidump_stackwalk': True, 18:34:44 INFO - 'download_symbols': 'ondemand', 18:34:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:34:44 INFO - 'tooltool.py': '/tools/tooltool.py', 18:34:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:34:44 INFO - '/tools/misc-python/virtualenv.py')}, 18:34:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:34:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:34:44 INFO - 'installer_path': 'installer.exe', 18:34:44 INFO - 'log_level': 'info', 18:34:44 INFO - 'log_name': 'talos', 18:34:44 INFO - 'log_to_console': True, 18:34:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:34:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:34:44 INFO - 'opt_config_files': (), 18:34:44 INFO - 'pip_index': False, 18:34:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:34:44 INFO - 'cmd': ('bash', 18:34:44 INFO - '-c', 18:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:34:44 INFO - 'enabled': True, 18:34:44 INFO - 'halt_on_failure': False, 18:34:44 INFO - 'name': 'check_screen_resolution'},), 18:34:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:34:44 INFO - 'cmd': ('bash', 18:34:44 INFO - '-c', 18:34:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:34:44 INFO - 'enabled': True, 18:34:44 INFO - 'halt_on_failure': False, 18:34:44 INFO - 'name': 'check_screen_resolution'},), 18:34:44 INFO - 'run_cmd_checks_enabled': True, 18:34:44 INFO - 'sps_profile': False, 18:34:44 INFO - 'sps_profile_interval': 0, 18:34:44 INFO - 'suite': 'dromaeojs-e10s', 18:34:44 INFO - 'system_bits': '64', 18:34:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:34:44 INFO - 'title': 't-yosemite-r5-0077', 18:34:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:34:44 INFO - 'use_talos_json': True, 18:34:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:34:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:34:44 INFO - 'work_dir': 'build'} 18:34:44 INFO - ##### 18:34:44 INFO - ##### Running clobber step. 18:34:44 INFO - ##### 18:34:44 INFO - Running pre-action listener: _resource_record_pre_action 18:34:44 INFO - Running main action method: clobber 18:34:44 INFO - rmtree: /builds/slave/test/build 18:34:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:34:47 INFO - Running post-action listener: _resource_record_post_action 18:34:47 INFO - ##### 18:34:47 INFO - ##### Running read-buildbot-config step. 18:34:47 INFO - ##### 18:34:47 INFO - Running pre-action listener: _resource_record_pre_action 18:34:47 INFO - Running main action method: read_buildbot_config 18:34:47 INFO - Using buildbot properties: 18:34:47 INFO - { 18:34:47 INFO - "properties": { 18:34:47 INFO - "buildnumber": 25, 18:34:47 INFO - "product": "firefox", 18:34:47 INFO - "script_repo_revision": "production", 18:34:47 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 18:34:47 INFO - "repository": "", 18:34:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 18:34:47 INFO - "buildid": "20151111163445", 18:34:47 INFO - "slavename": "t-yosemite-r5-0077", 18:34:47 INFO - "pgo_build": "False", 18:34:47 INFO - "basedir": "/builds/slave/test", 18:34:47 INFO - "project": "", 18:34:47 INFO - "platform": "yosemite", 18:34:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:34:47 INFO - "slavebuilddir": "test", 18:34:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:34:47 INFO - "branch": "mozilla-central", 18:34:47 INFO - "repo_path": "mozilla-central", 18:34:47 INFO - "stage_platform": "macosx64", 18:34:47 INFO - "builduid": "fdd9671c17154f89a16dd014d1da741a", 18:34:47 INFO - "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8" 18:34:47 INFO - }, 18:34:47 INFO - "sourcestamp": { 18:34:47 INFO - "repository": "", 18:34:47 INFO - "hasPatch": false, 18:34:47 INFO - "project": "", 18:34:47 INFO - "branch": "mozilla-central-macosx64-talos", 18:34:47 INFO - "changes": [ 18:34:47 INFO - { 18:34:47 INFO - "category": null, 18:34:47 INFO - "files": [ 18:34:47 INFO - { 18:34:47 INFO - "url": null, 18:34:47 INFO - "name": "https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:34:47 INFO - } 18:34:47 INFO - ], 18:34:47 INFO - "repository": "", 18:34:47 INFO - "rev": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8", 18:34:47 INFO - "who": "kwierso@gmail.com", 18:34:47 INFO - "when": 1447295021, 18:34:47 INFO - "number": 6651609, 18:34:47 INFO - "comments": "Backed out changeset b4c4ffc473ba (bug 1223635) for mass m(bc) bustage CLOSED TREE", 18:34:47 INFO - "project": "", 18:34:47 INFO - "at": "Wed 11 Nov 2015 18:23:41", 18:34:47 INFO - "branch": "mozilla-central-macosx64-talos", 18:34:47 INFO - "revlink": "", 18:34:47 INFO - "properties": [ 18:34:47 INFO - [ 18:34:47 INFO - "buildid", 18:34:47 INFO - "20151111163445", 18:34:47 INFO - "Change" 18:34:47 INFO - ], 18:34:47 INFO - [ 18:34:47 INFO - "builduid", 18:34:47 INFO - "fdd9671c17154f89a16dd014d1da741a", 18:34:47 INFO - "Change" 18:34:47 INFO - ], 18:34:47 INFO - [ 18:34:47 INFO - "pgo_build", 18:34:47 INFO - "False", 18:34:47 INFO - "Change" 18:34:47 INFO - ] 18:34:47 INFO - ], 18:34:47 INFO - "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8" 18:34:47 INFO - } 18:34:47 INFO - ], 18:34:47 INFO - "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8" 18:34:47 INFO - } 18:34:47 INFO - } 18:34:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:34:47 INFO - Running post-action listener: _resource_record_post_action 18:34:47 INFO - ##### 18:34:47 INFO - ##### Running download-and-extract step. 18:34:47 INFO - ##### 18:34:47 INFO - Running pre-action listener: _resource_record_pre_action 18:34:47 INFO - Running main action method: download_and_extract 18:34:47 INFO - mkdir: /builds/slave/test/build/tests 18:34: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')]} 18:34:47 INFO - https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:34:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/test_packages.json 18:34:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/test_packages.json 18:34:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:34:48 INFO - Downloaded 1149 bytes. 18:34:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:34:48 INFO - Using the following test package requirements: 18:34:48 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:34:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:34:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'jsshell-mac.zip'], 18:34:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:34:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:34:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:34:48 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:34:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:34:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:34:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:34:48 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:34:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:34:48 INFO - https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:34:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:34:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:34:49 INFO - Downloaded 17453978 bytes. 18:34:49 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 18:34:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:34:54 INFO - Return code: 0 18:34:54 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 18:34: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')]} 18:34:54 INFO - https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:34:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:34:55 INFO - Downloaded 17453978 bytes. 18:34:55 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 18:34:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:34:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:35:02 INFO - Return code: 0 18:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:02 INFO - https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:35:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:35:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:35:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:35:03 INFO - Downloaded 11131693 bytes. 18:35:03 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 18:35:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:35:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:35:03 INFO - Return code: 0 18:35: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')]} 18:35:03 INFO - https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:35:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:35:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:35:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__h0cZnORsGuyUVdMFB__A/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 18:35:07 INFO - Downloaded 108700280 bytes. 18:35:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:35:07 INFO - mkdir: /builds/slave/test/properties 18:35:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:35:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:35:07 INFO - Contents: 18:35:07 INFO - build_url:https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:35:07 INFO - Running post-action listener: _resource_record_post_action 18:35:07 INFO - Running post-action listener: set_extra_try_arguments 18:35:07 INFO - ##### 18:35:07 INFO - ##### Running populate-webroot step. 18:35:07 INFO - ##### 18:35:07 INFO - Running pre-action listener: _resource_record_pre_action 18:35:07 INFO - Running main action method: populate_webroot 18:35:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:35:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:35:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:35:07 INFO - '../fennec_ids.txt'], 18:35:07 INFO - 'tests': ['tcheck2']}, 18:35:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:35:07 INFO - '--tppagecycles', 18:35:07 INFO - '7'], 18:35:07 INFO - 'tests': ['tsvgm']}}, 18:35:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:35:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:35:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:35:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:35:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'tests': ['damp', 'tps']}, 18:35:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['damp', 'tps']}, 18:35:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:35:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:35:07 INFO - 'other': {'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'other_l64': {'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'other_nol64': {'tests': ['a11yr', 18:35:07 INFO - 'ts_paint', 18:35:07 INFO - 'tpaint', 18:35:07 INFO - 'sessionrestore', 18:35:07 INFO - 'sessionrestore_no_auto_restore']}, 18:35:07 INFO - 'svgr': {'tests': ['tsvgx', 18:35:07 INFO - 'tsvgr_opacity', 18:35:07 INFO - 'tart', 18:35:07 INFO - 'tscrollx', 18:35:07 INFO - 'cart']}, 18:35:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['tsvgx', 18:35:07 INFO - 'tsvgr_opacity', 18:35:07 INFO - 'tart', 18:35:07 INFO - 'tscrollx', 18:35:07 INFO - 'cart']}, 18:35:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'tests': ['tp5o']}, 18:35:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'talos_options': ['--e10s'], 18:35:07 INFO - 'tests': ['tp5o']}, 18:35:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'talos_options': ['--xperf_path', 18:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:07 INFO - 'tests': ['tp5n']}, 18:35:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:07 INFO - 'talos_options': ['--e10s', 18:35:07 INFO - '--xperf_path', 18:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:07 INFO - 'tests': ['tp5n']}}, 18:35:07 INFO - 'talos.zip': {'path': '', 18:35:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:35:07 INFO - Running post-action listener: _resource_record_post_action 18:35:07 INFO - ##### 18:35:07 INFO - ##### Running create-virtualenv step. 18:35:07 INFO - ##### 18:35:07 INFO - Running pre-action listener: _resource_record_pre_action 18:35:07 INFO - Running main action method: create_virtualenv 18:35:07 INFO - Creating virtualenv /builds/slave/test/build/venv 18:35:07 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 18:35:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:35:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:35:07 INFO - Using real prefix '/tools/python27' 18:35:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:35:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:35:12 INFO - Installing pip.................done. 18:35:12 INFO - Return code: 0 18:35:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:12 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:12 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 18:35:12 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 18:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:12 INFO - 'HOME': '/Users/cltbld', 18:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:12 INFO - 'LOGNAME': 'cltbld', 18:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:12 INFO - 'MOZ_NO_REMOTE': '1', 18:35:12 INFO - 'NO_EM_RESTART': '1', 18:35:12 INFO - 'PAGER': '/bin/cat', 18:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:12 INFO - 'PWD': '/builds/slave/test', 18:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:12 INFO - 'SHELL': '/bin/bash', 18:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:12 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:12 INFO - 'USER': 'cltbld', 18:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:12 INFO - 'XPC_FLAGS': '0x0', 18:35:12 INFO - 'XPC_SERVICE_NAME': '0', 18:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:12 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 18:35:12 INFO - Cleaning up... 18:35:12 INFO - Return code: 0 18:35:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:12 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:12 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 18:35:12 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 18:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:12 INFO - 'HOME': '/Users/cltbld', 18:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:12 INFO - 'LOGNAME': 'cltbld', 18:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:12 INFO - 'MOZ_NO_REMOTE': '1', 18:35:12 INFO - 'NO_EM_RESTART': '1', 18:35:12 INFO - 'PAGER': '/bin/cat', 18:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:12 INFO - 'PWD': '/builds/slave/test', 18:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:12 INFO - 'SHELL': '/bin/bash', 18:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:12 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:12 INFO - 'USER': 'cltbld', 18:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:12 INFO - 'XPC_FLAGS': '0x0', 18:35:12 INFO - 'XPC_SERVICE_NAME': '0', 18:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:12 INFO - Downloading/unpacking psutil>=0.7.1 18:35:12 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 18:35:12 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 18:35:12 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 18:35:12 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 18:35:12 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 18:35:12 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 18:35:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:35:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:35:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:15 INFO - Installing collected packages: psutil 18:35:15 INFO - Running setup.py install for psutil 18:35:15 INFO - building 'psutil._psutil_osx' extension 18:35:15 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 18:35:15 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 18:35:15 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 18:35:15 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 18:35:15 INFO - building 'psutil._psutil_posix' extension 18:35:15 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 18:35:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:35:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:35:15 INFO - ^ 18:35:16 INFO - 1 warning generated. 18:35:16 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 18:35:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:16 INFO - Successfully installed psutil 18:35:16 INFO - Cleaning up... 18:35:16 INFO - Return code: 0 18:35:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:35:16 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')]} 18:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:16 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')]} 18:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:16 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:16 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 18:35:16 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 18:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:16 INFO - 'HOME': '/Users/cltbld', 18:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:16 INFO - 'LOGNAME': 'cltbld', 18:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:16 INFO - 'MOZ_NO_REMOTE': '1', 18:35:16 INFO - 'NO_EM_RESTART': '1', 18:35:16 INFO - 'PAGER': '/bin/cat', 18:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:16 INFO - 'PWD': '/builds/slave/test', 18:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:16 INFO - 'SHELL': '/bin/bash', 18:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:16 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:16 INFO - 'USER': 'cltbld', 18:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:16 INFO - 'XPC_FLAGS': '0x0', 18:35:16 INFO - 'XPC_SERVICE_NAME': '0', 18:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:35:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:35:18 INFO - Installing collected packages: mozsystemmonitor 18:35:18 INFO - Running setup.py install for mozsystemmonitor 18:35:19 INFO - Successfully installed mozsystemmonitor 18:35:19 INFO - Cleaning up... 18:35:19 INFO - Return code: 0 18:35:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:19 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:19 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 18:35:19 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 18:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:19 INFO - 'HOME': '/Users/cltbld', 18:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:19 INFO - 'LOGNAME': 'cltbld', 18:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:19 INFO - 'MOZ_NO_REMOTE': '1', 18:35:19 INFO - 'NO_EM_RESTART': '1', 18:35:19 INFO - 'PAGER': '/bin/cat', 18:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:19 INFO - 'PWD': '/builds/slave/test', 18:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:19 INFO - 'SHELL': '/bin/bash', 18:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:19 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:19 INFO - 'USER': 'cltbld', 18:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:19 INFO - 'XPC_FLAGS': '0x0', 18:35:19 INFO - 'XPC_SERVICE_NAME': '0', 18:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:19 INFO - Downloading/unpacking blobuploader==1.2.4 18:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:35:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:35:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:35:21 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 18:35:21 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 18:35:21 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 18:35:21 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 18:35:21 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 18:35:21 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 18:35:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:35:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:23 INFO - Downloading docopt-0.6.1.tar.gz 18:35:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:35:23 INFO - Installing collected packages: blobuploader, requests, docopt 18:35:23 INFO - Running setup.py install for blobuploader 18:35:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:35:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:35:23 INFO - Running setup.py install for requests 18:35:23 INFO - Running setup.py install for docopt 18:35:24 INFO - Successfully installed blobuploader requests docopt 18:35:24 INFO - Cleaning up... 18:35:24 INFO - Return code: 0 18:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:24 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:24 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 18:35:24 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 18:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:24 INFO - 'HOME': '/Users/cltbld', 18:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:24 INFO - 'LOGNAME': 'cltbld', 18:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:24 INFO - 'MOZ_NO_REMOTE': '1', 18:35:24 INFO - 'NO_EM_RESTART': '1', 18:35:24 INFO - 'PAGER': '/bin/cat', 18:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:24 INFO - 'PWD': '/builds/slave/test', 18:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:24 INFO - 'SHELL': '/bin/bash', 18:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:24 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:24 INFO - 'USER': 'cltbld', 18:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:24 INFO - 'XPC_FLAGS': '0x0', 18:35:24 INFO - 'XPC_SERVICE_NAME': '0', 18:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-ysRufw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-hVwBRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-RMDLNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-eD9Ui2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-FqlXnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:24 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-pRENs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-RrtwoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-15_sbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-9Da3xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-hzqkTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-XbNT3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-mV4vxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-op5Urz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:25 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-O5QdaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:26 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-zOgJJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:26 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-feftvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:26 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-iMKY9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:35:26 INFO - Running setup.py install for manifestparser 18:35:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:35:26 INFO - Running setup.py install for mozcrash 18:35:26 INFO - Running setup.py install for mozdebug 18:35:26 INFO - Running setup.py install for mozdevice 18:35:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Running setup.py install for mozfile 18:35:27 INFO - Running setup.py install for mozhttpd 18:35:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Running setup.py install for mozinfo 18:35:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Running setup.py install for mozInstall 18:35:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:35:27 INFO - Running setup.py install for mozleak 18:35:27 INFO - Running setup.py install for mozlog 18:35:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Running setup.py install for moznetwork 18:35:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Running setup.py install for mozprocess 18:35:28 INFO - Running setup.py install for mozprofile 18:35:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Running setup.py install for mozrunner 18:35:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:35:28 INFO - Running setup.py install for mozscreenshot 18:35:29 INFO - Running setup.py install for moztest 18:35:29 INFO - Running setup.py install for mozversion 18:35:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:35:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:35:29 INFO - Cleaning up... 18:35:29 INFO - Return code: 0 18:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:29 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:29 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 18:35:29 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 18:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:29 INFO - 'HOME': '/Users/cltbld', 18:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:29 INFO - 'LOGNAME': 'cltbld', 18:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:29 INFO - 'MOZ_NO_REMOTE': '1', 18:35:29 INFO - 'NO_EM_RESTART': '1', 18:35:29 INFO - 'PAGER': '/bin/cat', 18:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:29 INFO - 'PWD': '/builds/slave/test', 18:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:29 INFO - 'SHELL': '/bin/bash', 18:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:29 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:29 INFO - 'USER': 'cltbld', 18:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:29 INFO - 'XPC_FLAGS': '0x0', 18:35:29 INFO - 'XPC_SERVICE_NAME': '0', 18:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:29 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-rjSxpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:29 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)) 18:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:29 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-r9R5xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-ynA0O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-j4etxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-89wu8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-U4vX9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-3l2uti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-AIV4jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-6gtImI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:30 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)) 18:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:30 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-5EA7Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-_Umfhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-ZPuSso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-5OdrQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-KxC5IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-N1PSMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-OOEI3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:31 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)) 18:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:31 INFO - Running setup.py (path:/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/pip-sOm5YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:31 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)) 18:35:31 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)) 18:35:31 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)) 18:35:31 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)) 18:35:31 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)) 18:35:31 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)) 18:35:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:31 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 18:35:31 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 18:35:31 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 18:35:31 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 18:35:31 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 18:35:31 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 18:35:34 INFO - Downloading blessings-1.5.1.tar.gz 18:35:34 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 18:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:35:34 INFO - Installing collected packages: blessings 18:35:34 INFO - Running setup.py install for blessings 18:35:34 INFO - Successfully installed blessings 18:35:34 INFO - Cleaning up... 18:35:34 INFO - Return code: 0 18:35:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:34 INFO - Reading from file tmpfile_stdout 18:35:34 INFO - Current package versions: 18:35:34 INFO - blessings == 1.5.1 18:35:34 INFO - blobuploader == 1.2.4 18:35:34 INFO - docopt == 0.6.1 18:35:34 INFO - manifestparser == 1.1 18:35:34 INFO - mozInstall == 1.12 18:35:34 INFO - mozcrash == 0.16 18:35:34 INFO - mozdebug == 0.1 18:35:34 INFO - mozdevice == 0.47 18:35:34 INFO - mozfile == 1.2 18:35:34 INFO - mozhttpd == 0.7 18:35:34 INFO - mozinfo == 0.9 18:35:34 INFO - mozleak == 0.1 18:35:34 INFO - mozlog == 3.0 18:35:34 INFO - moznetwork == 0.27 18:35:34 INFO - mozprocess == 0.22 18:35:34 INFO - mozprofile == 0.27 18:35:34 INFO - mozrunner == 6.11 18:35:34 INFO - mozscreenshot == 0.1 18:35:34 INFO - mozsystemmonitor == 0.0 18:35:34 INFO - moztest == 0.7 18:35:34 INFO - mozversion == 1.4 18:35:34 INFO - psutil == 3.1.1 18:35:34 INFO - requests == 1.2.3 18:35:34 INFO - wsgiref == 0.1.2 18:35:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35: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')]} 18:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35: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')]} 18:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:34 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 0x106b01490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ade228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9781e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/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.9GJLioVyln/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:35:34 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 18:35:34 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 18:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:34 INFO - 'HOME': '/Users/cltbld', 18:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:34 INFO - 'LOGNAME': 'cltbld', 18:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:34 INFO - 'MOZ_NO_REMOTE': '1', 18:35:34 INFO - 'NO_EM_RESTART': '1', 18:35:34 INFO - 'PAGER': '/bin/cat', 18:35:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:34 INFO - 'PWD': '/builds/slave/test', 18:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:34 INFO - 'SHELL': '/bin/bash', 18:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:35:34 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:34 INFO - 'USER': 'cltbld', 18:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:34 INFO - 'XPC_FLAGS': '0x0', 18:35:34 INFO - 'XPC_SERVICE_NAME': '0', 18:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 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)) 18:35:35 INFO - Cleaning up... 18:35:35 INFO - Return code: 0 18:35:35 INFO - Running post-action listener: _resource_record_post_action 18:35:35 INFO - Running post-action listener: _start_resource_monitoring 18:35:35 INFO - Starting resource monitoring. 18:35:35 INFO - ##### 18:35:35 INFO - ##### Running install step. 18:35:35 INFO - ##### 18:35:35 INFO - Running pre-action listener: _resource_record_pre_action 18:35:35 INFO - Running main action method: install 18:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:35 INFO - Reading from file tmpfile_stdout 18:35:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:35:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:35:35 INFO - Reading from file tmpfile_stdout 18:35:35 INFO - Output received: 18:35:35 INFO - Usage: mozinstall [options] installer 18:35:35 INFO - Options: 18:35:35 INFO - -h, --help show this help message and exit 18:35:35 INFO - -d DEST, --destination=DEST 18:35:35 INFO - Directory to install application into. [default: 18:35:35 INFO - "/builds/slave/test"] 18:35:35 INFO - --app=APP Application being installed. [default: firefox] 18:35:35 INFO - mkdir: /builds/slave/test/build/application 18:35:35 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'] 18:35:35 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 18:36:12 INFO - Reading from file tmpfile_stdout 18:36:12 INFO - Output received: 18:36:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:36:12 INFO - Running post-action listener: _resource_record_post_action 18:36:12 INFO - ##### 18:36:12 INFO - ##### Running run-tests step. 18:36:12 INFO - ##### 18:36:12 INFO - Running pre-action listener: _resource_record_pre_action 18:36:12 INFO - Running main action method: run_tests 18:36:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:36:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:36:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:36:12 INFO - 2015-11-11 18:36:12.657 screenresolution[1917:17817] starting screenresolution argv=screenresolution get 18:36:12 INFO - 2015-11-11 18:36:12.660 screenresolution[1917:17817] Display 0: 1600x1200x32@60 18:36:12 INFO - 2015-11-11 18:36:12.667 screenresolution[1918:17819] starting screenresolution argv=screenresolution list 18:36:12 INFO - Available Modes on Display 0 18:36:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:36:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:36:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:36:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:36:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:36:12 INFO - Intel HD Graphics 3000: 18:36:12 INFO - Chipset Model: Intel HD Graphics 3000 18:36:12 INFO - Type: GPU 18:36:12 INFO - Bus: Built-In 18:36:12 INFO - VRAM (Total): 512 MB 18:36:12 INFO - VRAM (Dynamic, Max): 10 18:36:12 INFO - Vendor: Intel (0x8086) 18:36:12 INFO - Device ID: 0x0116 18:36:12 INFO - Revision ID: 0x0009 18:36:12 INFO - Displays: 18:36:12 INFO - Display: 18:36:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:36:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:36:12 INFO - Display Serial Number: 1600x1200 60 18:36:12 INFO - Main Display: Yes 18:36:12 INFO - Mirror: Off 18:36:12 INFO - Online: Yes 18:36:12 INFO - Rotation: Supported 18:36:12 INFO - Return code: 0 18:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:36:12 INFO - Python 2.7.3 18:36:12 INFO - Return code: 0 18:36:12 INFO - grabbing minidump binary from tooltool 18:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:12 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 0x106a249f0>, '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 0x106784db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a188c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:36:12 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 18:36:12 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 18:36:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:36:13 INFO - Return code: 0 18:36:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:36:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:36:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:36:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:36:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0077', '--webServer', 'localhost'] in /builds/slave/test/build 18:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0077 --webServer localhost 18:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.D95RKGxshl/Render', 18:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:36:13 INFO - 'HOME': '/Users/cltbld', 18:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:36:13 INFO - 'LOGNAME': 'cltbld', 18:36:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:36:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:13 INFO - 'MOZ_NO_REMOTE': '1', 18:36:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:36:13 INFO - 'NO_EM_RESTART': '1', 18:36:13 INFO - 'PAGER': '/bin/cat', 18:36:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:13 INFO - 'PWD': '/builds/slave/test', 18:36:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:36:13 INFO - 'SHELL': '/bin/bash', 18:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9GJLioVyln/Listeners', 18:36:13 INFO - 'TMPDIR': '/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/', 18:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:36:13 INFO - 'USER': 'cltbld', 18:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:13 INFO - 'XPC_FLAGS': '0x0', 18:36:13 INFO - 'XPC_SERVICE_NAME': '0', 18:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:36:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0077', '--webServer', 'localhost'] with output_timeout 3600 18:36:13 INFO - mozversion INFO | application_buildid: 20151111163445 18:36:13 INFO - mozversion INFO | application_changeset: 8bf46ba0297dfecfdbae08edc1166d8a10bbadf8 18:36:13 INFO - mozversion INFO | application_display_name: Nightly 18:36:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:36:13 INFO - mozversion INFO | application_name: Firefox 18:36:13 INFO - mozversion INFO | application_remotingname: firefox 18:36:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:36:13 INFO - mozversion INFO | application_vendor: Mozilla 18:36:13 INFO - mozversion INFO | application_version: 45.0a1 18:36:13 INFO - mozversion INFO | platform_buildid: 20151111163445 18:36:13 INFO - mozversion INFO | platform_changeset: 8bf46ba0297dfecfdbae08edc1166d8a10bbadf8 18:36:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:36:13 INFO - mozversion INFO | platform_version: 45.0a1 18:36:13 INFO - 2015-11-11 18:36:13,275 DEBUG : using testdate: 1447295773 18:36:13 INFO - 2015-11-11 18:36:13,275 DEBUG : actual date: 1447295773 18:36:13 INFO - 2015-11-11 18:36:13,284 INFO : starting webserver on 'localhost:56295' 18:36:13 INFO - 2015-11-11 18:36:13,285 INFO : Starting test suite t-yosemite-r5-0077.e 18:36:13 INFO - 2015-11-11 18:36:13,285 INFO : Starting test dromaeo_css 18:36:13 INFO - 2015-11-11 18:36:13,285 DEBUG : operating with platform_type : mac_ 18:36:13 INFO - 2015-11-11 18:36:13,286 INFO : Initialising browser for dromaeo_css test... 18:36:13 INFO - 2015-11-11 18:36:13,300 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmp1RuahK/profile http://localhost:56295/getInfo.html 18:36:16 INFO - 2015-11-11 18:36:16,599 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:36:16 INFO - 2015-11-11 18:36:16,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:36:16 INFO - 2015-11-11 18:36:16,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:36:16 INFO - 2015-11-11 18:36:16,599 DEBUG : BROWSER_OUTPUT: __metrics 18:36:17 INFO - 2015-11-11 18:36:17,254 INFO : Browser initialized. 18:36:17 INFO - 2015-11-11 18:36:17,255 INFO : Running cycle 1/1 for dromaeo_css test... 18:36:17 INFO - 2015-11-11 18:36:17,255 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmp1RuahK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:36:29 INFO - 2015-11-11 18:36:29,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 241090560 18:36:29 INFO - 2015-11-11 18:36:29,424 DEBUG : BROWSER_OUTPUT: 18:37:19 INFO - 2015-11-11 18:37:19,158 DEBUG : BROWSER_OUTPUT: 1447295839153 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] 18:39:29 INFO - 2015-11-11 18:39:29,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56295/tests/dromaeo/cssquery-ext.html) 18:39:30 INFO - 2015-11-11 18:39:30,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 264937472 18:39:30 INFO - 2015-11-11 18:39:30,365 DEBUG : BROWSER_OUTPUT: 18:42:32 INFO - 2015-11-11 18:42:32,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-ext.html (next: http://localhost:56295/tests/dromaeo/cssquery-jquery.html) 18:42:33 INFO - 2015-11-11 18:42:33,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 270520320 18:42:33 INFO - 2015-11-11 18:42:33,018 DEBUG : BROWSER_OUTPUT: 18:45:34 INFO - 2015-11-11 18:45:34,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56295/tests/dromaeo/cssquery-mootools.html) 18:45:35 INFO - 2015-11-11 18:45:35,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 273256448 18:45:35 INFO - 2015-11-11 18:45:35,324 DEBUG : BROWSER_OUTPUT: 18:48:37 INFO - 2015-11-11 18:48:37,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56295/tests/dromaeo/cssquery-prototype.html) 18:48:37 INFO - 2015-11-11 18:48:37,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 278827008 18:48:37 INFO - 2015-11-11 18:48:37,665 DEBUG : BROWSER_OUTPUT: 18:51:40 INFO - 2015-11-11 18:51:40,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56295/tests/dromaeo/cssquery-yui.html) 18:51:40 INFO - 2015-11-11 18:51:40,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 283537408 18:51:40 INFO - 2015-11-11 18:51:40,872 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/dromaeo/cssquery-yui.html (next: http://localhost:56295/tests/dromaeo/cssquery-dojo.html) 18:54:43 INFO - 2015-11-11 18:54:43,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 288305152 18:54:43 INFO - 2015-11-11 18:54:43,368 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,368 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:54:43 INFO - 2015-11-11 18:54:43,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:54:43 INFO - 2015-11-11 18:54:43,368 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:54:43 INFO - 2015-11-11 18:54:43,368 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:54:43 INFO - 2015-11-11 18:54:43,370 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3058.434189674909;3195.744340452764;3201.5357773122896;3253.154179913222;3286.4248756467614;5116.38603367596;5227.764750586223;5259.105951988162;5297.788088476456;5299.125644268691;5048.5203905629;5154.252633368169;5168.2764412982215;5170.172772356424;5296.947030529694;4799.880002999918;4841.8063277468855;4864.878378040559;4904.150242059984;4955.157623204046;25.970753830201655;4824.951750482503;4842.757862106898;4928.926066109011;4959.826406075788;4700.55344742249;4763.833265835679;4768.2370820668875;4815.759212039384;4851.442084160331;4832.1543729847135;4840.273958906192;4841.346418233528;4851.029794041206;4857.902841943177;4627.537246275346;4758.143534163849;4835.395575553056;4845.588125009378;4921.4094308682825;4942.18453955097;5002.19964805633;5051.570616497602;5167.560757335594;5206;5564.721763911829;5585.74864131111;5588.022096133161;5627;5643.717814109278;5468.425815289417;5596.384397716248;5620.044592419298;5644.491995720405;5700.543956483471;5150.510701483353;5239.685618862804;5241.842744717626;5296.364436267634;5332.986732520809;5684.971575142181;5763.538916886639;5764.798232061858;5774.0184168690585;5792.565557583198;5368.248445217672;5391.81128660495;5510.1459273812625;5519.254900588449;5586.357568879631;5487.2317875497465;5603.215549823028;5603.663780173202;5617.971910140505;5717.056685646821;5514.09017512114;5522.9447705523235;5533.280673512498;5542.889142217214;5544.445555444423;5254.6847189168775;5420.457954204548;5441.238226648273;5515.090010148361;5636.436356364331;4351.456067991501;4365.192439398721;4379.627731642846;4388.495323037828;4420.557944205554;3959.742616729903;3985.980070099689;3996.5803590623145;4018.7588744675413;4056.1887622475624;5178.870528236749;5180.7150606717;5303.151495760737;5317.6277660564165;5378.838634840961;5657.12314591239;5682.147677848273;5684.8863022739315;5697.686627235542;5728;5016.197408414636;5339.706316152571;5340.786368545215;5342.332208473941;5389.299391079213;4858.5384388483035;4892.510748925079;4908.533689299511;4922.778474968635;4955.677880937727;5771.30744310677;5771.797987070517;5778.711064446845;5791.131330300404;5796.82609521715;5474.698891561003;5577.77688892456;5648.85877853057;5701.543876489954;5702.287214098238;5661.716914154358;5710.486056254957;5725.08398656213;5725.484706376279;5770.480656740746;5412.675239485643;5435;5449.046416876951;5450.727463626882;5461.044317244546;5450.127979523258;5513.751881165437;5538.16927460868;5548.306461692288;5609.747561359667;5500.80747173847;5501.257330260363;5504.146857237135;5505.091659876236;5599.860003499945;5481.725913704378;5498.477644623755;5503.422140675171;5515.145152501369;5543.9168412474655;5104.617153713412;5263.052650522943;5338;5449.3460784706085;5509.724513774215;5438.728063596884;5493.752781124939;5509.559235261089;5525.475079867406;5525.585581081355;5271.182966640177;5402.35171779389;5432.837014889559;5440.6735595864375;5474.808381706621 18:54:43 INFO - 2015-11-11 18:54:43,374 DEBUG : BROWSER_OUTPUT: |1;ext.html;517.3352242368558;542.574079347712;552.1827695011384;557.637535601859;565.4373897971519;35624.821875890615;36076.098097547576;36243;36252.456213156824;36809.44785828215;39328.60671393285;39440.40839387412;39447;39491.60508394915;39989.60010399895;8717.91282087179;8863.867041994376;8949.015608283084;8974.326925480582;8982.10178982103;8633.309335253165;8790.824183516326;8811.691590794324;8820.426672266314;8841.60212790426;8680.826383472328;8773.868391974125;8806.515641639708;8830.47017178968;8875.644974201025;8760.25537829282;8820.955895220546;8835;8866.689665861728;8943.418677785923;8632.56837158146;8770.210681038738;8777.64889404423;8788.73633790981;8877.866831997526;36388.81805590982;36862;36864.262714745826;36916.63083369159;37429.62570374289;2413.2398294537165;2674.897119341558;2834.390606019695;2948.6461624605186;3558.3061303045915;25109.37226569332;25308.240752777445;25545.23364299074;26072.8696356517;26340.60489092665;2188.3106821351384;2188.792064753846;2204.9779502204933;2206.8124209442058;2208.514126892081;234453;236401;236731.99999999828;236775;237483;44985.325220121726;52014;52140.739296303276;52230.738846305525;52463.73768131135;42915.57084429178;54543;54861.725691371284;55055.72472137614;55220.17169742457;14085.577432677037;14357.425702971974;14363.353649085817;14383.640408989859;14394.712105757826;10591.682249532527;10802.729931751612;10820.729481763019;10878.673639790819;10942.4528773561;16098.597535061483;16605.252763625667;16817.41139060127;16870.493885183463;17189.82810171907;7631.847363052819;7797.688092476237;7803.180666030099;7832.198594323338;7853;905.1129892705054;923.5428462910768;972.1736523954723;1060.8939106089483;1095.7644106517137;26266.737332626428;26505.46989060208;26551.601725974127;26705;26732.59901101485;910.3354551177545;1002.013017178079;1002.6340385759291;1011.6054738651932;1013.1843865688045;12374.13381063317;12493.625191244277;12572.874271257353;12609.747805044031;13922.930385348009;224609.75390245888;230396;230466;230845;232991;46737.7663111689;47002.5299747005;47102.76448617735;47112;47211.76394118008;1320.320035181882;1320.445412926554;1320.9075364724376;1329.1094966372361;1340.095435580979;26123.216303510926;26399.34001649974;26583.734162658126;26825.731742682325;27014.864925675247;41907.37138942979;42460;42514.57485425106;42596.36105458358;42603.5739642612;274819;277349;278375;279237;281028;27610.309742256606;28398.716012840432;29149.271268218465;29344.11967640974;29414.11757647274;34697;34916.30167396587;35388.11529711778;35407.29185416226;35432.46851297181;30778;32401.837990809894;32526.186845329055;32655.18362040873;32669.836650816593;31655.84172079125;32014.35971280608;32154.196145095622;32535.674643253264;32604;32156.67843321537;32545.34909301848;32884.01347959565;32905.50641740328;32906.341873161924;26096.478070438865;28130.2967425816;28273;28313.43373132567;28365.290867727646;22029.118835247053;22291;22381.552368952205;22399.32802015877;22495.887520562294 18:54:43 INFO - 2015-11-11 18:54:43,374 DEBUG : BROWSER_OUTPUT: |2;jquery.html;311.67118689782296;325.84848045658777;327.16899076346084;328.2499488668392;331.9973679487946;13143.737125257489;13686.247256400906;13729.519466818663;16077.919610401947;16379.83620163798;15754.763678544803;16207.91896040518;16973.74539381907;17040.04039535454;17200.483985480456;5075.568576670988;5241.2400201970695;5247.711375874344;5320.574354051667;5321.893562128756;4364.738115713051;4501.774911254441;4508.864734057984;4558.430196225472;5233.816816411427;4306.913861722764;4442.289233722605;4454.220511410506;4481.910361792762;4492.910141797162;3605.729570282226;4460.754658493782;4468.061707041526;4484.506704262529;4508.098380323916;3769.3403654360377;3779.3197224499854;3782.8486860525823;3817.0838998640406;3929.2141571685493;11794.410279486077;12413.503459861595;12633.620991370273;12670.429830657642;12756.681082972907;1678.3454452763433;1841.4383612998165;1866.5706887415834;1886;1922.3944457495984;8820.911790882074;8922.876993052445;8949.463032218087;8995.235404990584;9120.087991200893;1423.2670174859954;1478.3495262084648;1483.614260292321;1540.9306581203873;1549.3802479008375;53099.20351194735;53667.19499207515;54081.459185408035;54129;54310.72844635791;6235.906461403082;6242.09489624002;6286.685665716695;6286.9056964145575;6296.150019747367;7091.11361079865;7092.645367731593;7093.467989900778;7100.822479438056;7129.322714342129;5058.317127187856;5128.435872054071;5153.45888681683;5168.095583272912;5175.611829112831;5455.699936503451;5471.398146203994;5491.066518691832;5504.174373843955;5519.69641669712;2745.5881617757495;2748;2808.1575527341715;2819.7744180465925;2822.068717323278;1001.3090967232587;1003.7892042670975;1004.8844382895915;1006.2503434941016;1056.0442799266675;397.41778294797683;427.6749670250632;443.388124388342;445.2808713926985;451.417671204143;10621.628243011457;11058.723531911606;11157.888421115686;11238.325700458;11242.943785281184;435.7102526819693;435.8735966569659;437.38110573538086;449.910017996402;450.9233430316854;5971.343152253248;6006.579539432285;6043.8186854394435;6065.150878876961;6089.482393996472;348193;513612;527541;529393;532933;65040.34959650438;66273.33726662671;67086.32913670898;67496.32503674901;67503.66248168728;475.11865489516447;480.2028632470153;481.3309499795287;483.06526870505684;488.4431747807502;10219;10356.430396327973;10381.065704086668;10435.217358697977;10438.843417348899;32459.35081298408;33011.33977320488;33035.504467432525;33212.83393583017;33531.66468335286;41007;41423.1715365697;43660.78169609132;44807;44887.10225795401;5705.258316418839;5836.503897168618;5852.648841069379;5865.794697185749;5891.381404952418;8970.775730606787;10608;10686.412247326161;11001.779964400826;11169.050630696156;9298.395604285699;9384.718458446258;9529.475878826732;9568.66038754561;9569.61721531131;9100.408473449204;9238.168564829197;9253.491057991874;9425.811483770149;9524.523773811421;9228.077192280718;9429.481378524248;9717.319787615083;9742.95128524353;9779.85330220033;5682.545396368363;5854.151148083419;5901.7639294427745;5931.169636250842;5958.225430693982;9369.390989585656;9376.906230937604;9574.760630984281;9600.567974441026;9603.615855365708 18:54:43 INFO - 2015-11-11 18:54:43,378 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1459.7445447046764;1675.8407951244628;1720.122737403924;1738.5392870889216;1738.9565260868476;7408.925910740891;7609.505382150156;7700.152983171846;7875.4487185897015;7879.684812607496;7656.042994625672;7672.578008209546;7756.185600511935;7763.340116090125;7764.18476060014;2110.493481564425;2154.149111101114;2157.7842215778373;2162.2540223622905;2163.891805409731;2157.223399576151;2169.8698078115362;2180.3785921012513;2187.562487502498;2189.0149432755243;1859.0983373064053;1905.5712464695403;2106.0838535237144;2113.3342996955985;2145.410012246637;2075.1491888325713;2090.6341390256644;2104.947376315589;2107.0202355904426;2113.556153207836;2131.79747923947;2141.4860433496005;2142.271627646592;2142.871427714342;2153.246363772683;7521.097468303784;7563.281488258606;7564.281393267631;7584.279493448169;7589.620518974084;4412.382266482695;4508.526604706524;4524.61540769035;4529.343245229424;4549.272116461383;2639.2214296782304;2653.3234025323613;2723.8638068096716;2728.3315587680945;2775.9028434004913;838.2539539809575;1438.6762978329896;1463.751162302411;1482.1996122094056;1500.1074360755333;9954.90045099547;10127.341722787995;10134.239932005203;10149.238807089498;10165.237607179492;4151.91696166075;4192.622663960258;4268.274393353137;4277.2942464493635;4294.076773493652;9035.141661542142;9035.548222588845;9036;9065.81868362629;9101.180893719464;4766.356541866804;4773.0453909218295;4794.089123066607;4796.688215265996;4824.541668541483;4301.569843015736;4317.7841107945105;4319.956800432018;4323.567643235651;4327.6321512671775;3425.3149370126075;3569.785812851237;3578.2664553766417;3579.2483578448296;3586.98206508971;1077.3105212663902;1088.1240601315858;1092.814221582333;1095.9452027398597;1097.7914196302677;847.2586486824028;916.812053529025;1020.9540570674337;1066.2642776484201;1253.3357320620087;6780.93219067803;7143.607101609357;7168.856622867514;7184.533005354635;7187.89218161728;618.8978818494988;640.2860810196597;644.687326646576;645.4642646603309;764.852720918622;5406.648567843077;5609.382967873531;5614.905093506809;5618.943810561924;5633.802816901389;8775;8805.47167169959;8849.823003539894;9080.81838363229;9084.8637270441;8792;8794.648214071494;8810.207081362709;8851.778705532284;8860.955695221483;6888.276730943279;7021.824454388681;7031.8945215821805;7052.400545953651;7110.608916509642;7179.282071792779;7191.676374563052;7207.531510451804;7212.927870721225;7243.420526357773;7990.081140668665;8089.757307280791;8154.714584989734;8172.918270817216;8182.549959752271;8198.344132469507;8270.297024752963;8412.369072319478;8432.114627964222;8442.915570844212;6450.451711604378;6456.644884531396;6490.675466226576;6534.509911756542;6551.901721474277;6927.89608155868;6976.441884649114;6984.196817365864;7016.7544135954995;7095.538789978635;6470.99699546571;6525.347465253627;6643.236027856665;6686.13080299558;6903.689333979883;6562.081308616893;6583.275839657729;6683.131192944886;6706.93293067063;6752.054712340178;6728.3271672832325;6822.11312529368;6840.213375461885;6853.9314606853295;6860.245373009065;5836.678982655994;5888.263967004124;5891.263592050994;5897.144913987362;5925.99258126111;5933.199018132497;5936.5844390892225;5959.135925290895;6122.173506576733;6334.556581039283 18:54:43 INFO - 2015-11-11 18:54:43,378 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.5186294477058;306.1702785451427;308.857925354337;312.8533923171576;313.2122711380876;5930.851728706784;5947.821565353041;5981.5214782817375;5994.280686317648;6082.695865206733;5894.528437724972;5904.675242861641;5915.822525324247;5951.137085122655;5992.22101126854;4452.910941781162;4458.910821783563;4462.330650402433;4462.955370446302;4491.528389519102;4465.486469056068;4467.396901418299;4467.530909254514;4476.776161191944;4536.886577835564;4311.396404503372;4439.644828413735;4444.511103778582;4497.302918047708;4523.886902827439;4497.190505708971;4498.955010449887;4507.57178068083;4517.570830771088;4548.0221752323405;3822.388417853158;3823.4647149399107;3836.865709700175;3838.2899163654815;3847.365184744514;5797.565182611321;5824.271966004249;5826.737796799154;5828.06750919855;5837.09525023622;4906.509349065101;5000.349954505928;5073.949260507385;5077.086124497589;5093.414257360377;6086.543509236825;6109;6112.205413296288;6118.8164355068975;6123.08153776937;4122.093139509333;4126.277901367279;4131.5042194936495;4132.380142978547;4137.91724165515;6455.806325810233;6590.209174899042;6594.802155935329;6606.93393066068;6624.470042396645;4121.752694838319;4183.874483765492;4189.748615083105;4191.3293872980785;4258.552851950501;4241.2365774160335;4248.851290204828;4259.701820872571;4285.292926667065;4286.207051695446;4966.354373931365;4973.055119527278;4985.750712464363;4993.550580447704;5022;6130.785422510191;6152.384761523812;6177.69111544421;6184.536159788034;6219.440250377397;1508.2986411318789;1521.5435369389138;1534.1255484374024;1548.9767653485208;1559.7036563052984;976.72651657536;983.2281658897731;996.1731762636994;996.2179688944144;1002.6039714312806;5843.737031833578;5874.94125058744;5888.175655408247;5900.026495628259;5957.672328022;6309.116723658692;6331.398517140864;6335;6345.49236061114;6405.423511883952;5963.522918166536;5982.102684597346;5995.52035837132;6000.609960352563;6075.301340345828;3480.4257297545623;3586.1751797086295;3597.460380942827;3606.5852426971232;3637.0725465006785;6654.201495820435;6679.799606011828;6681.298463661343;6694.564853284521;6750.0212469192675;6605.900911486331;6616.371444712745;6629.635370054597;6666.266710661824;6694.297098804653;6566.934330656728;6657.400833924873;6679.966600167065;6697.598144111369;6739.93260067393;6455.225372955276;6461.0954466373805;6479.384458476437;6524.380183882524;6560.343965603593;6254.9687251563455;6267.1539342188225;6269.435750782452;6273.96863015682;6346.2067241594805;6546.443552298108;6618.437432818265;6636.13730215069;6652.667366631552;6681.933180668326;4193.496780386373;4217.97891010543;4221.852235171754;4232.195882782262;4243.384709217208;6404.647744374104;6417.197850268716;6429.839254018687;6493.772717954849;6494.870102598016;6228.22147231596;6245.687715614292;6256.718447669957;6264.906026409699;6273.247210334789;6160.10678451631;6247.5939063960695;6261.342559031418;6283.8114856554375;6291.433770960635;5958.255218097738;6093.664848433379;6118.724657390517;6122.448979591858;6154.569180157346;6238.251409830849;6263.3736626337;6382.521310901608;6399.072134540373;6443.194600674916;6219.284782249918;6219.813405597839;6238.625682459067;6241.126242325987;6264.655443950444 18:54:43 INFO - 2015-11-11 18:54:43,381 DEBUG : BROWSER_OUTPUT: |5;yui.html;623.6414061914401;650.4926157597076;716.8064622551911;731.9414446844252;758.7761610324956;13152.276624785633;13395;15273.694526109484;15547.68904621907;15664.373425062984;13876.236806975612;13882.444702211924;13886.166829990208;13936.512222072204;14072.71854562908;821.3839620284787;831.5717405536138;836.0510820219034;845.1970627903486;848.7199224256011;831.6091437024588;835.9498430094184;837.7989282572199;839.8824164616958;846.551327796269;818.3289702443998;851.0213254757048;852.1478521478522;853.7950891785989;854.8546747052985;839.4669384940546;844.2992316377423;845.1252953193446;846.7756044648173;847.5931552854634;606.5875204860693;607.3744043635063;607.8662694207311;614.8962612111271;620.8851362497952;12830.486780528861;12958.22250664963;13000.154989925624;13004.414801333962;13022.283774392405;8973.820523589491;9021.729348119567;9253.583588738456;9644.324897257195;9676.56455459506;8295.585220739;8393.118722534167;8456.492610443393;8505.192006759347;9210.723678289662;2724.0320823844104;2753.408017276275;2772.265349682336;2809.887604495818;2825.7973747623973;40259.79870100631;41239.1752164955;41515.377269340985;44954.550454495366;45458.54541454576;6253.1245625612455;6268;6340.714667839959;6449.451796597248;6519.282878883319;11420.257683250562;11543.942280288546;11548.191626586058;11552.422378881023;11565.19043666952;5709.086546152679;5723.427657234327;5762.164486149485;5870.207521984563;5923.08192230205;3247.0908145719236;3327.8003319800405;3352.4636058230567;3377.257003459235;3394.096749099463;2530.683664541932;2564.230730780758;2568.4349443122483;2569.832960857538;2571.5756900111646;376.55002272284906;381.8148198123908;418.1073408273358;433.60541906864603;433.8416477985576;424.9235137675248;487.24720307125574;513.82273115775;543.2177664163592;572.0903763016823;7014.263502332284;7184.425245980309;7208.783736487913;7267.273272672691;7349.55902645843;467.4040598237207;541.3017207801892;554.8696056426736;556.866352075499;568.4031766645006;3398.2523844754114;3428.468587368962;3456.326016426823;3467.9133021674156;3501.6673416025437;56585;57114;57379.13931291034;57410.712946435;57916.42083579195;49469.257961130614;49476.752616236685;49600.751996239786;49607.503924960285;50190;43064.9233769152;45393;45746.542534574895;45817.312740308924;46279.5372046282;6988.685509152202;7052.188998265266;7225.819354515969;7612.352949999091;7636.08366995964;33275.83362083174;33471.16322091967;33734.49398259077;33775;34176;44229;44744.328835068154;45444.772776135906;46253;46658.300125497466;6820.215675197217;7221.241769614325;7237.493375463667;7403.111626604842;7452.590107543921;10913.618023369145;10974.341539507335;11141.275817071864;11223;11756.529738810352;10113.393196408239;10169.44068076263;10380.896191037993;10599.788004240027;10605.469726513798;9906.702798916043;10189.184865210616;10435.269531132748;10506.106980906403;10660.307080039773;8538.615762290836;8885.4668719877;9931.602735890772;10061.144802691853;10298.330608510423;8405.318742968646;8549.914500854911;8654.091320411519;8814.206721395105;8838.160374764388;7793.399600006102;7807.258310460497;8112.959435203023;8249.628766705393;8777.561121943749 18:54:43 INFO - 2015-11-11 18:54:43,381 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:54:43 INFO - 2015-11-11 18:54:43,381 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:54:43 INFO - 2015-11-11 18:54:43,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,287 18:54:43 INFO - 2015-11-11 18:54:43,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:54:43 INFO - 2015-11-11 18:54:43,382 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296883367__endTimestamp 18:54:43 INFO - 2015-11-11 18:54:43,382 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,382 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5184.13 Median:5402.35 stddev:675.44 (12.5%) stddev-sans-first:656.60 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: Values: 3058.4 3195.7 3201.5 3253.2 3286.4 5116.4 5227.8 5259.1 5297.8 5299.1 5048.5 5154.3 5168.3 5170.2 5296.9 4799.9 4841.8 4864.9 4904.2 4955.2 26.0 4825.0 4842.8 4928.9 4959.8 4700.6 4763.8 4768.2 4815.8 4851.4 4832.2 4840.3 4841.3 4851.0 4857.9 4627.5 4758.1 4835.4 4845.6 4921.4 4942.2 5002.2 5051.6 5167.6 5206.0 5564.7 5585.7 5588.0 5627.0 5643.7 5468.4 5596.4 5620.0 5644.5 5700.5 5150.5 5239.7 5241.8 5296.4 5333.0 5685.0 5763.5 5764.8 5774.0 5792.6 5368.2 5391.8 5510.1 5519.3 5586.4 5487.2 5603.2 5603.7 5618.0 5717.1 5514.1 5522.9 5533.3 5542.9 5544.4 5254.7 5420.5 5441.2 5515.1 5636.4 4351.5 4365.2 4379.6 4388.5 4420.6 3959.7 3986.0 3996.6 4018.8 4056.2 5178.9 5180.7 5303.2 5317.6 5378.8 5657.1 5682.1 5684.9 5697.7 5728.0 5016.2 5339.7 5340.8 5342.3 5389.3 4858.5 4892.5 4908.5 4922.8 4955.7 5771.3 5771.8 5778.7 5791.1 5796.8 5474.7 5577.8 5648.9 5701.5 5702.3 5661.7 5710.5 5725.1 5725.5 5770.5 5412.7 5435.0 5449.0 5450.7 5461.0 5450.1 5513.8 5538.2 5548.3 5609.7 5500.8 5501.3 5504.1 5505.1 5599.9 5481.7 5498.5 5503.4 5515.1 5543.9 5104.6 5263.1 5338.0 5449.3 5509.7 5438.7 5493.8 5509.6 5525.5 5525.6 5271.2 5402.4 5432.8 5440.7 5474.8 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,383 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40422.36 Median:32464.01 stddev:64874.16 (199.8%) stddev-sans-first:64986.96 18:54:43 INFO - 2015-11-11 18:54:43,385 DEBUG : BROWSER_OUTPUT: Values: 517.3 542.6 552.2 557.6 565.4 35624.8 36076.1 36243.0 36252.5 36809.4 39328.6 39440.4 39447.0 39491.6 39989.6 8717.9 8863.9 8949.0 8974.3 8982.1 8633.3 8790.8 8811.7 8820.4 8841.6 8680.8 8773.9 8806.5 8830.5 8875.6 8760.3 8821.0 8835.0 8866.7 8943.4 8632.6 8770.2 8777.6 8788.7 8877.9 36388.8 36862.0 36864.3 36916.6 37429.6 2413.2 2674.9 2834.4 2948.6 3558.3 25109.4 25308.2 25545.2 26072.9 26340.6 2188.3 2188.8 2205.0 2206.8 2208.5 234453.0 236401.0 236732.0 236775.0 237483.0 44985.3 52014.0 52140.7 52230.7 52463.7 42915.6 54543.0 54861.7 55055.7 55220.2 14085.6 14357.4 14363.4 14383.6 14394.7 10591.7 10802.7 10820.7 10878.7 10942.5 16098.6 16605.3 16817.4 16870.5 17189.8 7631.8 7797.7 7803.2 7832.2 7853.0 905.1 923.5 972.2 1060.9 1095.8 26266.7 26505.5 26551.6 26705.0 26732.6 910.3 1002.0 1002.6 1011.6 1013.2 12374.1 12493.6 12572.9 12609.7 13922.9 224609.8 230396.0 230466.0 230845.0 232991.0 46737.8 47002.5 47102.8 47112.0 47211.8 1320.3 1320.4 1320.9 1329.1 1340.1 26123.2 26399.3 26583.7 26825.7 27014.9 41907.4 42460.0 42514.6 42596.4 42603.6 274819.0 277349.0 278375.0 279237.0 281028.0 27610.3 28398.7 29149.3 29344.1 29414.1 34697.0 34916.3 35388.1 35407.3 35432.5 30778.0 32401.8 32526.2 32655.2 32669.8 31655.8 32014.4 32154.2 32535.7 32604.0 32156.7 32545.3 32884.0 32905.5 32906.3 26096.5 28130.3 28273.0 28313.4 28365.3 22029.1 22291.0 22381.6 22399.3 22495.9 18:54:43 INFO - 2015-11-11 18:54:43,385 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,385 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24513.66 Median:4508.48 stddev:81190.40 (1800.8%) stddev-sans-first:81397.82 18:54:43 INFO - 2015-11-11 18:54:43,387 DEBUG : BROWSER_OUTPUT: Values: 311.7 325.8 327.2 328.2 332.0 13143.7 13686.2 13729.5 16077.9 16379.8 15754.8 16207.9 16973.7 17040.0 17200.5 5075.6 5241.2 5247.7 5320.6 5321.9 4364.7 4501.8 4508.9 4558.4 5233.8 4306.9 4442.3 4454.2 4481.9 4492.9 3605.7 4460.8 4468.1 4484.5 4508.1 3769.3 3779.3 3782.8 3817.1 3929.2 11794.4 12413.5 12633.6 12670.4 12756.7 1678.3 1841.4 1866.6 1886.0 1922.4 8820.9 8922.9 8949.5 8995.2 9120.1 1423.3 1478.3 1483.6 1540.9 1549.4 53099.2 53667.2 54081.5 54129.0 54310.7 6235.9 6242.1 6286.7 6286.9 6296.2 7091.1 7092.6 7093.5 7100.8 7129.3 5058.3 5128.4 5153.5 5168.1 5175.6 5455.7 5471.4 5491.1 5504.2 5519.7 2745.6 2748.0 2808.2 2819.8 2822.1 1001.3 1003.8 1004.9 1006.3 1056.0 397.4 427.7 443.4 445.3 451.4 10621.6 11058.7 11157.9 11238.3 11242.9 435.7 435.9 437.4 449.9 450.9 5971.3 6006.6 6043.8 6065.2 6089.5 348193.0 513612.0 527541.0 529393.0 532933.0 65040.3 66273.3 67086.3 67496.3 67503.7 475.1 480.2 481.3 483.1 488.4 10219.0 10356.4 10381.1 10435.2 10438.8 32459.4 33011.3 33035.5 33212.8 33531.7 41007.0 41423.2 43660.8 44807.0 44887.1 5705.3 5836.5 5852.6 5865.8 5891.4 8970.8 10608.0 10686.4 11001.8 11169.1 9298.4 9384.7 9529.5 9568.7 9569.6 9100.4 9238.2 9253.5 9425.8 9524.5 9228.1 9429.5 9717.3 9743.0 9779.9 5682.5 5854.2 5901.8 5931.2 5958.2 9369.4 9376.9 9574.8 9600.6 9603.6 18:54:43 INFO - 2015-11-11 18:54:43,387 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,388 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5258.29 Median:3476.73 stddev:2735.10 (78.7%) stddev-sans-first:2727.88 18:54:43 INFO - 2015-11-11 18:54:43,388 DEBUG : BROWSER_OUTPUT: Values: 1459.7 1675.8 1720.1 1738.5 1739.0 7408.9 7609.5 7700.2 7875.4 7879.7 7656.0 7672.6 7756.2 7763.3 7764.2 2110.5 2154.1 2157.8 2162.3 2163.9 2157.2 2169.9 2180.4 2187.6 2189.0 1859.1 1905.6 2106.1 2113.3 2145.4 2075.1 2090.6 2104.9 2107.0 2113.6 2131.8 2141.5 2142.3 2142.9 2153.2 7521.1 7563.3 7564.3 7584.3 7589.6 4412.4 4508.5 4524.6 4529.3 4549.3 2639.2 2653.3 2723.9 2728.3 2775.9 838.3 1438.7 1463.8 1482.2 1500.1 9954.9 10127.3 10134.2 10149.2 10165.2 4151.9 4192.6 4268.3 4277.3 4294.1 9035.1 9035.5 9036.0 9065.8 9101.2 4766.4 4773.0 4794.1 4796.7 4824.5 4301.6 4317.8 4320.0 4323.6 4327.6 3425.3 3569.8 3578.3 3579.2 3587.0 1077.3 1088.1 1092.8 1095.9 1097.8 847.3 916.8 1021.0 1066.3 1253.3 6780.9 7143.6 7168.9 7184.5 7187.9 618.9 640.3 644.7 645.5 764.9 5406.6 5609.4 5614.9 5618.9 5633.8 8775.0 8805.5 8849.8 9080.8 9084.9 8792.0 8794.6 8810.2 8851.8 8861.0 6888.3 7021.8 7031.9 7052.4 7110.6 7179.3 7191.7 7207.5 7212.9 7243.4 7990.1 8089.8 8154.7 8172.9 8182.5 8198.3 8270.3 8412.4 8432.1 8442.9 6450.5 6456.6 6490.7 6534.5 6551.9 6927.9 6976.4 6984.2 7016.8 7095.5 6471.0 6525.3 6643.2 6686.1 6903.7 6562.1 6583.3 6683.1 6706.9 6752.1 6728.3 6822.1 6840.2 6853.9 6860.2 5836.7 5888.3 5891.3 5897.1 5926.0 5933.2 5936.6 5959.1 6122.2 6334.6 18:54:43 INFO - 2015-11-11 18:54:43,388 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,388 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5190.23 Median:5987.16 stddev:1600.83 (26.7%) stddev-sans-first:1562.56 18:54:43 INFO - 2015-11-11 18:54:43,389 DEBUG : BROWSER_OUTPUT: Values: 293.5 306.2 308.9 312.9 313.2 5930.9 5947.8 5981.5 5994.3 6082.7 5894.5 5904.7 5915.8 5951.1 5992.2 4452.9 4458.9 4462.3 4463.0 4491.5 4465.5 4467.4 4467.5 4476.8 4536.9 4311.4 4439.6 4444.5 4497.3 4523.9 4497.2 4499.0 4507.6 4517.6 4548.0 3822.4 3823.5 3836.9 3838.3 3847.4 5797.6 5824.3 5826.7 5828.1 5837.1 4906.5 5000.3 5073.9 5077.1 5093.4 6086.5 6109.0 6112.2 6118.8 6123.1 4122.1 4126.3 4131.5 4132.4 4137.9 6455.8 6590.2 6594.8 6606.9 6624.5 4121.8 4183.9 4189.7 4191.3 4258.6 4241.2 4248.9 4259.7 4285.3 4286.2 4966.4 4973.1 4985.8 4993.6 5022.0 6130.8 6152.4 6177.7 6184.5 6219.4 1508.3 1521.5 1534.1 1549.0 1559.7 976.7 983.2 996.2 996.2 1002.6 5843.7 5874.9 5888.2 5900.0 5957.7 6309.1 6331.4 6335.0 6345.5 6405.4 5963.5 5982.1 5995.5 6000.6 6075.3 3480.4 3586.2 3597.5 3606.6 3637.1 6654.2 6679.8 6681.3 6694.6 6750.0 6605.9 6616.4 6629.6 6666.3 6694.3 6566.9 6657.4 6680.0 6697.6 6739.9 6455.2 6461.1 6479.4 6524.4 6560.3 6255.0 6267.2 6269.4 6274.0 6346.2 6546.4 6618.4 6636.1 6652.7 6681.9 4193.5 4218.0 4221.9 4232.2 4243.4 6404.6 6417.2 6429.8 6493.8 6494.9 6228.2 6245.7 6256.7 6264.9 6273.2 6160.1 6247.6 6261.3 6283.8 6291.4 5958.3 6093.7 6118.7 6122.4 6154.6 6238.3 6263.4 6382.5 6399.1 6443.2 6219.3 6219.8 6238.6 6241.1 6264.7 18:54:43 INFO - 2015-11-11 18:54:43,389 DEBUG : BROWSER_OUTPUT: 18:54:43 INFO - 2015-11-11 18:54:43,390 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12649.29 Median:542.26 stddev:15664.03 (2888.7%) stddev-sans-first:15681.94 18:54:43 INFO - 2015-11-11 18:54:43,391 DEBUG : BROWSER_OUTPUT: Values: 623.6 650.5 716.8 731.9 758.8 13152.3 13395.0 15273.7 15547.7 15664.4 13876.2 13882.4 13886.2 13936.5 14072.7 821.4 831.6 836.1 845.2 848.7 831.6 835.9 837.8 839.9 846.6 818.3 851.0 852.1 853.8 854.9 839.5 844.3 845.1 846.8 847.6 606.6 607.4 607.9 614.9 620.9 12830.5 12958.2 13000.2 13004.4 13022.3 8973.8 9021.7 9253.6 9644.3 9676.6 8295.6 8393.1 8456.5 8505.2 9210.7 2724.0 2753.4 2772.3 2809.9 2825.8 40259.8 41239.2 41515.4 44954.6 45458.5 6253.1 6268.0 6340.7 6449.5 6519.3 11420.3 11543.9 11548.2 11552.4 11565.2 5709.1 5723.4 5762.2 5870.2 5923.1 3247.1 3327.8 3352.5 3377.3 3394.1 2530.7 2564.2 2568.4 2569.8 2571.6 376.6 381.8 418.1 433.6 433.8 424.9 487.2 513.8 543.2 572.1 7014.3 7184.4 7208.8 7267.3 7349.6 467.4 541.3 554.9 556.9 568.4 3398.3 3428.5 3456.3 3467.9 3501.7 56585.0 57114.0 57379.1 57410.7 57916.4 49469.3 49476.8 49600.8 49607.5 50190.0 43064.9 45393.0 45746.5 45817.3 46279.5 6988.7 7052.2 7225.8 7612.4 7636.1 33275.8 33471.2 33734.5 33775.0 34176.0 44229.0 44744.3 45444.8 46253.0 46658.3 6820.2 7221.2 7237.5 7403.1 7452.6 10913.6 10974.3 11141.3 11223.0 11756.5 10113.4 10169.4 10380.9 10599.8 10605.5 9906.7 10189.2 10435.3 10506.1 10660.3 8538.6 8885.5 9931.6 10061.1 10298.3 8405.3 8549.9 8654.1 8814.2 8838.2 7793.4 7807.3 8113.0 8249.6 8777.6 18:54:43 INFO - 2015-11-11 18:54:43,391 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:54:43 INFO - 2015-11-11 18:54:43,391 DEBUG : BROWSER_OUTPUT: 18:54:44 INFO - 2015-11-11 18:54:44,001 INFO : Browser exited with error code: 0 18:54:44 INFO - 2015-11-11 18:54:44,029 INFO : Completed test dromaeo_css (00:18:30) 18:54:44 INFO - 2015-11-11 18:54:44,029 INFO : Starting test kraken 18:54:44 INFO - 2015-11-11 18:54:44,030 DEBUG : operating with platform_type : mac_ 18:54:44 INFO - 2015-11-11 18:54:44,030 INFO : Initialising browser for kraken test... 18:54:44 INFO - 2015-11-11 18:54:44,042 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpDpIRj0/profile http://localhost:56295/getInfo.html 18:54:47 INFO - 2015-11-11 18:54:47,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:54:47 INFO - 2015-11-11 18:54:47,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:54:47 INFO - 2015-11-11 18:54:47,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:54:47 INFO - 2015-11-11 18:54:47,112 DEBUG : BROWSER_OUTPUT: __metrics 18:54:47 INFO - 2015-11-11 18:54:47,776 INFO : Browser initialized. 18:54:47 INFO - 2015-11-11 18:54:47,777 INFO : Running cycle 1/1 for kraken test... 18:54:47 INFO - 2015-11-11 18:54:47,777 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpDpIRj0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:54:59 INFO - 2015-11-11 18:54:59,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 241025024 18:54:59 INFO - 2015-11-11 18:54:59,949 DEBUG : BROWSER_OUTPUT: 18:55:02 INFO - 2015-11-11 18:55:02,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-beat-detection) 18:55:03 INFO - 2015-11-11 18:55:03,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 258760704 18:55:03 INFO - 2015-11-11 18:55:03,052 DEBUG : BROWSER_OUTPUT: 18:55:05 INFO - 2015-11-11 18:55:05,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-dft) 18:55:06 INFO - 2015-11-11 18:55:06,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 267427840 18:55:06 INFO - 2015-11-11 18:55:06,293 DEBUG : BROWSER_OUTPUT: 18:55:09 INFO - 2015-11-11 18:55:09,197 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-fft) 18:55:09 INFO - 2015-11-11 18:55:09,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 267993088 18:55:09 INFO - 2015-11-11 18:55:09,778 DEBUG : BROWSER_OUTPUT: 18:55:11 INFO - 2015-11-11 18:55:11,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56295/tests/kraken/driver.html?testName=audio-oscillator) 18:55:12 INFO - 2015-11-11 18:55:12,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 268402688 18:55:12 INFO - 2015-11-11 18:55:12,348 DEBUG : BROWSER_OUTPUT: 18:55:14 INFO - 2015-11-11 18:55:14,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:55:15 INFO - 2015-11-11 18:55:15,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 268201984 18:55:15 INFO - 2015-11-11 18:55:15,077 DEBUG : BROWSER_OUTPUT: 18:55:18 INFO - 2015-11-11 18:55:18,177 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-darkroom) 18:55:18 INFO - 2015-11-11 18:55:18,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 268652544 18:55:18 INFO - 2015-11-11 18:55:18,755 DEBUG : BROWSER_OUTPUT: 18:55:21 INFO - 2015-11-11 18:55:21,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56295/tests/kraken/driver.html?testName=imaging-desaturate) 18:55:22 INFO - 2015-11-11 18:55:22,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 268791808 18:55:22 INFO - 2015-11-11 18:55:22,541 DEBUG : BROWSER_OUTPUT: 18:55:25 INFO - 2015-11-11 18:55:25,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56295/tests/kraken/driver.html?testName=json-parse-financial) 18:55:26 INFO - 2015-11-11 18:55:26,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 267358208 18:55:26 INFO - 2015-11-11 18:55:26,124 DEBUG : BROWSER_OUTPUT: 18:55:27 INFO - 2015-11-11 18:55:27,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:55:28 INFO - 2015-11-11 18:55:28,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 267554816 18:55:28 INFO - 2015-11-11 18:55:28,312 DEBUG : BROWSER_OUTPUT: 18:55:30 INFO - 2015-11-11 18:55:30,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:55:30 INFO - 2015-11-11 18:55:30,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 267993088 18:55:30 INFO - 2015-11-11 18:55:30,776 DEBUG : BROWSER_OUTPUT: 18:55:32 INFO - 2015-11-11 18:55:32,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:55:33 INFO - 2015-11-11 18:55:33,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 268177408 18:55:33 INFO - 2015-11-11 18:55:33,492 DEBUG : BROWSER_OUTPUT: 18:55:36 INFO - 2015-11-11 18:55:36,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:55:36 INFO - 2015-11-11 18:55:36,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 268013568 18:55:36 INFO - 2015-11-11 18:55:36,765 DEBUG : BROWSER_OUTPUT: 18:55:39 INFO - 2015-11-11 18:55:39,464 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:55:40 INFO - 2015-11-11 18:55:40,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 268308480 18:55:40 INFO - 2015-11-11 18:55:40,054 DEBUG : BROWSER_OUTPUT: 18:55:41 INFO - 2015-11-11 18:55:41,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56295/tests/kraken/driver.html?testName=ai-astar) 18:55:42 INFO - 2015-11-11 18:55:42,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 267485184 18:55:42 INFO - 2015-11-11 18:55:42,023 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,023 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:55:42 INFO - 2015-11-11 18:55:42,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:55:42 INFO - 2015-11-11 18:55:42,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:55:42 INFO - 2015-11-11 18:55:42,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:55:42 INFO - 2015-11-11 18:55:42,024 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;99;108;109;108;119;109;108;107;107 18:55:42 INFO - 2015-11-11 18:55:42,024 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;130;152;163;131;152;148;129;166;130 18:55:42 INFO - 2015-11-11 18:55:42,024 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;165;165;165;168;169;177;174;180;180 18:55:42 INFO - 2015-11-11 18:55:42,025 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;73;77;66;70;69;69;136;73;77 18:55:42 INFO - 2015-11-11 18:55:42,025 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;90;127;86;88;92;130;93;96;139 18:55:42 INFO - 2015-11-11 18:55:42,026 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;116;123;115;126;130;131;125;125;124 18:55:42 INFO - 2015-11-11 18:55:42,026 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;126;127;126;128;136;136;136;137;138;136 18:55:42 INFO - 2015-11-11 18:55:42,026 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;103;106;112;123;117;111;113;120;115;111 18:55:42 INFO - 2015-11-11 18:55:42,026 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;65;63;63;64;63;65;69;62;66 18:55:42 INFO - 2015-11-11 18:55:42,026 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;68;70;69;70;70;70;73;75 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;87;89;86;89;91;97;94;95;98 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;140;142;139;144;141;144;147;136;143 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;160;154;154;169;155;169;167;168;170 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;73;71;71;71;74;71;71;74;73 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,709 18:55:42 INFO - 2015-11-11 18:55:42,027 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:55:42 INFO - 2015-11-11 18:55:42,028 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296942022__endTimestamp 18:55:42 INFO - 2015-11-11 18:55:42,028 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,028 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:55:42 INFO - 2015-11-11 18:55:42,028 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:55:42 INFO - 2015-11-11 18:55:42,028 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,030 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:4.79 (4.4%) stddev-sans-first:5.07 18:55:42 INFO - 2015-11-11 18:55:42,030 DEBUG : BROWSER_OUTPUT: Values: 109.0 99.0 108.0 109.0 108.0 119.0 109.0 108.0 107.0 107.0 18:55:42 INFO - 2015-11-11 18:55:42,030 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,030 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.00 stddev:14.42 (9.5%) stddev-sans-first:14.88 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: Values: 155.0 130.0 152.0 163.0 131.0 152.0 148.0 129.0 166.0 130.0 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:170.80 Median:171.50 stddev:6.36 (3.7%) stddev-sans-first:6.39 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 165.0 165.0 168.0 169.0 177.0 174.0 180.0 180.0 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,031 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.60 Median:73.00 stddev:20.51 (28.1%) stddev-sans-first:21.73 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: Values: 76.0 73.0 77.0 66.0 70.0 69.0 69.0 136.0 73.0 77.0 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.00 Median:89.50 stddev:20.41 (22.8%) stddev-sans-first:21.01 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 127.0 86.0 88.0 92.0 130.0 93.0 96.0 139.0 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,032 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:123.60 Median:125.00 stddev:5.21 (4.2%) stddev-sans-first:5.44 18:55:42 INFO - 2015-11-11 18:55:42,033 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 123.0 115.0 126.0 130.0 131.0 125.0 125.0 124.0 18:55:42 INFO - 2015-11-11 18:55:42,033 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,033 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:132.60 Median:136.00 stddev:5.10 (3.8%) stddev-sans-first:4.82 18:55:42 INFO - 2015-11-11 18:55:42,033 DEBUG : BROWSER_OUTPUT: Values: 126.0 127.0 126.0 128.0 136.0 136.0 136.0 137.0 138.0 136.0 18:55:42 INFO - 2015-11-11 18:55:42,033 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.10 Median:114.00 stddev:6.03 (5.3%) stddev-sans-first:5.17 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: Values: 103.0 106.0 112.0 123.0 117.0 111.0 113.0 120.0 115.0 111.0 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:2.01 (3.1%) stddev-sans-first:2.13 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 63.0 63.0 64.0 63.0 65.0 69.0 62.0 66.0 18:55:42 INFO - 2015-11-11 18:55:42,034 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,035 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:2.17 (3.1%) stddev-sans-first:2.12 18:55:42 INFO - 2015-11-11 18:55:42,035 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 68.0 70.0 69.0 70.0 70.0 70.0 73.0 75.0 18:55:42 INFO - 2015-11-11 18:55:42,035 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:92.50 stddev:4.17 (4.5%) stddev-sans-first:4.38 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: Values: 90.0 87.0 89.0 86.0 89.0 91.0 97.0 94.0 95.0 98.0 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:142.50 stddev:5.32 (3.7%) stddev-sans-first:3.23 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: Values: 128.0 140.0 142.0 139.0 144.0 141.0 144.0 147.0 136.0 143.0 18:55:42 INFO - 2015-11-11 18:55:42,036 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:167.50 stddev:7.09 (4.2%) stddev-sans-first:7.04 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: Values: 155.0 160.0 154.0 154.0 169.0 155.0 169.0 167.0 168.0 170.0 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.36 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 71.0 71.0 74.0 71.0 71.0 74.0 73.0 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:55:42 INFO - 2015-11-11 18:55:42,037 DEBUG : BROWSER_OUTPUT: 18:55:42 INFO - 2015-11-11 18:55:42,689 INFO : Browser exited with error code: 0 18:55:42 INFO - 2015-11-11 18:55:42,740 INFO : Completed test kraken (00:00:58) 18:55:42 INFO - 2015-11-11 18:55:42,740 INFO : Starting test v8_7 18:55:42 INFO - 2015-11-11 18:55:42,740 DEBUG : operating with platform_type : mac_ 18:55:42 INFO - 2015-11-11 18:55:42,741 INFO : Initialising browser for v8_7 test... 18:55:42 INFO - 2015-11-11 18:55:42,753 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpwcgpWy/profile http://localhost:56295/getInfo.html 18:55:45 INFO - 2015-11-11 18:55:45,747 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:55:45 INFO - 2015-11-11 18:55:45,747 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:55:45 INFO - 2015-11-11 18:55:45,747 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:55:45 INFO - 2015-11-11 18:55:45,747 DEBUG : BROWSER_OUTPUT: __metrics 18:55:46 INFO - 2015-11-11 18:55:46,392 INFO : Browser initialized. 18:55:46 INFO - 2015-11-11 18:55:46,392 INFO : Running cycle 1/1 for v8_7 test... 18:55:46 INFO - 2015-11-11 18:55:46,392 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/T/tmpwcgpWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:55:58 INFO - 2015-11-11 18:55:58,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 240611328 18:55:58 INFO - 2015-11-11 18:55:58,567 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56295/tests/v8_7/run.html (next: http://localhost:56295/tests/v8_7/run.html) 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 261615616 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: |0;Richards;166.5278934221482 18:56:20 INFO - 2015-11-11 18:56:20,267 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;197.12201852946976 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |2;Encrypt;327.11808963035656 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5988.0952380952385 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1173.5052754982414 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |5;Earley;846.1538461538462 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |6;Boyer;13635.135135135135 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |7;RegExp;29705.882352941175 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |8;Splay;622.66500622665 18:56:20 INFO - 2015-11-11 18:56:20,268 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5976.190476190476 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: __startTimestamp1447296980260__endTimestamp 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,269 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: Values: 166.5 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:197.12 Median:197.12 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: Values: 197.1 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:327.12 Median:327.12 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: Values: 327.1 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,270 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5988.10 Median:5988.10 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: Values: 5988.1 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1173.51 Median:1173.51 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: Values: 1173.5 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:846.15 Median:846.15 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: Values: 846.2 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,271 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13635.14 Median:13635.14 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: Values: 13635.1 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29705.88 Median:29705.88 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: Values: 29705.9 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,272 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:622.67 Median:622.67 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: Values: 622.7 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5976.19 Median:5976.19 stddev:0.00 (0.0%) 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: Values: 5976.2 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:56:20 INFO - 2015-11-11 18:56:20,273 DEBUG : BROWSER_OUTPUT: 18:56:20 INFO - 2015-11-11 18:56:20,939 INFO : Browser exited with error code: 0 18:56:20 INFO - 2015-11-11 18:56:20,959 INFO : Completed test v8_7 (00:00:38) 18:56:21 INFO - 2015-11-11 18:56:21,388 INFO : Completed test suite (00:20:08) 18:56:21 INFO - 2015-11-11 18:56:21,389 DEBUG : Working with test: dromaeo_css 18:56:21 INFO - 2015-11-11 18:56:21,389 DEBUG : Generating results file: dromaeo_css 18:56:21 INFO - 2015-11-11 18:56:21,390 DEBUG : Working with test: kraken 18:56:21 INFO - 2015-11-11 18:56:21,390 DEBUG : Generating results file: kraken 18:56:21 INFO - 2015-11-11 18:56:21,390 INFO : javascript benchmark 18:56:21 INFO - 2015-11-11 18:56:21,390 DEBUG : Working with test: v8_7 18:56:21 INFO - 2015-11-11 18:56:21,390 DEBUG : Generating results file: v8_7 18:56:21 INFO - 2015-11-11 18:56:21,390 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:21 INFO - 2015-11-11 18:56:21,451 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 18:56:21 INFO - 2015-11-11 18:56:21,451 DEBUG : process_Request line: dromaeo_css 6252.60 graph.html#tests=[[72,1,57]] 18:56:21 INFO - 2015-11-11 18:56:21,451 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:21 INFO - 2015-11-11 18:56:21,483 DEBUG : process_Request line: kraken 1576.70 graph.html#tests=[[232,1,57]] 18:56:21 INFO - 2015-11-11 18:56:21,483 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:56:21 INFO - 2015-11-11 18:56:21,523 DEBUG : process_Request line: v8_7 19115.55 graph.html#tests=[[230,1,57]] 18:56:21 INFO - 2015-11-11 18:56:21,523 INFO : javascript benchmark 18:56:21 INFO - 2015-11-11 18:56:21,525 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [311.67118689782296, 325.84848045658777, 327.16899076346084, 328.2499488668392, 331.9973679487946, 13143.737125257489, 13686.247256400906, 13729.519466818663, 16077.919610401947, 16379.83620163798, 15754.763678544803, 16207.91896040518, 16973.74539381907, 17040.04039535454, 17200.483985480456, 5075.568576670988, 5241.2400201970695, 5247.711375874344, 5320.574354051667, 5321.893562128756, 4364.738115713051, 4501.774911254441, 4508.864734057984, 4558.430196225472, 5233.816816411427, 4306.913861722764, 4442.289233722605, 4454.220511410506, 4481.910361792762, 4492.910141797162, 3605.729570282226, 4460.754658493782, 4468.061707041526, 4484.506704262529, 4508.098380323916, 3769.3403654360377, 3779.3197224499854, 3782.8486860525823, 3817.0838998640406, 3929.2141571685493, 11794.410279486077, 12413.503459861595, 12633.620991370273, 12670.429830657642, 12756.681082972907, 1678.3454452763433, 1841.4383612998165, 1866.5706887415834, 1886.0, 1922.3944457495984, 8820.911790882074, 8922.876993052445, 8949.463032218087, 8995.235404990584, 9120.087991200893, 1423.2670174859954, 1478.3495262084648, 1483.614260292321, 1540.9306581203873, 1549.3802479008375, 53099.20351194735, 53667.19499207515, 54081.459185408035, 54129.0, 54310.72844635791, 6235.906461403082, 6242.09489624002, 6286.685665716695, 6286.9056964145575, 6296.150019747367, 7091.11361079865, 7092.645367731593, 7093.467989900778, 7100.822479438056, 7129.322714342129, 5058.317127187856, 5128.435872054071, 5153.45888681683, 5168.095583272912, 5175.611829112831, 5455.699936503451, 5471.398146203994, 5491.066518691832, 5504.174373843955, 5519.69641669712, 2745.5881617757495, 2748.0, 2808.1575527341715, 2819.7744180465925, 2822.068717323278, 1001.3090967232587, 1003.7892042670975, 1004.8844382895915, 1006.2503434941016, 1056.0442799266675, 397.41778294797683, 427.6749670250632, 443.388124388342, 445.2808713926985, 451.417671204143, 10621.628243011457, 11058.723531911606, 11157.888421115686, 11238.325700458, 11242.943785281184, 435.7102526819693, 435.8735966569659, 437.38110573538086, 449.910017996402, 450.9233430316854, 5971.343152253248, 6006.579539432285, 6043.8186854394435, 6065.150878876961, 6089.482393996472, 348193.0, 513612.0, 527541.0, 529393.0, 532933.0, 65040.34959650438, 66273.33726662671, 67086.32913670898, 67496.32503674901, 67503.66248168728, 475.11865489516447, 480.2028632470153, 481.3309499795287, 483.06526870505684, 488.4431747807502, 10219.0, 10356.430396327973, 10381.065704086668, 10435.217358697977, 10438.843417348899, 32459.35081298408, 33011.33977320488, 33035.504467432525, 33212.83393583017, 33531.66468335286, 41007.0, 41423.1715365697, 43660.78169609132, 44807.0, 44887.10225795401, 5705.258316418839, 5836.503897168618, 5852.648841069379, 5865.794697185749, 5891.381404952418, 8970.775730606787, 10608.0, 10686.412247326161, 11001.779964400826, 11169.050630696156, 9298.395604285699, 9384.718458446258, 9529.475878826732, 9568.66038754561, 9569.61721531131, 9100.408473449204, 9238.168564829197, 9253.491057991874, 9425.811483770149, 9524.523773811421, 9228.077192280718, 9429.481378524248, 9717.319787615083, 9742.95128524353, 9779.85330220033, 5682.545396368363, 5854.151148083419, 5901.7639294427745, 5931.169636250842, 5958.225430693982, 9369.390989585656, 9376.906230937604, 9574.760630984281, 9600.567974441026, 9603.615855365708], "dojo.html": [3058.434189674909, 3195.744340452764, 3201.5357773122896, 3253.154179913222, 3286.4248756467614, 5116.38603367596, 5227.764750586223, 5259.105951988162, 5297.788088476456, 5299.125644268691, 5048.5203905629, 5154.252633368169, 5168.2764412982215, 5170.172772356424, 5296.947030529694, 4799.880002999918, 4841.8063277468855, 4864.878378040559, 4904.150242059984, 4955.157623204046, 25.970753830201655, 4824.951750482503, 4842.757862106898, 4928.926066109011, 4959.826406075788, 4700.55344742249, 4763.833265835679, 4768.2370820668875, 4815.759212039384, 4851.442084160331, 4832.1543729847135, 4840.273958906192, 4841.346418233528, 4851.029794041206, 4857.902841943177, 4627.537246275346, 4758.143534163849, 4835.395575553056, 4845.588125009378, 4921.4094308682825, 4942.18453955097, 5002.19964805633, 5051.570616497602, 5167.560757335594, 5206.0, 5564.721763911829, 5585.74864131111, 5588.022096133161, 5627.0, 5643.717814109278, 5468.425815289417, 5596.384397716248, 5620.044592419298, 5644.491995720405, 5700.543956483471, 5150.510701483353, 5239.685618862804, 5241.842744717626, 5296.364436267634, 5332.986732520809, 5684.971575142181, 5763.538916886639, 5764.798232061858, 5774.0184168690585, 5792.565557583198, 5368.248445217672, 5391.81128660495, 5510.1459273812625, 5519.254900588449, 5586.357568879631, 5487.2317875497465, 5603.215549823028, 5603.663780173202, 5617.971910140505, 5717.056685646821, 5514.09017512114, 5522.9447705523235, 5533.280673512498, 5542.889142217214, 5544.445555444423, 5254.6847189168775, 5420.457954204548, 5441.238226648273, 5515.090010148361, 5636.436356364331, 4351.456067991501, 4365.192439398721, 4379.627731642846, 4388.495323037828, 4420.557944205554, 3959.742616729903, 3985.980070099689, 3996.5803590623145, 4018.7588744675413, 4056.1887622475624, 5178.870528236749, 5180.7150606717, 5303.151495760737, 5317.6277660564165, 5378.838634840961, 5657.12314591239, 5682.147677848273, 5684.8863022739315, 5697.686627235542, 5728.0, 5016.197408414636, 5339.706316152571, 5340.786368545215, 5342.332208473941, 5389.299391079213, 4858.5384388483035, 4892.510748925079, 4908.533689299511, 4922.778474968635, 4955.677880937727, 5771.30744310677, 5771.797987070517, 5778.711064446845, 5791.131330300404, 5796.82609521715, 5474.698891561003, 5577.77688892456, 5648.85877853057, 5701.543876489954, 5702.287214098238, 5661.716914154358, 5710.486056254957, 5725.08398656213, 5725.484706376279, 5770.480656740746, 5412.675239485643, 5435.0, 5449.046416876951, 5450.727463626882, 5461.044317244546, 5450.127979523258, 5513.751881165437, 5538.16927460868, 5548.306461692288, 5609.747561359667, 5500.80747173847, 5501.257330260363, 5504.146857237135, 5505.091659876236, 5599.860003499945, 5481.725913704378, 5498.477644623755, 5503.422140675171, 5515.145152501369, 5543.9168412474655, 5104.617153713412, 5263.052650522943, 5338.0, 5449.3460784706085, 5509.724513774215, 5438.728063596884, 5493.752781124939, 5509.559235261089, 5525.475079867406, 5525.585581081355, 5271.182966640177, 5402.35171779389, 5432.837014889559, 5440.6735595864375, 5474.808381706621], "mootools.html": [1459.7445447046764, 1675.8407951244628, 1720.122737403924, 1738.5392870889216, 1738.9565260868476, 7408.925910740891, 7609.505382150156, 7700.152983171846, 7875.4487185897015, 7879.684812607496, 7656.042994625672, 7672.578008209546, 7756.185600511935, 7763.340116090125, 7764.18476060014, 2110.493481564425, 2154.149111101114, 2157.7842215778373, 2162.2540223622905, 2163.891805409731, 2157.223399576151, 2169.8698078115362, 2180.3785921012513, 2187.562487502498, 2189.0149432755243, 1859.0983373064053, 1905.5712464695403, 2106.0838535237144, 2113.3342996955985, 2145.410012246637, 2075.1491888325713, 2090.6341390256644, 2104.947376315589, 2107.0202355904426, 2113.556153207836, 2131.79747923947, 2141.4860433496005, 2142.271627646592, 2142.871427714342, 2153.246363772683, 7521.097468303784, 7563.281488258606, 7564.281393267631, 7584.279493448169, 7589.620518974084, 4412.382266482695, 4508.526604706524, 4524.61540769035, 4529.343245229424, 4549.272116461383, 2639.2214296782304, 2653.3234025323613, 2723.8638068096716, 2728.3315587680945, 2775.9028434004913, 838.2539539809575, 1438.6762978329896, 1463.751162302411, 1482.1996122094056, 1500.1074360755333, 9954.90045099547, 10127.341722787995, 10134.239932005203, 10149.238807089498, 10165.237607179492, 4151.91696166075, 4192.622663960258, 4268.274393353137, 4277.2942464493635, 4294.076773493652, 9035.141661542142, 9035.548222588845, 9036.0, 9065.81868362629, 9101.180893719464, 4766.356541866804, 4773.0453909218295, 4794.089123066607, 4796.688215265996, 4824.541668541483, 4301.569843015736, 4317.7841107945105, 4319.956800432018, 4323.567643235651, 4327.6321512671775, 3425.3149370126075, 3569.785812851237, 3578.2664553766417, 3579.2483578448296, 3586.98206508971, 1077.3105212663902, 1088.1240601315858, 1092.814221582333, 1095.9452027398597, 1097.7914196302677, 847.2586486824028, 916.812053529025, 1020.9540570674337, 1066.2642776484201, 1253.3357320620087, 6780.93219067803, 7143.607101609357, 7168.856622867514, 7184.533005354635, 7187.89218161728, 618.8978818494988, 640.2860810196597, 644.687326646576, 645.4642646603309, 764.852720918622, 5406.648567843077, 5609.382967873531, 5614.905093506809, 5618.943810561924, 5633.802816901389, 8775.0, 8805.47167169959, 8849.823003539894, 9080.81838363229, 9084.8637270441, 8792.0, 8794.648214071494, 8810.207081362709, 8851.778705532284, 8860.955695221483, 6888.276730943279, 7021.824454388681, 7031.8945215821805, 7052.400545953651, 7110.608916509642, 7179.282071792779, 7191.676374563052, 7207.531510451804, 7212.927870721225, 7243.420526357773, 7990.081140668665, 8089.757307280791, 8154.714584989734, 8172.918270817216, 8182.549959752271, 8198.344132469507, 8270.297024752963, 8412.369072319478, 8432.114627964222, 8442.915570844212, 6450.451711604378, 6456.644884531396, 6490.675466226576, 6534.509911756542, 6551.901721474277, 6927.89608155868, 6976.441884649114, 6984.196817365864, 7016.7544135954995, 7095.538789978635, 6470.99699546571, 6525.347465253627, 6643.236027856665, 6686.13080299558, 6903.689333979883, 6562.081308616893, 6583.275839657729, 6683.131192944886, 6706.93293067063, 6752.054712340178, 6728.3271672832325, 6822.11312529368, 6840.213375461885, 6853.9314606853295, 6860.245373009065, 5836.678982655994, 5888.263967004124, 5891.263592050994, 5897.144913987362, 5925.99258126111, 5933.199018132497, 5936.5844390892225, 5959.135925290895, 6122.173506576733, 6334.556581039283], "ext.html": [517.3352242368558, 542.574079347712, 552.1827695011384, 557.637535601859, 565.4373897971519, 35624.821875890615, 36076.098097547576, 36243.0, 36252.456213156824, 36809.44785828215, 39328.60671393285, 39440.40839387412, 39447.0, 39491.60508394915, 39989.60010399895, 8717.91282087179, 8863.867041994376, 8949.015608283084, 8974.326925480582, 8982.10178982103, 8633.309335253165, 8790.824183516326, 8811.691590794324, 8820.426672266314, 8841.60212790426, 8680.826383472328, 8773.868391974125, 8806.515641639708, 8830.47017178968, 8875.644974201025, 8760.25537829282, 8820.955895220546, 8835.0, 8866.689665861728, 8943.418677785923, 8632.56837158146, 8770.210681038738, 8777.64889404423, 8788.73633790981, 8877.866831997526, 36388.81805590982, 36862.0, 36864.262714745826, 36916.63083369159, 37429.62570374289, 2413.2398294537165, 2674.897119341558, 2834.390606019695, 2948.6461624605186, 3558.3061303045915, 25109.37226569332, 25308.240752777445, 25545.23364299074, 26072.8696356517, 26340.60489092665, 2188.3106821351384, 2188.792064753846, 2204.9779502204933, 2206.8124209442058, 2208.514126892081, 234453.0, 236401.0, 236731.99999999828, 236775.0, 237483.0, 44985.325220121726, 52014.0, 52140.739296303276, 52230.738846305525, 52463.73768131135, 42915.57084429178, 54543.0, 54861.725691371284, 55055.72472137614, 55220.17169742457, 14085.577432677037, 14357.425702971974, 14363.353649085817, 14383.640408989859, 14394.712105757826, 10591.682249532527, 10802.729931751612, 10820.729481763019, 10878.673639790819, 10942.4528773561, 16098.597535061483, 16605.252763625667, 16817.41139060127, 16870.493885183463, 17189.82810171907, 7631.847363052819, 7797.688092476237, 7803.180666030099, 7832.198594323338, 7853.0, 905.1129892705054, 923.5428462910768, 972.1736523954723, 1060.8939106089483, 1095.7644106517137, 26266.737332626428, 26505.46989060208, 26551.601725974127, 26705.0, 26732.59901101485, 910.3354551177545, 1002.013017178079, 1002.6340385759291, 1011.6054738651932, 1013.1843865688045, 12374.13381063317, 12493.625191244277, 12572.874271257353, 12609.747805044031, 13922.930385348009, 224609.75390245888, 230396.0, 230466.0, 230845.0, 232991.0, 46737.7663111689, 47002.5299747005, 47102.76448617735, 47112.0, 47211.76394118008, 1320.320035181882, 1320.445412926554, 1320.9075364724376, 1329.1094966372361, 1340.095435580979, 26123.216303510926, 26399.34001649974, 26583.734162658126, 26825.731742682325, 27014.864925675247, 41907.37138942979, 42460.0, 42514.57485425106, 42596.36105458358, 42603.5739642612, 274819.0, 277349.0, 278375.0, 279237.0, 281028.0, 27610.309742256606, 28398.716012840432, 29149.271268218465, 29344.11967640974, 29414.11757647274, 34697.0, 34916.30167396587, 35388.11529711778, 35407.29185416226, 35432.46851297181, 30778.0, 32401.837990809894, 32526.186845329055, 32655.18362040873, 32669.836650816593, 31655.84172079125, 32014.35971280608, 32154.196145095622, 32535.674643253264, 32604.0, 32156.67843321537, 32545.34909301848, 32884.01347959565, 32905.50641740328, 32906.341873161924, 26096.478070438865, 28130.2967425816, 28273.0, 28313.43373132567, 28365.290867727646, 22029.118835247053, 22291.0, 22381.552368952205, 22399.32802015877, 22495.887520562294], "prototype.html": [293.5186294477058, 306.1702785451427, 308.857925354337, 312.8533923171576, 313.2122711380876, 5930.851728706784, 5947.821565353041, 5981.5214782817375, 5994.280686317648, 6082.695865206733, 5894.528437724972, 5904.675242861641, 5915.822525324247, 5951.137085122655, 5992.22101126854, 4452.910941781162, 4458.910821783563, 4462.330650402433, 4462.955370446302, 4491.528389519102, 4465.486469056068, 4467.396901418299, 4467.530909254514, 4476.776161191944, 4536.886577835564, 4311.396404503372, 4439.644828413735, 4444.511103778582, 4497.302918047708, 4523.886902827439, 4497.190505708971, 4498.955010449887, 4507.57178068083, 4517.570830771088, 4548.0221752323405, 3822.388417853158, 3823.4647149399107, 3836.865709700175, 3838.2899163654815, 3847.365184744514, 5797.565182611321, 5824.271966004249, 5826.737796799154, 5828.06750919855, 5837.09525023622, 4906.509349065101, 5000.349954505928, 5073.949260507385, 5077.086124497589, 5093.414257360377, 6086.543509236825, 6109.0, 6112.205413296288, 6118.8164355068975, 6123.08153776937, 4122.093139509333, 4126.277901367279, 4131.5042194936495, 4132.380142978547, 4137.91724165515, 6455.806325810233, 6590.209174899042, 6594.802155935329, 6606.93393066068, 6624.470042396645, 4121.752694838319, 4183.874483765492, 4189.748615083105, 4191.3293872980785, 4258.552851950501, 4241.2365774160335, 4248.851290204828, 4259.701820872571, 4285.292926667065, 4286.207051695446, 4966.354373931365, 4973.055119527278, 4985.750712464363, 4993.550580447704, 5022.0, 6130.785422510191, 6152.384761523812, 6177.69111544421, 6184.536159788034, 6219.440250377397, 1508.2986411318789, 1521.5435369389138, 1534.1255484374024, 1548.9767653485208, 1559.7036563052984, 976.72651657536, 983.2281658897731, 996.1731762636994, 996.2179688944144, 1002.6039714312806, 5843.737031833578, 5874.94125058744, 5888.175655408247, 5900.026495628259, 5957.672328022, 6309.116723658692, 6331.398517140864, 6335.0, 6345.49236061114, 6405.423511883952, 5963.522918166536, 5982.102684597346, 5995.52035837132, 6000.609960352563, 6075.301340345828, 3480.4257297545623, 3586.1751797086295, 3597.460380942827, 3606.5852426971232, 3637.0725465006785, 6654.201495820435, 6679.799606011828, 6681.298463661343, 6694.564853284521, 6750.0212469192675, 6605.900911486331, 6616.371444712745, 6629.635370054597, 6666.266710661824, 6694.297098804653, 6566.934330656728, 6657.400833924873, 6679.966600167065, 6697.598144111369, 6739.93260067393, 6455.225372955276, 6461.0954466373805, 6479.384458476437, 6524.380183882524, 6560.343965603593, 6254.9687251563455, 6267.1539342188225, 6269.435750782452, 6273.96863015682, 6346.2067241594805, 6546.443552298108, 6618.437432818265, 6636.13730215069, 6652.667366631552, 6681.933180668326, 4193.496780386373, 4217.97891010543, 4221.852235171754, 4232.195882782262, 4243.384709217208, 6404.647744374104, 6417.197850268716, 6429.839254018687, 6493.772717954849, 6494.870102598016, 6228.22147231596, 6245.687715614292, 6256.718447669957, 6264.906026409699, 6273.247210334789, 6160.10678451631, 6247.5939063960695, 6261.342559031418, 6283.8114856554375, 6291.433770960635, 5958.255218097738, 6093.664848433379, 6118.724657390517, 6122.448979591858, 6154.569180157346, 6238.251409830849, 6263.3736626337, 6382.521310901608, 6399.072134540373, 6443.194600674916, 6219.284782249918, 6219.813405597839, 6238.625682459067, 6241.126242325987, 6264.655443950444], "yui.html": [623.6414061914401, 650.4926157597076, 716.8064622551911, 731.9414446844252, 758.7761610324956, 13152.276624785633, 13395.0, 15273.694526109484, 15547.68904621907, 15664.373425062984, 13876.236806975612, 13882.444702211924, 13886.166829990208, 13936.512222072204, 14072.71854562908, 821.3839620284787, 831.5717405536138, 836.0510820219034, 845.1970627903486, 848.7199224256011, 831.6091437024588, 835.9498430094184, 837.7989282572199, 839.8824164616958, 846.551327796269, 818.3289702443998, 851.0213254757048, 852.1478521478522, 853.7950891785989, 854.8546747052985, 839.4669384940546, 844.2992316377423, 845.1252953193446, 846.7756044648173, 847.5931552854634, 606.5875204860693, 607.3744043635063, 607.8662694207311, 614.8962612111271, 620.8851362497952, 12830.486780528861, 12958.22250664963, 13000.154989925624, 13004.414801333962, 13022.283774392405, 8973.820523589491, 9021.729348119567, 9253.583588738456, 9644.324897257195, 9676.56455459506, 8295.585220739, 8393.118722534167, 8456.492610443393, 8505.192006759347, 9210.723678289662, 2724.0320823844104, 2753.408017276275, 2772.265349682336, 2809.887604495818, 2825.7973747623973, 40259.79870100631, 41239.1752164955, 41515.377269340985, 44954.550454495366, 45458.54541454576, 6253.1245625612455, 6268.0, 6340.714667839959, 6449.451796597248, 6519.282878883319, 11420.257683250562, 11543.942280288546, 11548.191626586058, 11552.422378881023, 11565.19043666952, 5709.086546152679, 5723.427657234327, 5762.164486149485, 5870.207521984563, 5923.08192230205, 3247.0908145719236, 3327.8003319800405, 3352.4636058230567, 3377.257003459235, 3394.096749099463, 2530.683664541932, 2564.230730780758, 2568.4349443122483, 2569.832960857538, 2571.5756900111646, 376.55002272284906, 381.8148198123908, 418.1073408273358, 433.60541906864603, 433.8416477985576, 424.9235137675248, 487.24720307125574, 513.82273115775, 543.2177664163592, 572.0903763016823, 7014.263502332284, 7184.425245980309, 7208.783736487913, 7267.273272672691, 7349.55902645843, 467.4040598237207, 541.3017207801892, 554.8696056426736, 556.866352075499, 568.4031766645006, 3398.2523844754114, 3428.468587368962, 3456.326016426823, 3467.9133021674156, 3501.6673416025437, 56585.0, 57114.0, 57379.13931291034, 57410.712946435, 57916.42083579195, 49469.257961130614, 49476.752616236685, 49600.751996239786, 49607.503924960285, 50190.0, 43064.9233769152, 45393.0, 45746.542534574895, 45817.312740308924, 46279.5372046282, 6988.685509152202, 7052.188998265266, 7225.819354515969, 7612.352949999091, 7636.08366995964, 33275.83362083174, 33471.16322091967, 33734.49398259077, 33775.0, 34176.0, 44229.0, 44744.328835068154, 45444.772776135906, 46253.0, 46658.300125497466, 6820.215675197217, 7221.241769614325, 7237.493375463667, 7403.111626604842, 7452.590107543921, 10913.618023369145, 10974.341539507335, 11141.275817071864, 11223.0, 11756.529738810352, 10113.393196408239, 10169.44068076263, 10380.896191037993, 10599.788004240027, 10605.469726513798, 9906.702798916043, 10189.184865210616, 10435.269531132748, 10506.106980906403, 10660.307080039773, 8538.615762290836, 8885.4668719877, 9931.602735890772, 10061.144802691853, 10298.330608510423, 8405.318742968646, 8549.914500854911, 8654.091320411519, 8814.206721395105, 8838.160374764388, 7793.399600006102, 7807.258310460497, 8112.959435203023, 8249.628766705393, 8777.561121943749]}, "summary": {"lowerIsBetter": false, "suite": 6252.594058417215, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6330.142263516631, "unit": "ms", "value": 6330.142263516631}, "dojo.html": {"lowerIsBetter": false, "filtered": 5146.327466679901, "unit": "ms", "value": 5146.327466679901}, "mootools.html": {"lowerIsBetter": false, "filtered": 4287.713503489546, "unit": "ms", "value": 4287.713503489546}, "ext.html": {"lowerIsBetter": false, "filtered": 16690.14607294525, "unit": "ms", "value": 16690.14607294525}, "prototype.html": {"lowerIsBetter": false, "filtered": 4657.445227616042, "unit": "ms", "value": 4657.445227616042}, "yui.html": {"lowerIsBetter": false, "filtered": 5502.767259158355, "unit": "ms", "value": 5502.767259158355}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447295773, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111163445", "branch": "Firefox", "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8"}}, {"talos_counters": {}, "results": {"audio-dft": [165.0, 165.0, 165.0, 165.0, 168.0, 169.0, 177.0, 174.0, 180.0, 180.0], "ai-astar": [109.0, 99.0, 108.0, 109.0, 108.0, 119.0, 109.0, 108.0, 107.0, 107.0], "imaging-gaussian-blur": [121.0, 116.0, 123.0, 115.0, 126.0, 130.0, 131.0, 125.0, 125.0, 124.0], "audio-beat-detection": [155.0, 130.0, 152.0, 163.0, 131.0, 152.0, 148.0, 129.0, 166.0, 130.0], "json-stringify-tinderbox": [68.0, 71.0, 68.0, 70.0, 69.0, 70.0, 70.0, 70.0, 73.0, 75.0], "stanford-crypto-pbkdf2": [155.0, 160.0, 154.0, 154.0, 169.0, 155.0, 169.0, 167.0, 168.0, 170.0], "json-parse-financial": [64.0, 65.0, 63.0, 63.0, 64.0, 63.0, 65.0, 69.0, 62.0, 66.0], "stanford-crypto-sha256-iterative": [73.0, 73.0, 71.0, 71.0, 71.0, 74.0, 71.0, 71.0, 74.0, 73.0], "audio-fft": [76.0, 73.0, 77.0, 66.0, 70.0, 69.0, 69.0, 136.0, 73.0, 77.0], "imaging-darkroom": [126.0, 127.0, 126.0, 128.0, 136.0, 136.0, 136.0, 137.0, 138.0, 136.0], "stanford-crypto-ccm": [128.0, 140.0, 142.0, 139.0, 144.0, 141.0, 144.0, 147.0, 136.0, 143.0], "audio-oscillator": [89.0, 90.0, 127.0, 86.0, 88.0, 92.0, 130.0, 93.0, 96.0, 139.0], "stanford-crypto-aes": [90.0, 87.0, 89.0, 86.0, 89.0, 91.0, 97.0, 94.0, 95.0, 98.0], "imaging-desaturate": [103.0, 106.0, 112.0, 123.0, 117.0, 111.0, 113.0, 120.0, 115.0, 111.0]}, "summary": {"lowerIsBetter": true, "suite": 1576.7, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.6, "unit": "ms", "value": 78.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 162.1, "unit": "ms", "value": 162.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 140.4, "unit": "ms", "value": 140.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 132.6, "unit": "ms", "value": 132.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 64.4, "unit": "ms", "value": 64.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.0, "unit": "ms", "value": 103.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.3, "unit": "ms", "value": 108.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 170.8, "unit": "ms", "value": 170.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.2, "unit": "ms", "value": 72.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.4, "unit": "ms", "value": 70.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 123.6, "unit": "ms", "value": 123.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 91.6, "unit": "ms", "value": 91.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 113.1, "unit": "ms", "value": 113.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447295773, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111163445", "branch": "Firefox", "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [197.12201852946976], "Encrypt": [327.11808963035656], "NavierStokes": [5976.190476190476], "Decrypt": [5988.0952380952385], "Splay": [622.66500622665], "Richards": [166.5278934221482], "RegExp": [29705.882352941175], "Earley": [846.1538461538462], "Boyer": [13635.135135135135], "RayTrace": [1173.5052754982414]}, "summary": {"lowerIsBetter": false, "suite": 19115.55017897747, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 335.4166139999999, "unit": "score", "value": 335.4166139999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 813.715317, "unit": "score", "value": 813.715317}, "NavierStokes": {"lowerIsBetter": false, "filtered": 248.31872509960152, "unit": "score", "value": 248.31872509960152}, "Decrypt": {"lowerIsBetter": false, "filtered": 44.451697813121285, "unit": "score", "value": 44.451697813121285}, "Splay": {"lowerIsBetter": false, "filtered": 130.874546, "unit": "score", "value": 130.874546}, "RegExp": {"lowerIsBetter": false, "filtered": 30.66682178217823, "unit": "score", "value": 30.66682178217823}, "Richards": {"lowerIsBetter": false, "filtered": 211.98851000000005, "unit": "score", "value": 211.98851000000005}, "Earley": {"lowerIsBetter": false, "filtered": 787.6380909090906, "unit": "score", "value": 787.6380909090906}, "Boyer": {"lowerIsBetter": false, "filtered": 48.87835678889987, "unit": "score", "value": 48.87835678889987}, "RayTrace": {"lowerIsBetter": false, "filtered": 630.5800369630373, "unit": "score", "value": 630.5800369630373}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0077.e"}, "testrun": {"date": 1447295773, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111163445", "branch": "Firefox", "revision": "8bf46ba0297dfecfdbae08edc1166d8a10bbadf8"}}] 18:56:21 INFO - RETURN: dromaeo_css: 6252.60 18:56:21 INFO - RETURN: kraken: 1576.70 18:56:21 INFO - RETURN: v8_7: 19115.55 18:56:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "19115.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1576.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6252.60"}}} 18:56:21 INFO - Return code: 0 18:56:21 INFO - # TBPL SUCCESS # 18:56:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:56:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:56:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:56:21 INFO - 2015-11-11 18:56:21.664 screenresolution[1949:20832] starting screenresolution argv=screenresolution get 18:56:21 INFO - 2015-11-11 18:56:21.667 screenresolution[1949:20832] Display 0: 1600x1200x32@60 18:56:21 INFO - 2015-11-11 18:56:21.673 screenresolution[1950:20835] starting screenresolution argv=screenresolution list 18:56:21 INFO - Available Modes on Display 0 18:56:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:56:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:56:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:56:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:56:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:56:21 INFO - Intel HD Graphics 3000: 18:56:21 INFO - Chipset Model: Intel HD Graphics 3000 18:56:21 INFO - Type: GPU 18:56:21 INFO - Bus: Built-In 18:56:21 INFO - VRAM (Total): 512 MB 18:56:21 INFO - VRAM (Dynamic, Max): 10 18:56:21 INFO - Vendor: Intel (0x8086) 18:56:21 INFO - Device ID: 0x0116 18:56:21 INFO - Revision ID: 0x0009 18:56:21 INFO - Displays: 18:56:21 INFO - Display: 18:56:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:56:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:56:21 INFO - Display Serial Number: 1600x1200 60 18:56:21 INFO - Main Display: Yes 18:56:21 INFO - Mirror: Off 18:56:21 INFO - Online: Yes 18:56:21 INFO - Rotation: Supported 18:56:21 INFO - Return code: 0 18:56:21 INFO - Running post-action listener: _resource_record_post_action 18:56:21 INFO - Running post-run listener: _resource_record_post_run 18:56:23 INFO - Total resource usage - Wall time: 1246s; CPU: 30.0%; Read bytes: 53248; Write bytes: 689665024; Read time: 370; Write time: 57762 18:56:23 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 338602496; Write bytes: 334243840; Read time: 32671; Write time: 5167 18:56:23 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 49152; Write bytes: 343862272; Read time: 358; Write time: 51290 18:56:23 INFO - Running post-run listener: _upload_blobber_files 18:56:23 INFO - Blob upload gear active. 18:56:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:56:23 INFO - Copying logs to upload dir... 18:56:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1299.177847 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2015-11-11 18:56:23.080107) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:56:23.084051) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010034 build_url: 'https://queue.taskcluster.net/v1/task/__h0cZnORsGuyUVdMFB__A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:56:23.109752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:56:23.110080) ========= 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.D95RKGxshl/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.9GJLioVyln/Listeners TMPDIR=/var/folders/bh/sbv5nmp57tg4mhkh5bhp853r00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005230 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:56:23.159563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:56:23.159923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:56:23.160329) ========= ========= Total master_lag: 0.23 =========