builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0057 starttime: 1447714608.45 results: success (0) buildid: 20151116131535 builduid: 32f7adbe6b6542af900c4c9d6084ff36 revision: 4e0d0bf80b36e05be962ef860cbd62b63fe8b245 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.453615) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.454150) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.454508) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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.006109 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.525759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.526179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.556539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.557065) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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.021136 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.607645) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.608014) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.608478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:48.608821) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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-16 14:56:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.85M=0.001s 2015-11-16 14:56:48 (8.85 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.219880 ========= master_lag: 0.41 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.240264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.240650) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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.062185 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.321564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.321968) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4e0d0bf80b36e05be962ef860cbd62b63fe8b245 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4e0d0bf80b36e05be962ef860cbd62b63fe8b245 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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-16 14:56:49,415 truncating revision to first 12 chars 2015-11-16 14:56:49,415 Setting DEBUG logging. 2015-11-16 14:56:49,416 attempt 1/10 2015-11-16 14:56:49,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4e0d0bf80b36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 14:56:49,674 unpacking tar archive at: fx-team-4e0d0bf80b36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.957669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.958028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.974652) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.974993) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 14:56:49.975495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-16 14:56:49.975829) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:56:50 INFO - MultiFileLogger online at 20151116 14:56:50 in /builds/slave/test 14:56:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:56:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:56:50 INFO - {'append_to_log': False, 14:56:50 INFO - 'base_work_dir': '/builds/slave/test', 14:56:50 INFO - 'blob_upload_branch': 'Fx-Team', 14:56:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:56:50 INFO - 'branch': 'Fx-Team', 14:56:50 INFO - 'buildbot_json_path': 'buildprops.json', 14:56:50 INFO - 'config_files': ('talos/mac_config.py',), 14:56:50 INFO - 'default_actions': ('clobber', 14:56:50 INFO - 'read-buildbot-config', 14:56:50 INFO - 'download-and-extract', 14:56:50 INFO - 'populate-webroot', 14:56:50 INFO - 'create-virtualenv', 14:56:50 INFO - 'install', 14:56:50 INFO - 'run-tests'), 14:56:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:56:50 INFO - 'download_minidump_stackwalk': True, 14:56:50 INFO - 'download_symbols': 'ondemand', 14:56:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:56:50 INFO - 'tooltool.py': '/tools/tooltool.py', 14:56:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:56:50 INFO - '/tools/misc-python/virtualenv.py')}, 14:56:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:56:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:56:50 INFO - 'installer_path': 'installer.exe', 14:56:50 INFO - 'log_level': 'info', 14:56:50 INFO - 'log_name': 'talos', 14:56:50 INFO - 'log_to_console': True, 14:56:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:56:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:56:50 INFO - 'opt_config_files': (), 14:56:50 INFO - 'pip_index': False, 14:56:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:56:50 INFO - 'cmd': ('bash', 14:56:50 INFO - '-c', 14:56:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:56:50 INFO - 'enabled': True, 14:56:50 INFO - 'halt_on_failure': False, 14:56:50 INFO - 'name': 'check_screen_resolution'},), 14:56:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:56:50 INFO - 'cmd': ('bash', 14:56:50 INFO - '-c', 14:56:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:56:50 INFO - 'enabled': True, 14:56:50 INFO - 'halt_on_failure': False, 14:56:50 INFO - 'name': 'check_screen_resolution'},), 14:56:50 INFO - 'run_cmd_checks_enabled': True, 14:56:50 INFO - 'sps_profile': False, 14:56:50 INFO - 'sps_profile_interval': 0, 14:56:50 INFO - 'suite': 'dromaeojs-e10s', 14:56:50 INFO - 'system_bits': '64', 14:56:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:56:50 INFO - 'title': 't-yosemite-r5-0057', 14:56:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:56:50 INFO - 'use_talos_json': True, 14:56:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:56:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:56:50 INFO - 'work_dir': 'build'} 14:56:50 INFO - ##### 14:56:50 INFO - ##### Running clobber step. 14:56:50 INFO - ##### 14:56:50 INFO - Running pre-action listener: _resource_record_pre_action 14:56:50 INFO - Running main action method: clobber 14:56:50 INFO - rmtree: /builds/slave/test/build 14:56:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:56:53 INFO - Running post-action listener: _resource_record_post_action 14:56:53 INFO - ##### 14:56:53 INFO - ##### Running read-buildbot-config step. 14:56:53 INFO - ##### 14:56:53 INFO - Running pre-action listener: _resource_record_pre_action 14:56:53 INFO - Running main action method: read_buildbot_config 14:56:53 INFO - Using buildbot properties: 14:56:53 INFO - { 14:56:53 INFO - "properties": { 14:56:53 INFO - "buildnumber": 50, 14:56:53 INFO - "product": "firefox", 14:56:53 INFO - "script_repo_revision": "production", 14:56:53 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 14:56:53 INFO - "repository": "", 14:56:53 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 14:56:53 INFO - "buildid": "20151116131535", 14:56:53 INFO - "slavename": "t-yosemite-r5-0057", 14:56:53 INFO - "pgo_build": "False", 14:56:53 INFO - "basedir": "/builds/slave/test", 14:56:53 INFO - "project": "", 14:56:53 INFO - "platform": "yosemite", 14:56:53 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:56:53 INFO - "slavebuilddir": "test", 14:56:53 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:56:53 INFO - "branch": "fx-team", 14:56:53 INFO - "repo_path": "integration/fx-team", 14:56:53 INFO - "stage_platform": "macosx64", 14:56:53 INFO - "builduid": "32f7adbe6b6542af900c4c9d6084ff36", 14:56:53 INFO - "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245" 14:56:53 INFO - }, 14:56:53 INFO - "sourcestamp": { 14:56:53 INFO - "repository": "", 14:56:53 INFO - "hasPatch": false, 14:56:53 INFO - "project": "", 14:56:53 INFO - "branch": "fx-team-macosx64-talos", 14:56:53 INFO - "changes": [ 14:56:53 INFO - { 14:56:53 INFO - "category": null, 14:56:53 INFO - "files": [ 14:56:53 INFO - { 14:56:53 INFO - "url": null, 14:56:53 INFO - "name": "https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 14:56:53 INFO - } 14:56:53 INFO - ], 14:56:53 INFO - "repository": "", 14:56:53 INFO - "rev": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245", 14:56:53 INFO - "who": "mozilla@noorenberghe.ca", 14:56:53 INFO - "when": 1447713714, 14:56:53 INFO - "number": 6668340, 14:56:53 INFO - "comments": "Bug 1165807 - display WeakSet and WeakMap contents in console; r=bz,fitzgen", 14:56:53 INFO - "project": "", 14:56:53 INFO - "at": "Mon 16 Nov 2015 14:41:54", 14:56:53 INFO - "branch": "fx-team-macosx64-talos", 14:56:53 INFO - "revlink": "", 14:56:53 INFO - "properties": [ 14:56:53 INFO - [ 14:56:53 INFO - "buildid", 14:56:53 INFO - "20151116131535", 14:56:53 INFO - "Change" 14:56:53 INFO - ], 14:56:53 INFO - [ 14:56:53 INFO - "builduid", 14:56:53 INFO - "32f7adbe6b6542af900c4c9d6084ff36", 14:56:53 INFO - "Change" 14:56:53 INFO - ], 14:56:53 INFO - [ 14:56:53 INFO - "pgo_build", 14:56:53 INFO - "False", 14:56:53 INFO - "Change" 14:56:53 INFO - ] 14:56:53 INFO - ], 14:56:53 INFO - "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245" 14:56:53 INFO - } 14:56:53 INFO - ], 14:56:53 INFO - "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245" 14:56:53 INFO - } 14:56:53 INFO - } 14:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 14:56:53 INFO - Running post-action listener: _resource_record_post_action 14:56:53 INFO - ##### 14:56:53 INFO - ##### Running download-and-extract step. 14:56:53 INFO - ##### 14:56:53 INFO - Running pre-action listener: _resource_record_pre_action 14:56:53 INFO - Running main action method: download_and_extract 14:56:53 INFO - mkdir: /builds/slave/test/build/tests 14:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:53 INFO - https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/test_packages.json 14:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/test_packages.json 14:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:56:54 INFO - Downloaded 1149 bytes. 14:56:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:56:54 INFO - Using the following test package requirements: 14:56:54 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:56:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 14:56:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'jsshell-mac.zip'], 14:56:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 14:56:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:56:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 14:56:54 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 14:56:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 14:56:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 14:56:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 14:56:54 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 14:56:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:56: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')]} 14:56:54 INFO - https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:56:55 INFO - Downloaded 17460649 bytes. 14:56: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 14:56:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:56:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:57:01 INFO - Return code: 0 14:57:01 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 14:57:01 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')]} 14:57:01 INFO - https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:57:02 INFO - Downloaded 17460649 bytes. 14:57:02 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 14:57:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 14:57:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 14:57:08 INFO - Return code: 0 14:57:08 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')]} 14:57:08 INFO - https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:57:09 INFO - Downloaded 11131693 bytes. 14:57:09 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 14:57:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 14:57:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 14:57:09 INFO - Return code: 0 14:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:09 INFO - https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 14:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/3j5wJpciR9-ZSG8DcC1F5w/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 14:57:13 INFO - Downloaded 108688052 bytes. 14:57:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:57:13 INFO - mkdir: /builds/slave/test/properties 14:57:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:13 INFO - Contents: 14:57:13 INFO - build_url:https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 14:57:13 INFO - Running post-action listener: _resource_record_post_action 14:57:13 INFO - Running post-action listener: set_extra_try_arguments 14:57:13 INFO - ##### 14:57:13 INFO - ##### Running populate-webroot step. 14:57:13 INFO - ##### 14:57:13 INFO - Running pre-action listener: _resource_record_pre_action 14:57:13 INFO - Running main action method: populate_webroot 14:57:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:57:13 INFO - '../fennec_ids.txt'], 14:57:13 INFO - 'tests': ['tcheck2']}, 14:57:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:13 INFO - '--tppagecycles', 14:57:13 INFO - '7'], 14:57:13 INFO - 'tests': ['tsvgm']}}, 14:57:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:57:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:57:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:57:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'tests': ['damp', 'tps']}, 14:57:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['damp', 'tps']}, 14:57:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:57:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:13 INFO - 'other': {'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'other_l64': {'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'other_nol64': {'tests': ['a11yr', 14:57:13 INFO - 'ts_paint', 14:57:13 INFO - 'tpaint', 14:57:13 INFO - 'sessionrestore', 14:57:13 INFO - 'sessionrestore_no_auto_restore']}, 14:57:13 INFO - 'svgr': {'tests': ['tsvgx', 14:57:13 INFO - 'tsvgr_opacity', 14:57:13 INFO - 'tart', 14:57:13 INFO - 'tscrollx', 14:57:13 INFO - 'cart']}, 14:57:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['tsvgx', 14:57:13 INFO - 'tsvgr_opacity', 14:57:13 INFO - 'tart', 14:57:13 INFO - 'tscrollx', 14:57:13 INFO - 'cart']}, 14:57:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'tests': ['tp5o']}, 14:57:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'talos_options': ['--e10s'], 14:57:13 INFO - 'tests': ['tp5o']}, 14:57:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'talos_options': ['--xperf_path', 14:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:13 INFO - 'tests': ['tp5n']}, 14:57:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:13 INFO - 'talos_options': ['--e10s', 14:57:13 INFO - '--xperf_path', 14:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:13 INFO - 'tests': ['tp5n']}}, 14:57:13 INFO - 'talos.zip': {'path': '', 14:57:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:13 INFO - Running post-action listener: _resource_record_post_action 14:57:13 INFO - ##### 14:57:13 INFO - ##### Running create-virtualenv step. 14:57:13 INFO - ##### 14:57:13 INFO - Running pre-action listener: _resource_record_pre_action 14:57:13 INFO - Running main action method: create_virtualenv 14:57:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:13 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 14:57:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:13 INFO - Using real prefix '/tools/python27' 14:57:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:19 INFO - Installing pip.................done. 14:57:19 INFO - Return code: 0 14:57:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:57: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')]} 14:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57: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', 'pip>=1.5'] in /builds/slave/test/build 14:57: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 pip>=1.5 14:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:19 INFO - 'HOME': '/Users/cltbld', 14:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:19 INFO - 'LOGNAME': 'cltbld', 14:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:19 INFO - 'MOZ_NO_REMOTE': '1', 14:57:19 INFO - 'NO_EM_RESTART': '1', 14:57:19 INFO - 'PAGER': '/bin/cat', 14:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:19 INFO - 'PWD': '/builds/slave/test', 14:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:19 INFO - 'SHELL': '/bin/bash', 14:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:19 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:19 INFO - 'USER': 'cltbld', 14:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:19 INFO - 'XPC_FLAGS': '0x0', 14:57:19 INFO - 'XPC_SERVICE_NAME': '0', 14:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:20 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 14:57:20 INFO - Cleaning up... 14:57:20 INFO - Return code: 0 14:57:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:20 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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:20 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 14:57:20 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 14:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:20 INFO - 'HOME': '/Users/cltbld', 14:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:20 INFO - 'LOGNAME': 'cltbld', 14:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:20 INFO - 'MOZ_NO_REMOTE': '1', 14:57:20 INFO - 'NO_EM_RESTART': '1', 14:57:20 INFO - 'PAGER': '/bin/cat', 14:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:20 INFO - 'PWD': '/builds/slave/test', 14:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:20 INFO - 'SHELL': '/bin/bash', 14:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:20 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:20 INFO - 'USER': 'cltbld', 14:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:20 INFO - 'XPC_FLAGS': '0x0', 14:57:20 INFO - 'XPC_SERVICE_NAME': '0', 14:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:20 INFO - Downloading/unpacking psutil>=0.7.1 14:57:20 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 14:57:20 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 14:57:20 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 14:57:20 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 14:57:20 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 14:57:20 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 14:57:23 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:57:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:23 INFO - Installing collected packages: psutil 14:57:23 INFO - Running setup.py install for psutil 14:57:23 INFO - building 'psutil._psutil_osx' extension 14:57:23 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 14:57:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:57:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:57:25 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 14:57:26 INFO - building 'psutil._psutil_posix' extension 14:57:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:57:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:57:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:57:26 INFO - ^ 14:57:26 INFO - 1 warning generated. 14:57:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:57:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:26 INFO - Successfully installed psutil 14:57:26 INFO - Cleaning up... 14:57:26 INFO - Return code: 0 14:57:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:26 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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:26 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 14:57:26 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 14:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:26 INFO - 'HOME': '/Users/cltbld', 14:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:26 INFO - 'LOGNAME': 'cltbld', 14:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:26 INFO - 'MOZ_NO_REMOTE': '1', 14:57:26 INFO - 'NO_EM_RESTART': '1', 14:57:26 INFO - 'PAGER': '/bin/cat', 14:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:26 INFO - 'PWD': '/builds/slave/test', 14:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:26 INFO - 'SHELL': '/bin/bash', 14:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:26 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:26 INFO - 'USER': 'cltbld', 14:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:26 INFO - 'XPC_FLAGS': '0x0', 14:57:26 INFO - 'XPC_SERVICE_NAME': '0', 14:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:57:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:57:29 INFO - Installing collected packages: mozsystemmonitor 14:57:29 INFO - Running setup.py install for mozsystemmonitor 14:57:29 INFO - Successfully installed mozsystemmonitor 14:57:29 INFO - Cleaning up... 14:57:29 INFO - Return code: 0 14:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57: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')]} 14:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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', '--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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:29 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 14:57:29 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 14:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:29 INFO - 'HOME': '/Users/cltbld', 14:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:29 INFO - 'LOGNAME': 'cltbld', 14:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:29 INFO - 'MOZ_NO_REMOTE': '1', 14:57:29 INFO - 'NO_EM_RESTART': '1', 14:57:29 INFO - 'PAGER': '/bin/cat', 14:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:29 INFO - 'PWD': '/builds/slave/test', 14:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:29 INFO - 'SHELL': '/bin/bash', 14:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:29 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:29 INFO - 'USER': 'cltbld', 14:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:29 INFO - 'XPC_FLAGS': '0x0', 14:57:29 INFO - 'XPC_SERVICE_NAME': '0', 14:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:30 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 14:57:30 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 14:57:30 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 14:57:30 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 14:57:30 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 14:57:30 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 14:57:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:34 INFO - Downloading docopt-0.6.1.tar.gz 14:57:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:34 INFO - Running setup.py install for blobuploader 14:57:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:34 INFO - Running setup.py install for requests 14:57:35 INFO - Running setup.py install for docopt 14:57:35 INFO - Successfully installed blobuploader requests docopt 14:57:35 INFO - Cleaning up... 14:57:35 INFO - Return code: 0 14:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:35 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')]} 14:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:35 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')]} 14:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:35 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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:35 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 14:57:35 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 14:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:35 INFO - 'HOME': '/Users/cltbld', 14:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:35 INFO - 'LOGNAME': 'cltbld', 14:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:35 INFO - 'MOZ_NO_REMOTE': '1', 14:57:35 INFO - 'NO_EM_RESTART': '1', 14:57:35 INFO - 'PAGER': '/bin/cat', 14:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:35 INFO - 'PWD': '/builds/slave/test', 14:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:35 INFO - 'SHELL': '/bin/bash', 14:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:35 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:35 INFO - 'USER': 'cltbld', 14:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:35 INFO - 'XPC_FLAGS': '0x0', 14:57:35 INFO - 'XPC_SERVICE_NAME': '0', 14:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:35 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-cxrXug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-T3oAcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-PRKbLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-K5VSGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-cnr28_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-DueVB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-GVyi6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:36 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-QWhVYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-F1wLmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-NUsa_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-WOypao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-QJUb0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-PI7agF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-AhG5Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:37 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-flNbs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:38 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-3OqXGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:38 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-9Qfz8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:38 INFO - Running setup.py install for manifestparser 14:57:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:38 INFO - Running setup.py install for mozcrash 14:57:38 INFO - Running setup.py install for mozdebug 14:57:38 INFO - Running setup.py install for mozdevice 14:57:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Running setup.py install for mozfile 14:57:39 INFO - Running setup.py install for mozhttpd 14:57:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Running setup.py install for mozinfo 14:57:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Running setup.py install for mozInstall 14:57:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:39 INFO - Running setup.py install for mozleak 14:57:39 INFO - Running setup.py install for mozlog 14:57:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:40 INFO - Running setup.py install for moznetwork 14:57:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:40 INFO - Running setup.py install for mozprocess 14:57:40 INFO - Running setup.py install for mozprofile 14:57:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:40 INFO - Running setup.py install for mozrunner 14:57:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:41 INFO - Running setup.py install for mozscreenshot 14:57:41 INFO - Running setup.py install for moztest 14:57:41 INFO - Running setup.py install for mozversion 14:57:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:41 INFO - Cleaning up... 14:57:41 INFO - Return code: 0 14:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:41 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')]} 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 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')]} 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:41 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 14:57:41 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 14:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:41 INFO - 'HOME': '/Users/cltbld', 14:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:41 INFO - 'LOGNAME': 'cltbld', 14:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:41 INFO - 'MOZ_NO_REMOTE': '1', 14:57:41 INFO - 'NO_EM_RESTART': '1', 14:57:41 INFO - 'PAGER': '/bin/cat', 14:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:41 INFO - 'PWD': '/builds/slave/test', 14:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:41 INFO - 'SHELL': '/bin/bash', 14:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:41 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:41 INFO - 'USER': 'cltbld', 14:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:41 INFO - 'XPC_FLAGS': '0x0', 14:57:41 INFO - 'XPC_SERVICE_NAME': '0', 14:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-6NEwxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-pEeEWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-JtEUzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-mbuEgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-OFjErY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-ioULnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-diZ0RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:42 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)) 14:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:42 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-WEjv0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-o52A9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-qKBTc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-YpAfJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-Gzd9Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-xLJGhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:43 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)) 14:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:43 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-ZAZYdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:44 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-HDChNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:44 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-LPqOKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:44 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)) 14:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:44 INFO - Running setup.py (path:/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/pip-tBp5a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:44 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)) 14:57:44 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)) 14:57:44 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)) 14:57:44 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)) 14:57:44 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)) 14:57:44 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)) 14:57:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:47 INFO - Downloading blessings-1.5.1.tar.gz 14:57:47 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 14:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:47 INFO - Installing collected packages: blessings 14:57:47 INFO - Running setup.py install for blessings 14:57:47 INFO - Successfully installed blessings 14:57:47 INFO - Cleaning up... 14:57:47 INFO - Return code: 0 14:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:47 INFO - Reading from file tmpfile_stdout 14:57:47 INFO - Current package versions: 14:57:47 INFO - blessings == 1.5.1 14:57:47 INFO - blobuploader == 1.2.4 14:57:47 INFO - docopt == 0.6.1 14:57:47 INFO - manifestparser == 1.1 14:57:47 INFO - mozInstall == 1.12 14:57:47 INFO - mozcrash == 0.16 14:57:47 INFO - mozdebug == 0.1 14:57:47 INFO - mozdevice == 0.47 14:57:47 INFO - mozfile == 1.2 14:57:47 INFO - mozhttpd == 0.7 14:57:47 INFO - mozinfo == 0.9 14:57:47 INFO - mozleak == 0.1 14:57:47 INFO - mozlog == 3.0 14:57:47 INFO - moznetwork == 0.27 14:57:47 INFO - mozprocess == 0.22 14:57:47 INFO - mozprofile == 0.27 14:57:47 INFO - mozrunner == 6.11 14:57:47 INFO - mozscreenshot == 0.1 14:57:47 INFO - mozsystemmonitor == 0.0 14:57:47 INFO - moztest == 0.7 14:57:47 INFO - mozversion == 1.4 14:57:47 INFO - psutil == 3.1.1 14:57:47 INFO - requests == 1.2.3 14:57:47 INFO - wsgiref == 0.1.2 14:57:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57: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')]} 14:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x106e27490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e04228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1abf02030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, '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.DmEjgzSfkr/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.lug1TqLUhC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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 14:57:47 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 14:57:47 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 14:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:57:47 INFO - 'HOME': '/Users/cltbld', 14:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:57:47 INFO - 'LOGNAME': 'cltbld', 14:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:47 INFO - 'MOZ_NO_REMOTE': '1', 14:57:47 INFO - 'NO_EM_RESTART': '1', 14:57:47 INFO - 'PAGER': '/bin/cat', 14:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:47 INFO - 'PWD': '/builds/slave/test', 14:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:57:47 INFO - 'SHELL': '/bin/bash', 14:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:57:47 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:57:47 INFO - 'USER': 'cltbld', 14:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:47 INFO - 'XPC_FLAGS': '0x0', 14:57:47 INFO - 'XPC_SERVICE_NAME': '0', 14:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 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)) 14:57:48 INFO - Cleaning up... 14:57:48 INFO - Return code: 0 14:57:48 INFO - Running post-action listener: _resource_record_post_action 14:57:48 INFO - Running post-action listener: _start_resource_monitoring 14:57:48 INFO - Starting resource monitoring. 14:57:48 INFO - ##### 14:57:48 INFO - ##### Running install step. 14:57:48 INFO - ##### 14:57:48 INFO - Running pre-action listener: _resource_record_pre_action 14:57:48 INFO - Running main action method: install 14:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:48 INFO - Reading from file tmpfile_stdout 14:57:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:48 INFO - Reading from file tmpfile_stdout 14:57:48 INFO - Output received: 14:57:48 INFO - Usage: mozinstall [options] installer 14:57:48 INFO - Options: 14:57:48 INFO - -h, --help show this help message and exit 14:57:48 INFO - -d DEST, --destination=DEST 14:57:48 INFO - Directory to install application into. [default: 14:57:48 INFO - "/builds/slave/test"] 14:57:48 INFO - --app=APP Application being installed. [default: firefox] 14:57:48 INFO - mkdir: /builds/slave/test/build/application 14:57:48 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'] 14:57:48 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 14:58:31 INFO - Reading from file tmpfile_stdout 14:58:31 INFO - Output received: 14:58:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:58:31 INFO - Running post-action listener: _resource_record_post_action 14:58:31 INFO - ##### 14:58:31 INFO - ##### Running run-tests step. 14:58:31 INFO - ##### 14:58:31 INFO - Running pre-action listener: _resource_record_pre_action 14:58:31 INFO - Running main action method: run_tests 14:58:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:58:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:58:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:58:31 INFO - 2015-11-16 14:58:31.320 screenresolution[1628:7536] starting screenresolution argv=screenresolution get 14:58:31 INFO - 2015-11-16 14:58:31.324 screenresolution[1628:7536] Display 0: 1600x1200x32@60 14:58:31 INFO - 2015-11-16 14:58:31.331 screenresolution[1629:7538] starting screenresolution argv=screenresolution list 14:58:31 INFO - Available Modes on Display 0 14:58:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:58:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:58:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:58:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:58:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:58:31 INFO - Intel HD Graphics 3000: 14:58:31 INFO - Chipset Model: Intel HD Graphics 3000 14:58:31 INFO - Type: GPU 14:58:31 INFO - Bus: Built-In 14:58:31 INFO - VRAM (Total): 512 MB 14:58:31 INFO - VRAM (Dynamic, Max): 10 14:58:31 INFO - Vendor: Intel (0x8086) 14:58:31 INFO - Device ID: 0x0116 14:58:31 INFO - Revision ID: 0x0009 14:58:31 INFO - Displays: 14:58:31 INFO - Display: 14:58:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:58:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:58:31 INFO - Display Serial Number: 1600x1200 60 14:58:31 INFO - Main Display: Yes 14:58:31 INFO - Mirror: Off 14:58:31 INFO - Online: Yes 14:58:31 INFO - Rotation: Supported 14:58:31 INFO - Return code: 0 14:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:58:31 INFO - Python 2.7.3 14:58:31 INFO - Return code: 0 14:58:31 INFO - grabbing minidump binary from tooltool 14:58:31 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')]} 14:58:31 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 0x106d4a9f0>, '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 0x106aaadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d3e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:58:31 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 14:58:31 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 14:58:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:58:31 INFO - Return code: 0 14:58:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:58:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:58:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:58:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:58:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0057', '--webServer', 'localhost'] in /builds/slave/test/build 14:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0057 --webServer localhost 14:58:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DmEjgzSfkr/Render', 14:58:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:31 INFO - 'HOME': '/Users/cltbld', 14:58:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:31 INFO - 'LOGNAME': 'cltbld', 14:58:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:31 INFO - 'MOZ_NO_REMOTE': '1', 14:58:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:31 INFO - 'NO_EM_RESTART': '1', 14:58:31 INFO - 'PAGER': '/bin/cat', 14:58:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:31 INFO - 'PWD': '/builds/slave/test', 14:58:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:31 INFO - 'SHELL': '/bin/bash', 14:58:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lug1TqLUhC/Listeners', 14:58:31 INFO - 'TMPDIR': '/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/', 14:58:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:31 INFO - 'USER': 'cltbld', 14:58:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:31 INFO - 'XPC_FLAGS': '0x0', 14:58:31 INFO - 'XPC_SERVICE_NAME': '0', 14:58:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 14:58:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0057', '--webServer', 'localhost'] with output_timeout 3600 14:58:32 INFO - mozversion INFO | application_buildid: 20151116131535 14:58:32 INFO - mozversion INFO | application_changeset: 4e0d0bf80b36e05be962ef860cbd62b63fe8b245 14:58:32 INFO - mozversion INFO | application_display_name: Nightly 14:58:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:58:32 INFO - mozversion INFO | application_name: Firefox 14:58:32 INFO - mozversion INFO | application_remotingname: firefox 14:58:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 14:58:32 INFO - mozversion INFO | application_vendor: Mozilla 14:58:32 INFO - mozversion INFO | application_version: 45.0a1 14:58:32 INFO - mozversion INFO | platform_buildid: 20151116131535 14:58:32 INFO - mozversion INFO | platform_changeset: 4e0d0bf80b36e05be962ef860cbd62b63fe8b245 14:58:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 14:58:32 INFO - mozversion INFO | platform_version: 45.0a1 14:58:32 INFO - 2015-11-16 14:58:32,117 DEBUG : using testdate: 1447714712 14:58:32 INFO - 2015-11-16 14:58:32,117 DEBUG : actual date: 1447714712 14:58:32 INFO - 2015-11-16 14:58:32,127 INFO : starting webserver on 'localhost:49265' 14:58:32 INFO - 2015-11-16 14:58:32,129 INFO : Starting test suite t-yosemite-r5-0057.e 14:58:32 INFO - 2015-11-16 14:58:32,129 INFO : Starting test dromaeo_css 14:58:32 INFO - 2015-11-16 14:58:32,129 DEBUG : operating with platform_type : mac_ 14:58:32 INFO - 2015-11-16 14:58:32,130 INFO : Initialising browser for dromaeo_css test... 14:58:32 INFO - 2015-11-16 14:58:32,164 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmp6kAlq7/profile http://localhost:49265/getInfo.html 14:58:36 INFO - 2015-11-16 14:58:36,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:58:36 INFO - 2015-11-16 14:58:36,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:58:36 INFO - 2015-11-16 14:58:36,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 14:58:36 INFO - 2015-11-16 14:58:36,723 DEBUG : BROWSER_OUTPUT: __metrics 14:58:37 INFO - 2015-11-16 14:58:37,442 INFO : Browser initialized. 14:58:37 INFO - 2015-11-16 14:58:37,442 INFO : Running cycle 1/1 for dromaeo_css test... 14:58:37 INFO - 2015-11-16 14:58:37,442 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmp6kAlq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:58:49 INFO - 2015-11-16 14:58:49,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 240549888 14:58:49 INFO - 2015-11-16 14:58:49,745 DEBUG : BROWSER_OUTPUT: 14:59:39 INFO - 2015-11-16 14:59:39,622 DEBUG : BROWSER_OUTPUT: 1447714779614 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] 15:01:50 INFO - 2015-11-16 15:01:50,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 15:01:51 INFO - 2015-11-16 15:01:51,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 267526144 15:01:51 INFO - 2015-11-16 15:01:51,919 DEBUG : BROWSER_OUTPUT: 15:04:54 INFO - 2015-11-16 15:04:54,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 15:04:54 INFO - 2015-11-16 15:04:54,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 272883712 15:04:54 INFO - 2015-11-16 15:04:54,598 DEBUG : BROWSER_OUTPUT: 15:07:56 INFO - 2015-11-16 15:07:56,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 15:07:56 INFO - 2015-11-16 15:07:56,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 274661376 15:07:56 INFO - 2015-11-16 15:07:56,970 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-16 15:10:58,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 15:10:59 INFO - 2015-11-16 15:10:59,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 278753280 15:10:59 INFO - 2015-11-16 15:10:59,339 DEBUG : BROWSER_OUTPUT: 15:14:02 INFO - 2015-11-16 15:14:02,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 15:14:02 INFO - 2015-11-16 15:14:02,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 283709440 15:14:02 INFO - 2015-11-16 15:14:02,711 DEBUG : BROWSER_OUTPUT: 15:17:04 INFO - 2015-11-16 15:17:04,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 15:17:05 INFO - 2015-11-16 15:17:05,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 289243136 15:17:05 INFO - 2015-11-16 15:17:05,246 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,247 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:17:05 INFO - 2015-11-16 15:17:05,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:17:05 INFO - 2015-11-16 15:17:05,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:17:05 INFO - 2015-11-16 15:17:05,248 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:17:05 INFO - 2015-11-16 15:17:05,249 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.9732402675972;2693.1920423872834;2719.9320016999573;2752.6696796384435;2765.3639662877526;4536.410266665337;4641.512641172675;4647.558481944218;4654.976725116374;4669.0428462165255;4450.977745111278;4452.732836029841;4536.206163921317;4578.748168850712;4601.5398460153965;4212;4223.6409905158025;4242.787860606973;4270.935935960963;4297.742135471866;4229.259879521087;4327.610515053644;4334.913301733964;4345.152695224432;4452.8441504547345;4023.939640905389;4154.210699967027;4180.310248808943;4229.809658565372;4290.935635965463;4167.91664166718;4212.705110642256;4219.38818871265;4256.2764330063965;4267.167902259061;4211.620954114144;4230.2174097792;4253.106847562016;4283.97858010711;4289.806958686867;4358.8038538265855;4392.34114882767;4424.933625995581;4556.020455602028;4570.520095390003;4874.878128046792;4919.7540122993705;4925.876853078666;4927.704337739747;4939.604831613498;4781.474037855833;4943.283223932545;4991.301217829507;5070.847874563769;5079.949200507985;4491.483479399878;4511.729296242236;4589.931151032737;4614.838480653195;4616.16908956391;4788.497207793202;5054.393472783216;5059.822906198339;5070.721110338893;5098;4593.104344652827;4751.83368582098;4790.473047964721;4821.686590371684;4911.091448082117;4804.807807687654;4893.877653058702;4914.434839993446;4918.262260660858;4951.183054795918;4835.879103022453;4855.32025516428;4856.17445034345;4862.112897388968;4865.489123641966;4679.344891715163;4739.644526660514;4825.710457372498;4866.853994380174;4944.55499005084;3818.9236215276096;3827.1197624545953;3868.574456809805;3878.398848178537;3911.941320880189;3328.8169150696945;3459.1697992482127;3469.9653003469643;3485.4597537381746;3489.755717099779;4446.577575130357;4497.527759585197;4611.054733779567;4643.141018911512;4655.37152484417;4914.385701787277;4946.3817022872145;4959.776810043557;4964.528369804862;5053.494650534991;4563.178627847019;4625.398698169217;4655.4180727409075;4671.995520963009;4708.529147085264;4196.307609244502;4228.619424251832;4234.1108367242605;4272.658187345067;4320.4383430153875;5049.495050494921;5051.368578927634;5065.898682026339;5076.543111120017;5079.974600126976;4551.681382303207;4978.6763860348965;4981.452040275639;5000.324956130876;5040.193569029085;4906.239532872411;4913.164761990399;4957.454679985127;5007.624428167975;5040.319556859777;4864.148773964472;4873.634477414279;4913.287573301923;4927.778249978831;4992.850214493571;4781.856544303677;4929.704217746947;4937.851864444073;4976.0794253063295;5003.3495645565845;4740.336352910665;4830.516948305141;4858.78135483897;4878.951210487991;4895.118878601744;4791.353167322367;4795.184818580919;4824.614030877591;4844.370231869834;4853.830115945925;4446.0885518467985;4525.049739554599;4615.83844565452;4724.220503616864;4737.8341758038305;4754;4790.712557246577;4843;4854.611631069577;4855;4687.484376718627;4689.413823272091;4710.24636058229;4729.43246810385;4729.763511824463 15:17:05 INFO - 2015-11-16 15:17:05,253 DEBUG : BROWSER_OUTPUT: |1;ext.html;430.1332814379026;438.16529511281;453.74816976577983;461.3034318179549;479.9776476105894;32285.838570807144;32870.342593148125;32885.67114328856;32916.50625240617;33321.833390833075;34773.47839782405;35481.46777798335;35545.644543554554;35715;35903.281934361294;7514.924850751505;7723.459357844953;7809.219078092202;7816;7842.019747531559;7550.6602202901;7672.1560628330835;7698.422618303622;7761.611919404036;7779.9222007780045;7533.6986520539385;7647.961760191191;7658.425618078639;7692.538447693129;7734.265244801763;7600.50596711212;7715.382769378436;7750;7757.030371203599;7793.96103019487;7537.773866784005;7655.540667559909;7676.309132178131;7726.613669316568;7767.53394796314;32415.351692966007;32873.83563082193;32879.67120328814;33019.504707429405;33228.00315990524;2409.5180963807134;2488.8675652578036;2796.2170592234206;2931.2818359501844;2977.0919869439813;22526.66210006851;22853.7714622855;23190.3042908713;23810;24027.038918443242;1948.756405449319;1962.1562728026943;1965.557749506364;1980.5939782344585;1980.6236815005102;223153;223591.8820405904;223664;225736;225805;46387;46551.30173047407;46569.534304657194;46598;46813.76593117013;46624;47656.52343476521;50862.23706644403;51396.48603513992;52229.7388513055;11876.168668193317;12070.698232544257;12091.939540302243;12224.694382640506;12230.938845305716;9138.451692898447;9312.90687093134;9360.90639093614;9362.297827662816;9391.107844754737;15358.462453814063;15520.456784012731;15524.456644017406;15596.92201538985;15924.92037539805;6805.523613347117;7045.154581450259;7051.435885129177;7067.71729130829;7090.220075791659;780.8399278147966;787.6809891993752;868.1795703060674;949.8052899155656;952.0574631115146;23483.178088767152;23578.646320305208;23772.405689857893;23859.284221473383;24104.915278812146;827.0943317067921;843.2705709561185;852.4757274276276;859.4070091636751;899.3434792601438;12192.756144877052;12391.566295179626;12547.372631368395;12646.936765316299;12693.428795704216;260351;263505;264441;266048;268158;43865.78067109644;43942.34086488705;44070.33894491585;44130.55869441265;44833.55166448359;1144.113312183048;1148.4257871064467;1163.0172504234079;1164.3886959346412;1181.1436708386352;23048.539029218988;23207.419814504774;23312.417189570395;23536.176233831735;23567.41081472977;39036.21927561376;39073;39157.412638809874;39574.40638390484;39605.80197098996;228973;232520;233056;234830;236256;25475.36311592225;26143.215703528924;26199;26272.868635656698;26442.471150577265;31210.21974450657;31644.683553165094;31675.20811979719;32423.513647294836;32485.350292993535;26471.229509821685;28622;28645.713542864305;28704;28728.425431491672;28479.857600711865;28852.711472885003;28853.134405967856;28858.855705721337;28948.855255723585;29000.7099928998;29139.7086029137;29358.853205733834;29564.113076607737;29660.25849353697;23614.763852361255;24410.389740256636;25274;25546.74453255518;25804.225873223833;19379.4186174415;19394;19571.804281956996;19709.704354434984;20133.899330503253 15:17:05 INFO - 2015-11-16 15:17:05,253 DEBUG : BROWSER_OUTPUT: |2;jquery.html;275.7339167703166;276.4691791759821;276.7243009725168;282.48446584982406;286.14585462394757;11416.257943233684;13786.448542058319;14160.50438234662;14207.857921420795;14918.776218356734;14614.634634134125;14742.33659485323;14755.336009879555;14958.626034349147;14960.700785984274;3738.906527336811;3889.3193691104084;3930.744501607386;4220.155968806243;4464.5981861632445;3904.5900180481067;3912.8434862605604;3939.7439166454233;3940.2119576084756;4015.4980627421573;2749.752522272995;2780.207640822366;3658.4512323151475;3884.3396622574232;3900.1029763154493;3842.212346468967;3870.6516413522777;3886.591907849663;3905.2384784966944;3932.7640341579454;3285.78642388244;3301.7688761786685;3331.083951913219;3354.4297469430257;3355.144438168276;10192.592296308212;10695.03744662984;10707.571697132105;10709.410982395964;10813.67558973232;1455.0469442515064;1536.431520337471;1538.7845701601784;1661.3188592677066;1681.377890180641;7530.548167109936;7832.412569057344;7952;7987.321077708401;8022.237887400687;1189.0962868220129;1242.8694987026322;1259.508791571288;1271.0784681106124;1349.1702602899245;47578.28632570514;47991.520084799056;48058.27912581279;49138.50861491375;49307.50692493065;5319.840404787863;5330.147176451749;5382.973085134628;5399.595030372738;5423.322084739408;6062.2725272966645;6111.54163437744;6149.385061493905;6154.938450615526;6181.783637572753;4245.469316335458;4336.934945975813;4344.131173765197;4359.476862776423;4378.2119218540965;4531.43357080365;4535.931961020521;4564.497905230422;4567.314902764546;4589.5181005994555;2376.39401952501;2379.1791831817995;2388.665586817847;2391.5770116780486;2424.175780234729;828.9378296627777;829.8049958259804;848.8090179709516;850.2177996243471;921.6543796076471;337.73319077928653;348.1296758104738;357.4905759292997;375.000623338799;376.98680546180753;9373.343865929319;9451.385659932082;9484.241260699127;9677.467739274267;9708.417494950325;360.6105406161392;371.1371062280209;372.3112242351628;373.54800691163996;377.2153919846712;4844.467108618049;5180.378354597472;5215.061288968022;5242.816501422432;5304.336957880265;447209;462533;470893;471648;475506;57322;58156;58501;59036.40963590395;59328.40671593315;401.05751484012336;404.1210367450783;404.443889651723;405.35346122933873;406.4736166664118;8774.07872173438;8775.473471591726;8872.955635221782;8893.377463577488;8935.017148113833;28167.591620418487;28683.85658071696;28730.712692872803;28794.136175914755;28870;37234.44148337723;37603.62396376111;38246;38499;39013.609863900994;4970.229614409773;4980.153373926513;5085.6185786066935;5093;5111.514406131411;9344.579493922654;9631.951840240754;9667.081627245401;9720.611175552898;9782.706518804447;8120.593970301343;8182.1817818217705;8234.505929644241;8345.040320362994;8431.831363372821;6899.448044156556;7953.6818527258265;7971.920280797118;7979.72070977513;8152.062512811102;8274.669013239403;8292.17078292166;8321.6671333146;8354.79113022155;8449.23956843887;4945.060438516671;4991.575716064175;4993.375828021497;5041.949580504148;5056.216286475602;8117.594120294079;8130.02439707239;8199.42604017713;8319.417640765088;8406.033306169624 15:17:05 INFO - 2015-11-16 15:17:05,257 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1442.466287473635;1462.7732701431269;1498.183489997951;1501.3560151633958;1506.5932198306464;5944.643321400719;6106.267247930255;6668.399844014038;6900.551464154826;6942.305769423056;6107.908381374283;6206.565540412173;6359.809205723825;6395.424411802936;6408.903866441996;1892.7728672559313;1941.3011315926256;1944.0377013378327;1947.2016473245972;1954.208545539059;1891.6216756648657;1920.654282229198;1931.5943651833131;1932.0822609260629;1938.2925232290183;1870.8971006594631;1923.2210954563425;1935.9322423715103;1936.4674714453497;1940.0590713503939;1805.4583624912473;1840.6778813707615;1855.749473821044;1859.4421673497895;1863.4409677096953;1880.7272945422837;1901.4770937992025;1910.14043680343;1949.5905859769466;1962.842972562206;6607.2071351438135;6728.461723062143;6778.288279730656;6780.796576102724;6808.761693340709;4051.8581849635416;4148.045949431617;4151.750894946313;4162.188373267214;4197;2394.820388470872;2443.645671377658;2461.5569197544437;2488.7635674610883;2513.40934880303;748.7267147491126;771.5910567399287;776.7708525984848;784.2040329066002;784.3764207455087;8835;8907.554622268926;8907.866382004275;8992.640294388217;9006.639734410615;3656.800374341639;3730.235301763132;3733.439984002367;3813.923721525554;3820.675242604354;7688.269614386624;7745.651445684845;7771.961140194263;7784.2215778421705;7879.054513458422;4176.791160441966;4192.622663960197;4215.051613386963;4222.683298752606;4232.174725928476;3450.7756995795194;3539.752217344761;3801.163743976321;3819.064329239299;3864.53625564934;3085.1515833146063;3164.620245570546;3172.857221425041;3194.5687332209855;3225.2581906161713;1003.1874181912674;1013.9290249682451;1022.2895087913829;1030.4744580263969;1032.0247366238832;867.0332579174176;871.6208449324564;920.1396694091046;983.2429029647275;1133.0991861470152;6241.687915604201;6356.173697419306;6388.073729309224;6390.968045159838;6391.242408337652;954.6849539651898;964.3972517176765;977.726236653738;978.1490103609763;998.3211416236884;4802.591779698695;4878;4932.062908047459;4947;4982.9252561211615;7791.766247012599;7845.137034926153;7933.404994625426;8043.1554686757045;8046.114927357986;7753.883691744629;7799.142094369615;7840.255175758294;7845.607719613997;7853.921460785434;6111.786087487006;6206.968965155145;6208.81373558794;6242.469390101802;6320.747170113236;6197.411245931629;6306.274778400542;6344.080108384351;6352.205974253218;6365.04524321337;6990.6504674767075;7032.472564557781;7124.857502850017;7164.426845852215;7194.964025179841;7205.819854503469;7261.056062711814;7276;7336.193018768038;7469.925300747141;5428.864278393072;5569.972150139223;5954.970225148846;6046.2139921809885;6055.2430946131735;6087.847803804941;6364.809055728336;6546.476281897341;6547.214334279917;6574.638394888327;5728.79949201776;5920.496757775637;5970.253718285215;6095.451409373178;6132.98805697055;5866.354700982974;5931.406859314034;5990.251218597676;6003.939960600338;6051.334353221054;5823.534117270524;6070.726817293321;6077.787277445445;6141.969290153699;6142.109394137914;5391.838244852661;5426.7829286829665;5431.972840135774;5447.046766815871;5451.945480545144;5494;5583.050881350099;5610.158476228598;5614.04561224601;5618.69097199658 15:17:05 INFO - 2015-11-16 15:17:05,258 DEBUG : BROWSER_OUTPUT: |4;prototype.html;264.876832272993;269.70736750625576;269.96220529125924;270.4051087607265;271.22024180481117;5312.574994000481;5329.546988505972;5341.359036915571;5355.384130824957;5375.677459352437;5238.79044838206;5395.919061214076;5433.266509021281;5439.238506609078;5466.726663666821;4076.2866498362814;4083.959160408395;4098.262312783698;4143.958560414388;4168.208040472316;4088.2641124597562;4097.262492751303;4105.44576482174;4121.752694838305;4158.688098392633;3799.1262009737775;4061.3704875744306;4075.8369665213354;4095.8361665533344;4106.993786522306;3890.824912878927;3961.98019009906;3981.402789581557;4009.3585026395635;4031.173609410064;3387.8814241501427;3387.915302117442;3404.5233667286598;3414.197663549064;3414.641462646436;5048.1418158913075;5148.588112950955;5168.198929165947;5228.08508511009;5267.420583735786;4508.909821803545;4509.977450112761;4535.387722657432;4576.0619073090265;4583.220852455091;5642.633228840113;5662.518685911702;5674.865026994617;5687.118496632987;5707.657540547539;3678.2459595782802;3692.7045836333027;3709.017110465729;3716.572594151653;3723.962760372389;5753.88492230153;5902;5945.108233764927;5971.641701497924;6012.549058820606;3774.5470543534952;3778.3387907116144;3779.508663873679;3781.7541859779576;3817.560980487224;3852.152526444178;3859.3632050711317;3863.6715879150024;3872.3997780344093;3892.766434013968;4479.70881892676;4507.166174257773;4525.230710779176;4534.959268329265;4563.748993805372;5499.092649712833;5688.317401911797;5690.4025077367105;5696.401877802854;5706.629069110578;1320.1485042147954;1345.3744009035845;1351.094766506443;1355.213975893979;1358.809766632672;846.9195426434479;858.2576071697937;860.3719284921917;880.0803160697087;885.6988623867916;5364.6512976656395;5404.675719456766;5428.212909128154;5430.5384042356845;5485;5879.206307148565;5904.321003084614;5907.202527658711;5912.586118971717;5924.111383292455;5411.756470958816;5429.945700543023;5430.8099216527235;5469.835904922858;5474.39781624021;3094.8607312670983;3174.682531746807;3207.1821685470054;3213.5983002124735;3216.533602627606;6108.389161083945;6130.233720784902;6132.908006379907;6164.506839452833;6174.876502469925;5890.705464726747;5952.9107063394085;6040.939590604038;6111.083337499411;6113.6855576050475;6118.1128736332985;6125.693715314216;6126.938730612636;6190.473809726223;6198.752049917953;5939.762409503572;5941.1385349125;5975.312839023568;5986.6707331097205;5990.460858522754;5594.0769772987005;5803.448672376117;5806.82579522615;5857.209276747584;5889.234399528034;6107.175531303217;6121.602095863755;6132.202813634199;6174.289956655042;6195.628262304276;3803.372443546784;3824.8661296854475;3825.846966121324;3835.386338185877;3849.5188101487315;5835.912461312999;5954.851128721816;5957.463828255478;5973.223480947449;6000.429959153874;5752.252207213036;5772.422757724194;5774.422557744192;5819.516023414002;5825.388334225015;5708.57185711065;5727.713614319351;5732.111522713986;5756.625819321731;5779.913301300568;5587.189857470563;5589.748461319169;5652.321721393295;5656.1798539212405;5671;5558.138488534122;5742.971285143548;5753.482186603226;5794.594378393641;5814.186013958134;5636;5641.830745077655;5650.350209725934;5656.123300888369;5697 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: |5;yui.html;607.4259824465881;609.198903441974;636.0999186151595;636.3064259956647;638.3297537585534;11282;11475.426228688564;12593.370331483424;12924.15992960457;12930.935345323283;11775.882241177585;11787;11813.645590632274;11849.7630047399;11855;713.568291183834;715.4133610439429;718.8706032914073;720.3444865172694;734.7612026091515;572.7794799002394;583.2738240890097;672.9528932974694;716.3517017099533;717.4188906985332;724.7173602295109;731.4843035659874;740.5741698523344;741.636598066946;746.9626518674072;728.7777227945475;729.0631538473064;730.3536370312258;730.5543618392776;731.1336066760905;537.4115343698644;537.4517991648536;542.6282996147652;542.7449098923539;546.1343770124357;11176.944115279453;11316.321020738782;11339.603113891057;11377.089832813355;11451;7534.54792712439;7582.203868593773;7688.769336919901;7941.166177551389;8505.106963768778;7431.8142046449275;7506.887396689054;7661.118971318314;7902.328302094329;7903;2443.3402981195154;2472.7527247275307;2502.436951685874;2525.747425257478;2554.106062877978;38239.80880095582;39245.41131883024;39287.214255715015;39399.8030009851;39431.802840985896;5490.231367608538;5737.971310143423;5864.941350586525;5923.970380148072;6108.511319094462;9934.900650993397;9947.253955953187;10023.348482348623;10057.547410366551;10061.597536098621;4901.264810278415;4935.555799978019;4977.950220497821;5028.874278143003;5228.712420816815;2991.6110905582136;3075.0928476099157;3101.5347697845505;3128.8279144647263;3172.682731726809;2234.441389652587;2282.0529480265836;2295.1966811615803;2309.203324852923;2317.154238702861;326.87905474973934;327.22284574136427;328.9029736227819;333.98635142342874;338.40609729923824;400.37941191153595;434.60668095373103;453.78445238511443;487.9438864530624;492.32797231778363;6541.542092053605;6665.600063996176;6734.3602357775935;6748.358905903931;6848.657567121624;495.45747406589726;501.9949800502021;508.6464906889676;509.5846884788885;523.2831021500568;3255.5279484474618;3408.2672225471147;3445.3109378124477;3463.203463203427;3554.5201397810965;50005.49994500081;50611.24083138756;50714.74642626763;51291;51352.48647513552;41912.790436047624;42222.57777422186;42527.36208956868;42767;42891.78554107272;40404.15150181997;41377.37933931054;41452.585474145475;41960;42174.578254217064;6865.691043902936;6889.586624802528;6926.307369263033;6970.79087627372;7133.607651579213;29380;29478.705212947596;29649.70079338527;30010.699893001663;30015;36541.45187822238;37265.6273437273;40293.39559906662;40545.391819123324;40601.79699101485;6024.581805882344;6061.212042434456;6288.968555157195;6325.082862984934;6545.312742162005;8962.283017358726;9091.814776440498;9144.131307525775;9153.17621414076;9156.542172891195;8602.91397086021;8604.311655067704;8609.48343099416;8634.266087382643;8721.389502734748;8373.455725377831;8643.308535317285;8673.609687563949;8739;8764.035956044703;8523.190296921783;8524.488530688179;8559.486430814171;8634.913650863411;8710.69512567057;7363.668634911549;7472.701091956478;7629;7897.605119744105;7950.045994480699;7617.885731714139;7641.197674244347;7648.8144337627755;7671.501352412075;7817.570033648204 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: __startTimestamp1447715825246__endTimestamp 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:17:05 INFO - 2015-11-16 15:17:05,262 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:17:05 INFO - 2015-11-16 15:17:05,263 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,263 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4566.87 Median:4708.53 stddev:491.00 (10.4%) stddev-sans-first:469.57 15:17:05 INFO - 2015-11-16 15:17:05,263 DEBUG : BROWSER_OUTPUT: Values: 2676.0 2693.2 2719.9 2752.7 2765.4 4536.4 4641.5 4647.6 4655.0 4669.0 4451.0 4452.7 4536.2 4578.7 4601.5 4212.0 4223.6 4242.8 4270.9 4297.7 4229.3 4327.6 4334.9 4345.2 4452.8 4023.9 4154.2 4180.3 4229.8 4290.9 4167.9 4212.7 4219.4 4256.3 4267.2 4211.6 4230.2 4253.1 4284.0 4289.8 4358.8 4392.3 4424.9 4556.0 4570.5 4874.9 4919.8 4925.9 4927.7 4939.6 4781.5 4943.3 4991.3 5070.8 5079.9 4491.5 4511.7 4589.9 4614.8 4616.2 4788.5 5054.4 5059.8 5070.7 5098.0 4593.1 4751.8 4790.5 4821.7 4911.1 4804.8 4893.9 4914.4 4918.3 4951.2 4835.9 4855.3 4856.2 4862.1 4865.5 4679.3 4739.6 4825.7 4866.9 4944.6 3818.9 3827.1 3868.6 3878.4 3911.9 3328.8 3459.2 3470.0 3485.5 3489.8 4446.6 4497.5 4611.1 4643.1 4655.4 4914.4 4946.4 4959.8 4964.5 5053.5 4563.2 4625.4 4655.4 4672.0 4708.5 4196.3 4228.6 4234.1 4272.7 4320.4 5049.5 5051.4 5065.9 5076.5 5080.0 4551.7 4978.7 4981.5 5000.3 5040.2 4906.2 4913.2 4957.5 5007.6 5040.3 4864.1 4873.6 4913.3 4927.8 4992.9 4781.9 4929.7 4937.9 4976.1 5003.3 4740.3 4830.5 4858.8 4879.0 4895.1 4791.4 4795.2 4824.6 4844.4 4853.8 4446.1 4525.0 4615.8 4724.2 4737.8 4754.0 4790.7 4843.0 4854.6 4855.0 4687.5 4689.4 4710.2 4729.4 4729.8 15:17:05 INFO - 2015-11-16 15:17:05,263 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,263 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37926.76 Median:31427.45 stddev:63045.14 (200.6%) stddev-sans-first:63159.13 15:17:05 INFO - 2015-11-16 15:17:05,265 DEBUG : BROWSER_OUTPUT: Values: 430.1 438.2 453.7 461.3 480.0 32285.8 32870.3 32885.7 32916.5 33321.8 34773.5 35481.5 35545.6 35715.0 35903.3 7514.9 7723.5 7809.2 7816.0 7842.0 7550.7 7672.2 7698.4 7761.6 7779.9 7533.7 7648.0 7658.4 7692.5 7734.3 7600.5 7715.4 7750.0 7757.0 7794.0 7537.8 7655.5 7676.3 7726.6 7767.5 32415.4 32873.8 32879.7 33019.5 33228.0 2409.5 2488.9 2796.2 2931.3 2977.1 22526.7 22853.8 23190.3 23810.0 24027.0 1948.8 1962.2 1965.6 1980.6 1980.6 223153.0 223591.9 223664.0 225736.0 225805.0 46387.0 46551.3 46569.5 46598.0 46813.8 46624.0 47656.5 50862.2 51396.5 52229.7 11876.2 12070.7 12091.9 12224.7 12230.9 9138.5 9312.9 9360.9 9362.3 9391.1 15358.5 15520.5 15524.5 15596.9 15924.9 6805.5 7045.2 7051.4 7067.7 7090.2 780.8 787.7 868.2 949.8 952.1 23483.2 23578.6 23772.4 23859.3 24104.9 827.1 843.3 852.5 859.4 899.3 12192.8 12391.6 12547.4 12646.9 12693.4 260351.0 263505.0 264441.0 266048.0 268158.0 43865.8 43942.3 44070.3 44130.6 44833.6 1144.1 1148.4 1163.0 1164.4 1181.1 23048.5 23207.4 23312.4 23536.2 23567.4 39036.2 39073.0 39157.4 39574.4 39605.8 228973.0 232520.0 233056.0 234830.0 236256.0 25475.4 26143.2 26199.0 26272.9 26442.5 31210.2 31644.7 31675.2 32423.5 32485.4 26471.2 28622.0 28645.7 28704.0 28728.4 28479.9 28852.7 28853.1 28858.9 28948.9 29000.7 29139.7 29358.9 29564.1 29660.3 23614.8 24410.4 25274.0 25546.7 25804.2 19379.4 19394.0 19571.8 19709.7 20133.9 15:17:05 INFO - 2015-11-16 15:17:05,265 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,265 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22459.75 Median:225870.22 stddev:76242.06 (33.8%) stddev-sans-first:76437.74 15:17:05 INFO - 2015-11-16 15:17:05,266 DEBUG : BROWSER_OUTPUT: Values: 275.7 276.5 276.7 282.5 286.1 11416.3 13786.4 14160.5 14207.9 14918.8 14614.6 14742.3 14755.3 14958.6 14960.7 3738.9 3889.3 3930.7 4220.2 4464.6 3904.6 3912.8 3939.7 3940.2 4015.5 2749.8 2780.2 3658.5 3884.3 3900.1 3842.2 3870.7 3886.6 3905.2 3932.8 3285.8 3301.8 3331.1 3354.4 3355.1 10192.6 10695.0 10707.6 10709.4 10813.7 1455.0 1536.4 1538.8 1661.3 1681.4 7530.5 7832.4 7952.0 7987.3 8022.2 1189.1 1242.9 1259.5 1271.1 1349.2 47578.3 47991.5 48058.3 49138.5 49307.5 5319.8 5330.1 5383.0 5399.6 5423.3 6062.3 6111.5 6149.4 6154.9 6181.8 4245.5 4336.9 4344.1 4359.5 4378.2 4531.4 4535.9 4564.5 4567.3 4589.5 2376.4 2379.2 2388.7 2391.6 2424.2 828.9 829.8 848.8 850.2 921.7 337.7 348.1 357.5 375.0 377.0 9373.3 9451.4 9484.2 9677.5 9708.4 360.6 371.1 372.3 373.5 377.2 4844.5 5180.4 5215.1 5242.8 5304.3 447209.0 462533.0 470893.0 471648.0 475506.0 57322.0 58156.0 58501.0 59036.4 59328.4 401.1 404.1 404.4 405.4 406.5 8774.1 8775.5 8873.0 8893.4 8935.0 28167.6 28683.9 28730.7 28794.1 28870.0 37234.4 37603.6 38246.0 38499.0 39013.6 4970.2 4980.2 5085.6 5093.0 5111.5 9344.6 9632.0 9667.1 9720.6 9782.7 8120.6 8182.2 8234.5 8345.0 8431.8 6899.4 7953.7 7971.9 7979.7 8152.1 8274.7 8292.2 8321.7 8354.8 8449.2 4945.1 4991.6 4993.4 5041.9 5056.2 8117.6 8130.0 8199.4 8319.4 8406.0 15:17:05 INFO - 2015-11-16 15:17:05,266 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,267 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4656.19 Median:5980.25 stddev:2391.16 (40.0%) stddev-sans-first:2385.67 15:17:05 INFO - 2015-11-16 15:17:05,267 DEBUG : BROWSER_OUTPUT: Values: 1442.5 1462.8 1498.2 1501.4 1506.6 5944.6 6106.3 6668.4 6900.6 6942.3 6107.9 6206.6 6359.8 6395.4 6408.9 1892.8 1941.3 1944.0 1947.2 1954.2 1891.6 1920.7 1931.6 1932.1 1938.3 1870.9 1923.2 1935.9 1936.5 1940.1 1805.5 1840.7 1855.7 1859.4 1863.4 1880.7 1901.5 1910.1 1949.6 1962.8 6607.2 6728.5 6778.3 6780.8 6808.8 4051.9 4148.0 4151.8 4162.2 4197.0 2394.8 2443.6 2461.6 2488.8 2513.4 748.7 771.6 776.8 784.2 784.4 8835.0 8907.6 8907.9 8992.6 9006.6 3656.8 3730.2 3733.4 3813.9 3820.7 7688.3 7745.7 7772.0 7784.2 7879.1 4176.8 4192.6 4215.1 4222.7 4232.2 3450.8 3539.8 3801.2 3819.1 3864.5 3085.2 3164.6 3172.9 3194.6 3225.3 1003.2 1013.9 1022.3 1030.5 1032.0 867.0 871.6 920.1 983.2 1133.1 6241.7 6356.2 6388.1 6391.0 6391.2 954.7 964.4 977.7 978.1 998.3 4802.6 4878.0 4932.1 4947.0 4982.9 7791.8 7845.1 7933.4 8043.2 8046.1 7753.9 7799.1 7840.3 7845.6 7853.9 6111.8 6207.0 6208.8 6242.5 6320.7 6197.4 6306.3 6344.1 6352.2 6365.0 6990.7 7032.5 7124.9 7164.4 7195.0 7205.8 7261.1 7276.0 7336.2 7469.9 5428.9 5570.0 5955.0 6046.2 6055.2 6087.8 6364.8 6546.5 6547.2 6574.6 5728.8 5920.5 5970.3 6095.5 6133.0 5866.4 5931.4 5990.3 6003.9 6051.3 5823.5 6070.7 6077.8 6142.0 6142.1 5391.8 5426.8 5432.0 5447.0 5451.9 5494.0 5583.1 5610.2 5614.0 5618.7 15:17:05 INFO - 2015-11-16 15:17:05,267 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,269 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4727.50 Median:5452.98 stddev:1486.52 (27.3%) stddev-sans-first:1452.47 15:17:05 INFO - 2015-11-16 15:17:05,270 DEBUG : BROWSER_OUTPUT: Values: 264.9 269.7 270.0 270.4 271.2 5312.6 5329.5 5341.4 5355.4 5375.7 5238.8 5395.9 5433.3 5439.2 5466.7 4076.3 4084.0 4098.3 4144.0 4168.2 4088.3 4097.3 4105.4 4121.8 4158.7 3799.1 4061.4 4075.8 4095.8 4107.0 3890.8 3962.0 3981.4 4009.4 4031.2 3387.9 3387.9 3404.5 3414.2 3414.6 5048.1 5148.6 5168.2 5228.1 5267.4 4508.9 4510.0 4535.4 4576.1 4583.2 5642.6 5662.5 5674.9 5687.1 5707.7 3678.2 3692.7 3709.0 3716.6 3724.0 5753.9 5902.0 5945.1 5971.6 6012.5 3774.5 3778.3 3779.5 3781.8 3817.6 3852.2 3859.4 3863.7 3872.4 3892.8 4479.7 4507.2 4525.2 4535.0 4563.7 5499.1 5688.3 5690.4 5696.4 5706.6 1320.1 1345.4 1351.1 1355.2 1358.8 846.9 858.3 860.4 880.1 885.7 5364.7 5404.7 5428.2 5430.5 5485.0 5879.2 5904.3 5907.2 5912.6 5924.1 5411.8 5429.9 5430.8 5469.8 5474.4 3094.9 3174.7 3207.2 3213.6 3216.5 6108.4 6130.2 6132.9 6164.5 6174.9 5890.7 5952.9 6040.9 6111.1 6113.7 6118.1 6125.7 6126.9 6190.5 6198.8 5939.8 5941.1 5975.3 5986.7 5990.5 5594.1 5803.4 5806.8 5857.2 5889.2 6107.2 6121.6 6132.2 6174.3 6195.6 3803.4 3824.9 3825.8 3835.4 3849.5 5835.9 5954.9 5957.5 5973.2 6000.4 5752.3 5772.4 5774.4 5819.5 5825.4 5708.6 5727.7 5732.1 5756.6 5779.9 5587.2 5589.7 5652.3 5656.2 5671.0 5558.1 5743.0 5753.5 5794.6 5814.2 5636.0 5641.8 5650.4 5656.1 5697.0 15:17:05 INFO - 2015-11-16 15:17:05,270 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,270 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11144.53 Median:542.69 stddev:13847.50 (2551.7%) stddev-sans-first:13863.74 15:17:05 INFO - 2015-11-16 15:17:05,271 DEBUG : BROWSER_OUTPUT: Values: 607.4 609.2 636.1 636.3 638.3 11282.0 11475.4 12593.4 12924.2 12930.9 11775.9 11787.0 11813.6 11849.8 11855.0 713.6 715.4 718.9 720.3 734.8 572.8 583.3 673.0 716.4 717.4 724.7 731.5 740.6 741.6 747.0 728.8 729.1 730.4 730.6 731.1 537.4 537.5 542.6 542.7 546.1 11176.9 11316.3 11339.6 11377.1 11451.0 7534.5 7582.2 7688.8 7941.2 8505.1 7431.8 7506.9 7661.1 7902.3 7903.0 2443.3 2472.8 2502.4 2525.7 2554.1 38239.8 39245.4 39287.2 39399.8 39431.8 5490.2 5738.0 5864.9 5924.0 6108.5 9934.9 9947.3 10023.3 10057.5 10061.6 4901.3 4935.6 4978.0 5028.9 5228.7 2991.6 3075.1 3101.5 3128.8 3172.7 2234.4 2282.1 2295.2 2309.2 2317.2 326.9 327.2 328.9 334.0 338.4 400.4 434.6 453.8 487.9 492.3 6541.5 6665.6 6734.4 6748.4 6848.7 495.5 502.0 508.6 509.6 523.3 3255.5 3408.3 3445.3 3463.2 3554.5 50005.5 50611.2 50714.7 51291.0 51352.5 41912.8 42222.6 42527.4 42767.0 42891.8 40404.2 41377.4 41452.6 41960.0 42174.6 6865.7 6889.6 6926.3 6970.8 7133.6 29380.0 29478.7 29649.7 30010.7 30015.0 36541.5 37265.6 40293.4 40545.4 40601.8 6024.6 6061.2 6289.0 6325.1 6545.3 8962.3 9091.8 9144.1 9153.2 9156.5 8602.9 8604.3 8609.5 8634.3 8721.4 8373.5 8643.3 8673.6 8739.0 8764.0 8523.2 8524.5 8559.5 8634.9 8710.7 7363.7 7472.7 7629.0 7897.6 7950.0 7617.9 7641.2 7648.8 7671.5 7817.6 15:17:05 INFO - 2015-11-16 15:17:05,271 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:17:05 INFO - 2015-11-16 15:17:05,271 DEBUG : BROWSER_OUTPUT: 15:17:05 INFO - 2015-11-16 15:17:05,954 INFO : Browser exited with error code: 0 15:17:05 INFO - 2015-11-16 15:17:05,988 INFO : Completed test dromaeo_css (00:18:33) 15:17:05 INFO - 2015-11-16 15:17:05,988 INFO : Starting test kraken 15:17:05 INFO - 2015-11-16 15:17:05,988 DEBUG : operating with platform_type : mac_ 15:17:05 INFO - 2015-11-16 15:17:05,988 INFO : Initialising browser for kraken test... 15:17:06 INFO - 2015-11-16 15:17:06,004 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpzDCGTk/profile http://localhost:49265/getInfo.html 15:17:09 INFO - 2015-11-16 15:17:09,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:17:09 INFO - 2015-11-16 15:17:09,292 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:17:09 INFO - 2015-11-16 15:17:09,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:17:09 INFO - 2015-11-16 15:17:09,293 DEBUG : BROWSER_OUTPUT: __metrics 15:17:10 INFO - 2015-11-16 15:17:10,016 INFO : Browser initialized. 15:17:10 INFO - 2015-11-16 15:17:10,017 INFO : Running cycle 1/1 for kraken test... 15:17:10 INFO - 2015-11-16 15:17:10,017 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpzDCGTk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:17:22 INFO - 2015-11-16 15:17:22,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 241639424 15:17:22 INFO - 2015-11-16 15:17:22,243 DEBUG : BROWSER_OUTPUT: 15:17:25 INFO - 2015-11-16 15:17:25,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 15:17:25 INFO - 2015-11-16 15:17:25,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 259633152 15:17:25 INFO - 2015-11-16 15:17:25,782 DEBUG : BROWSER_OUTPUT: 15:17:28 INFO - 2015-11-16 15:17:28,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 15:17:29 INFO - 2015-11-16 15:17:29,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 267100160 15:17:29 INFO - 2015-11-16 15:17:29,464 DEBUG : BROWSER_OUTPUT: 15:17:32 INFO - 2015-11-16 15:17:32,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 15:17:33 INFO - 2015-11-16 15:17:33,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 267210752 15:17:33 INFO - 2015-11-16 15:17:33,400 DEBUG : BROWSER_OUTPUT: 15:17:35 INFO - 2015-11-16 15:17:35,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 15:17:36 INFO - 2015-11-16 15:17:36,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 268578816 15:17:36 INFO - 2015-11-16 15:17:36,261 DEBUG : BROWSER_OUTPUT: 15:17:38 INFO - 2015-11-16 15:17:38,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:17:39 INFO - 2015-11-16 15:17:39,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 268992512 15:17:39 INFO - 2015-11-16 15:17:39,279 DEBUG : BROWSER_OUTPUT: 15:17:42 INFO - 2015-11-16 15:17:42,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 15:17:43 INFO - 2015-11-16 15:17:43,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 267452416 15:17:43 INFO - 2015-11-16 15:17:43,465 DEBUG : BROWSER_OUTPUT: 15:17:47 INFO - 2015-11-16 15:17:47,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 15:17:47 INFO - 2015-11-16 15:17:47,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 265818112 15:17:47 INFO - 2015-11-16 15:17:47,748 DEBUG : BROWSER_OUTPUT: 15:17:51 INFO - 2015-11-16 15:17:51,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 15:17:51 INFO - 2015-11-16 15:17:51,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 267862016 15:17:51 INFO - 2015-11-16 15:17:51,657 DEBUG : BROWSER_OUTPUT: 15:17:53 INFO - 2015-11-16 15:17:53,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:54 INFO - 2015-11-16 15:17:54,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 267739136 15:17:54 INFO - 2015-11-16 15:17:54,017 DEBUG : BROWSER_OUTPUT: 15:17:56 INFO - 2015-11-16 15:17:56,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:56 INFO - 2015-11-16 15:17:56,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 267509760 15:17:56 INFO - 2015-11-16 15:17:56,691 DEBUG : BROWSER_OUTPUT: 15:17:59 INFO - 2015-11-16 15:17:59,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:59 INFO - 2015-11-16 15:17:59,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 267436032 15:17:59 INFO - 2015-11-16 15:17:59,688 DEBUG : BROWSER_OUTPUT: 15:18:02 INFO - 2015-11-16 15:18:02,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:18:03 INFO - 2015-11-16 15:18:03,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 267886592 15:18:03 INFO - 2015-11-16 15:18:03,330 DEBUG : BROWSER_OUTPUT: 15:18:06 INFO - 2015-11-16 15:18:06,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:18:06 INFO - 2015-11-16 15:18:06,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 268009472 15:18:06 INFO - 2015-11-16 15:18:06,989 DEBUG : BROWSER_OUTPUT: 15:18:08 INFO - 2015-11-16 15:18:08,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 15:18:09 INFO - 2015-11-16 15:18:09,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 268926976 15:18:09 INFO - 2015-11-16 15:18:09,155 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,156 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:18:09 INFO - 2015-11-16 15:18:09,157 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:18:09 INFO - 2015-11-16 15:18:09,157 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:18:09 INFO - 2015-11-16 15:18:09,157 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:18:09 INFO - 2015-11-16 15:18:09,157 DEBUG : BROWSER_OUTPUT: |0;ai-astar;132;124;142;138;137;146;132;132;133;142 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;170;195;203;165;184;180;161;202;166 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;217;208;206;198;202;202;202;205;211 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;92;100;152;84;89;91;96;127;85 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;104;109;155;111;114;114;150;110;108;157 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;150;150;150;156;155;149;149;157;157;147 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;165;164;158;157;157;164;164;162;156;165 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;140;123;138;128;126;126;123;123;133 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;75;79;81;80;84;81;86;80;80 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;79;87;85;85;89;90;89;89;87;85 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;106;107;112;112;112;114;111;107;106;108 15:18:09 INFO - 2015-11-16 15:18:09,158 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;168;180;160;180;166;174;166;160;164;153 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;193;197;199;198;192;193;193;191;195;190 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;82;86;86;88;90;92;92;93;90;87 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,763 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: __startTimestamp1447715889155__endTimestamp 15:18:09 INFO - 2015-11-16 15:18:09,159 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,161 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:18:09 INFO - 2015-11-16 15:18:09,161 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:18:09 INFO - 2015-11-16 15:18:09,161 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,161 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:135.80 Median:137.50 stddev:6.48 (4.7%) stddev-sans-first:6.72 15:18:09 INFO - 2015-11-16 15:18:09,162 DEBUG : BROWSER_OUTPUT: Values: 132.0 124.0 142.0 138.0 137.0 146.0 132.0 132.0 133.0 142.0 15:18:09 INFO - 2015-11-16 15:18:09,162 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,162 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.10 Median:184.50 stddev:15.45 (8.4%) stddev-sans-first:16.32 15:18:09 INFO - 2015-11-16 15:18:09,162 DEBUG : BROWSER_OUTPUT: Values: 185.0 170.0 195.0 203.0 165.0 184.0 180.0 161.0 202.0 166.0 15:18:09 INFO - 2015-11-16 15:18:09,162 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,163 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.80 Median:205.50 stddev:6.05 (2.9%) stddev-sans-first:5.72 15:18:09 INFO - 2015-11-16 15:18:09,163 DEBUG : BROWSER_OUTPUT: Values: 197.0 217.0 208.0 206.0 198.0 202.0 202.0 202.0 205.0 211.0 15:18:09 INFO - 2015-11-16 15:18:09,163 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,163 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.00 Median:87.00 stddev:22.24 (25.6%) stddev-sans-first:22.82 15:18:09 INFO - 2015-11-16 15:18:09,164 DEBUG : BROWSER_OUTPUT: Values: 84.0 92.0 100.0 152.0 84.0 89.0 91.0 96.0 127.0 85.0 15:18:09 INFO - 2015-11-16 15:18:09,165 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,165 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.20 Median:114.00 stddev:21.51 (18.9%) stddev-sans-first:21.67 15:18:09 INFO - 2015-11-16 15:18:09,165 DEBUG : BROWSER_OUTPUT: Values: 104.0 109.0 155.0 111.0 114.0 114.0 150.0 110.0 108.0 157.0 15:18:09 INFO - 2015-11-16 15:18:09,165 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,166 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:152.00 Median:152.50 stddev:3.80 (2.5%) stddev-sans-first:3.96 15:18:09 INFO - 2015-11-16 15:18:09,166 DEBUG : BROWSER_OUTPUT: Values: 150.0 150.0 150.0 156.0 155.0 149.0 149.0 157.0 157.0 147.0 15:18:09 INFO - 2015-11-16 15:18:09,166 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,166 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:161.20 Median:164.00 stddev:3.74 (2.3%) stddev-sans-first:3.70 15:18:09 INFO - 2015-11-16 15:18:09,166 DEBUG : BROWSER_OUTPUT: Values: 165.0 164.0 158.0 157.0 157.0 164.0 164.0 162.0 156.0 165.0 15:18:09 INFO - 2015-11-16 15:18:09,167 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,167 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:127.90 Median:127.00 stddev:6.94 (5.5%) stddev-sans-first:6.57 15:18:09 INFO - 2015-11-16 15:18:09,167 DEBUG : BROWSER_OUTPUT: Values: 119.0 140.0 123.0 138.0 128.0 126.0 126.0 123.0 123.0 133.0 15:18:09 INFO - 2015-11-16 15:18:09,167 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:79.60 Median:80.50 stddev:4.45 (5.5%) stddev-sans-first:3.08 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: Values: 70.0 75.0 79.0 81.0 80.0 84.0 81.0 86.0 80.0 80.0 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:86.50 Median:88.00 stddev:3.24 (3.7%) stddev-sans-first:2.00 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: Values: 79.0 87.0 85.0 85.0 89.0 90.0 89.0 89.0 87.0 85.0 15:18:09 INFO - 2015-11-16 15:18:09,168 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:109.50 Median:111.50 stddev:2.99 (2.7%) stddev-sans-first:2.89 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: Values: 106.0 107.0 112.0 112.0 112.0 114.0 111.0 107.0 106.0 108.0 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:167.10 Median:167.00 stddev:8.77 (5.3%) stddev-sans-first:9.30 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: Values: 168.0 180.0 160.0 180.0 166.0 174.0 166.0 160.0 164.0 153.0 15:18:09 INFO - 2015-11-16 15:18:09,169 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.10 Median:194.00 stddev:3.03 (1.6%) stddev-sans-first:3.19 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: Values: 193.0 197.0 199.0 198.0 192.0 193.0 193.0 191.0 195.0 190.0 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.60 Median:90.00 stddev:3.44 (3.8%) stddev-sans-first:2.69 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: Values: 82.0 86.0 86.0 88.0 90.0 92.0 92.0 93.0 90.0 87.0 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:18:09 INFO - 2015-11-16 15:18:09,170 DEBUG : BROWSER_OUTPUT: 15:18:09 INFO - 2015-11-16 15:18:09,906 INFO : Browser exited with error code: 0 15:18:09 INFO - 2015-11-16 15:18:09,965 INFO : Completed test kraken (00:01:03) 15:18:09 INFO - 2015-11-16 15:18:09,965 INFO : Starting test v8_7 15:18:09 INFO - 2015-11-16 15:18:09,965 DEBUG : operating with platform_type : mac_ 15:18:09 INFO - 2015-11-16 15:18:09,965 INFO : Initialising browser for v8_7 test... 15:18:09 INFO - 2015-11-16 15:18:09,980 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpY5caPZ/profile http://localhost:49265/getInfo.html 15:18:13 INFO - 2015-11-16 15:18:13,230 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:18:13 INFO - 2015-11-16 15:18:13,231 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:18:13 INFO - 2015-11-16 15:18:13,231 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:18:13 INFO - 2015-11-16 15:18:13,231 DEBUG : BROWSER_OUTPUT: __metrics 15:18:13 INFO - 2015-11-16 15:18:13,930 INFO : Browser initialized. 15:18:13 INFO - 2015-11-16 15:18:13,931 INFO : Running cycle 1/1 for v8_7 test... 15:18:13 INFO - 2015-11-16 15:18:13,931 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/T/tmpY5caPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:18:26 INFO - 2015-11-16 15:18:26,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 241274880 15:18:26 INFO - 2015-11-16 15:18:26,142 DEBUG : BROWSER_OUTPUT: 15:18:48 INFO - 2015-11-16 15:18:48,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 15:18:49 INFO - 2015-11-16 15:18:49,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 261693440 15:18:49 INFO - 2015-11-16 15:18:49,055 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,055 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |0;Richards;876.4241893076249 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;236.35074450484518 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |2;Encrypt;376.9317753486619 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6951.388888888889 15:18:49 INFO - 2015-11-16 15:18:49,056 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1369.86301369863 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: |5;Earley;953.2888465204957 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: |6;Boyer;16426.22950819672 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: |7;RegExp;34741.379310344826 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: |8;Splay;884.9557522123894 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6883.561643835616 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: __startTimestamp1447715929048__endTimestamp 15:18:49 INFO - 2015-11-16 15:18:49,057 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:876.42 Median:876.42 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: Values: 876.4 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:236.35 Median:236.35 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,058 DEBUG : BROWSER_OUTPUT: Values: 236.4 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:376.93 Median:376.93 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: Values: 376.9 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6951.39 Median:6951.39 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: Values: 6951.4 15:18:49 INFO - 2015-11-16 15:18:49,059 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1369.86 Median:1369.86 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: Values: 1369.9 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:953.29 Median:953.29 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: Values: 953.3 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,060 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16426.23 Median:16426.23 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: Values: 16426.2 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34741.38 Median:34741.38 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: Values: 34741.4 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:884.96 Median:884.96 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,061 DEBUG : BROWSER_OUTPUT: Values: 885.0 15:18:49 INFO - 2015-11-16 15:18:49,062 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,062 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6883.56 Median:6883.56 stddev:0.00 (0.0%) 15:18:49 INFO - 2015-11-16 15:18:49,062 DEBUG : BROWSER_OUTPUT: Values: 6883.6 15:18:49 INFO - 2015-11-16 15:18:49,062 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:18:49 INFO - 2015-11-16 15:18:49,062 DEBUG : BROWSER_OUTPUT: 15:18:49 INFO - 2015-11-16 15:18:49,784 INFO : Browser exited with error code: 0 15:18:49 INFO - 2015-11-16 15:18:49,809 INFO : Completed test v8_7 (00:00:39) 15:18:49 INFO - 2015-11-16 15:18:49,972 INFO : Completed test suite (00:20:17) 15:18:49 INFO - 2015-11-16 15:18:49,972 DEBUG : Working with test: dromaeo_css 15:18:49 INFO - 2015-11-16 15:18:49,972 DEBUG : Generating results file: dromaeo_css 15:18:49 INFO - 2015-11-16 15:18:49,973 DEBUG : Working with test: kraken 15:18:49 INFO - 2015-11-16 15:18:49,973 DEBUG : Generating results file: kraken 15:18:49 INFO - 2015-11-16 15:18:49,973 INFO : javascript benchmark 15:18:49 INFO - 2015-11-16 15:18:49,973 DEBUG : Working with test: v8_7 15:18:49 INFO - 2015-11-16 15:18:49,973 DEBUG : Generating results file: v8_7 15:18:49 INFO - 2015-11-16 15:18:49,973 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:50 INFO - 2015-11-16 15:18:50,023 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 15:18:50 INFO - 2015-11-16 15:18:50,023 DEBUG : process_Request line: dromaeo_css 5546.35 graph.html#tests=[[72,64,57]] 15:18:50 INFO - 2015-11-16 15:18:50,023 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:50 INFO - 2015-11-16 15:18:50,057 DEBUG : process_Request line: kraken 1911.40 graph.html#tests=[[232,64,57]] 15:18:50 INFO - 2015-11-16 15:18:50,057 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:50 INFO - 2015-11-16 15:18:50,085 DEBUG : process_Request line: v8_7 13846.47 graph.html#tests=[[230,64,57]] 15:18:50 INFO - 2015-11-16 15:18:50,086 INFO : javascript benchmark 15:18:50 INFO - 2015-11-16 15:18:50,088 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [275.7339167703166, 276.4691791759821, 276.7243009725168, 282.48446584982406, 286.14585462394757, 11416.257943233684, 13786.448542058319, 14160.50438234662, 14207.857921420795, 14918.776218356734, 14614.634634134125, 14742.33659485323, 14755.336009879555, 14958.626034349147, 14960.700785984274, 3738.906527336811, 3889.3193691104084, 3930.744501607386, 4220.155968806243, 4464.5981861632445, 3904.5900180481067, 3912.8434862605604, 3939.7439166454233, 3940.2119576084756, 4015.4980627421573, 2749.752522272995, 2780.207640822366, 3658.4512323151475, 3884.3396622574232, 3900.1029763154493, 3842.212346468967, 3870.6516413522777, 3886.591907849663, 3905.2384784966944, 3932.7640341579454, 3285.78642388244, 3301.7688761786685, 3331.083951913219, 3354.4297469430257, 3355.144438168276, 10192.592296308212, 10695.03744662984, 10707.571697132105, 10709.410982395964, 10813.67558973232, 1455.0469442515064, 1536.431520337471, 1538.7845701601784, 1661.3188592677066, 1681.377890180641, 7530.548167109936, 7832.412569057344, 7952.0, 7987.321077708401, 8022.237887400687, 1189.0962868220129, 1242.8694987026322, 1259.508791571288, 1271.0784681106124, 1349.1702602899245, 47578.28632570514, 47991.520084799056, 48058.27912581279, 49138.50861491375, 49307.50692493065, 5319.840404787863, 5330.147176451749, 5382.973085134628, 5399.595030372738, 5423.322084739408, 6062.2725272966645, 6111.54163437744, 6149.385061493905, 6154.938450615526, 6181.783637572753, 4245.469316335458, 4336.934945975813, 4344.131173765197, 4359.476862776423, 4378.2119218540965, 4531.43357080365, 4535.931961020521, 4564.497905230422, 4567.314902764546, 4589.5181005994555, 2376.39401952501, 2379.1791831817995, 2388.665586817847, 2391.5770116780486, 2424.175780234729, 828.9378296627777, 829.8049958259804, 848.8090179709516, 850.2177996243471, 921.6543796076471, 337.73319077928653, 348.1296758104738, 357.4905759292997, 375.000623338799, 376.98680546180753, 9373.343865929319, 9451.385659932082, 9484.241260699127, 9677.467739274267, 9708.417494950325, 360.6105406161392, 371.1371062280209, 372.3112242351628, 373.54800691163996, 377.2153919846712, 4844.467108618049, 5180.378354597472, 5215.061288968022, 5242.816501422432, 5304.336957880265, 447209.0, 462533.0, 470893.0, 471648.0, 475506.0, 57322.0, 58156.0, 58501.0, 59036.40963590395, 59328.40671593315, 401.05751484012336, 404.1210367450783, 404.443889651723, 405.35346122933873, 406.4736166664118, 8774.07872173438, 8775.473471591726, 8872.955635221782, 8893.377463577488, 8935.017148113833, 28167.591620418487, 28683.85658071696, 28730.712692872803, 28794.136175914755, 28870.0, 37234.44148337723, 37603.62396376111, 38246.0, 38499.0, 39013.609863900994, 4970.229614409773, 4980.153373926513, 5085.6185786066935, 5093.0, 5111.514406131411, 9344.579493922654, 9631.951840240754, 9667.081627245401, 9720.611175552898, 9782.706518804447, 8120.593970301343, 8182.1817818217705, 8234.505929644241, 8345.040320362994, 8431.831363372821, 6899.448044156556, 7953.6818527258265, 7971.920280797118, 7979.72070977513, 8152.062512811102, 8274.669013239403, 8292.17078292166, 8321.6671333146, 8354.79113022155, 8449.23956843887, 4945.060438516671, 4991.575716064175, 4993.375828021497, 5041.949580504148, 5056.216286475602, 8117.594120294079, 8130.02439707239, 8199.42604017713, 8319.417640765088, 8406.033306169624], "dojo.html": [2675.9732402675972, 2693.1920423872834, 2719.9320016999573, 2752.6696796384435, 2765.3639662877526, 4536.410266665337, 4641.512641172675, 4647.558481944218, 4654.976725116374, 4669.0428462165255, 4450.977745111278, 4452.732836029841, 4536.206163921317, 4578.748168850712, 4601.5398460153965, 4212.0, 4223.6409905158025, 4242.787860606973, 4270.935935960963, 4297.742135471866, 4229.259879521087, 4327.610515053644, 4334.913301733964, 4345.152695224432, 4452.8441504547345, 4023.939640905389, 4154.210699967027, 4180.310248808943, 4229.809658565372, 4290.935635965463, 4167.91664166718, 4212.705110642256, 4219.38818871265, 4256.2764330063965, 4267.167902259061, 4211.620954114144, 4230.2174097792, 4253.106847562016, 4283.97858010711, 4289.806958686867, 4358.8038538265855, 4392.34114882767, 4424.933625995581, 4556.020455602028, 4570.520095390003, 4874.878128046792, 4919.7540122993705, 4925.876853078666, 4927.704337739747, 4939.604831613498, 4781.474037855833, 4943.283223932545, 4991.301217829507, 5070.847874563769, 5079.949200507985, 4491.483479399878, 4511.729296242236, 4589.931151032737, 4614.838480653195, 4616.16908956391, 4788.497207793202, 5054.393472783216, 5059.822906198339, 5070.721110338893, 5098.0, 4593.104344652827, 4751.83368582098, 4790.473047964721, 4821.686590371684, 4911.091448082117, 4804.807807687654, 4893.877653058702, 4914.434839993446, 4918.262260660858, 4951.183054795918, 4835.879103022453, 4855.32025516428, 4856.17445034345, 4862.112897388968, 4865.489123641966, 4679.344891715163, 4739.644526660514, 4825.710457372498, 4866.853994380174, 4944.55499005084, 3818.9236215276096, 3827.1197624545953, 3868.574456809805, 3878.398848178537, 3911.941320880189, 3328.8169150696945, 3459.1697992482127, 3469.9653003469643, 3485.4597537381746, 3489.755717099779, 4446.577575130357, 4497.527759585197, 4611.054733779567, 4643.141018911512, 4655.37152484417, 4914.385701787277, 4946.3817022872145, 4959.776810043557, 4964.528369804862, 5053.494650534991, 4563.178627847019, 4625.398698169217, 4655.4180727409075, 4671.995520963009, 4708.529147085264, 4196.307609244502, 4228.619424251832, 4234.1108367242605, 4272.658187345067, 4320.4383430153875, 5049.495050494921, 5051.368578927634, 5065.898682026339, 5076.543111120017, 5079.974600126976, 4551.681382303207, 4978.6763860348965, 4981.452040275639, 5000.324956130876, 5040.193569029085, 4906.239532872411, 4913.164761990399, 4957.454679985127, 5007.624428167975, 5040.319556859777, 4864.148773964472, 4873.634477414279, 4913.287573301923, 4927.778249978831, 4992.850214493571, 4781.856544303677, 4929.704217746947, 4937.851864444073, 4976.0794253063295, 5003.3495645565845, 4740.336352910665, 4830.516948305141, 4858.78135483897, 4878.951210487991, 4895.118878601744, 4791.353167322367, 4795.184818580919, 4824.614030877591, 4844.370231869834, 4853.830115945925, 4446.0885518467985, 4525.049739554599, 4615.83844565452, 4724.220503616864, 4737.8341758038305, 4754.0, 4790.712557246577, 4843.0, 4854.611631069577, 4855.0, 4687.484376718627, 4689.413823272091, 4710.24636058229, 4729.43246810385, 4729.763511824463], "mootools.html": [1442.466287473635, 1462.7732701431269, 1498.183489997951, 1501.3560151633958, 1506.5932198306464, 5944.643321400719, 6106.267247930255, 6668.399844014038, 6900.551464154826, 6942.305769423056, 6107.908381374283, 6206.565540412173, 6359.809205723825, 6395.424411802936, 6408.903866441996, 1892.7728672559313, 1941.3011315926256, 1944.0377013378327, 1947.2016473245972, 1954.208545539059, 1891.6216756648657, 1920.654282229198, 1931.5943651833131, 1932.0822609260629, 1938.2925232290183, 1870.8971006594631, 1923.2210954563425, 1935.9322423715103, 1936.4674714453497, 1940.0590713503939, 1805.4583624912473, 1840.6778813707615, 1855.749473821044, 1859.4421673497895, 1863.4409677096953, 1880.7272945422837, 1901.4770937992025, 1910.14043680343, 1949.5905859769466, 1962.842972562206, 6607.2071351438135, 6728.461723062143, 6778.288279730656, 6780.796576102724, 6808.761693340709, 4051.8581849635416, 4148.045949431617, 4151.750894946313, 4162.188373267214, 4197.0, 2394.820388470872, 2443.645671377658, 2461.5569197544437, 2488.7635674610883, 2513.40934880303, 748.7267147491126, 771.5910567399287, 776.7708525984848, 784.2040329066002, 784.3764207455087, 8835.0, 8907.554622268926, 8907.866382004275, 8992.640294388217, 9006.639734410615, 3656.800374341639, 3730.235301763132, 3733.439984002367, 3813.923721525554, 3820.675242604354, 7688.269614386624, 7745.651445684845, 7771.961140194263, 7784.2215778421705, 7879.054513458422, 4176.791160441966, 4192.622663960197, 4215.051613386963, 4222.683298752606, 4232.174725928476, 3450.7756995795194, 3539.752217344761, 3801.163743976321, 3819.064329239299, 3864.53625564934, 3085.1515833146063, 3164.620245570546, 3172.857221425041, 3194.5687332209855, 3225.2581906161713, 1003.1874181912674, 1013.9290249682451, 1022.2895087913829, 1030.4744580263969, 1032.0247366238832, 867.0332579174176, 871.6208449324564, 920.1396694091046, 983.2429029647275, 1133.0991861470152, 6241.687915604201, 6356.173697419306, 6388.073729309224, 6390.968045159838, 6391.242408337652, 954.6849539651898, 964.3972517176765, 977.726236653738, 978.1490103609763, 998.3211416236884, 4802.591779698695, 4878.0, 4932.062908047459, 4947.0, 4982.9252561211615, 7791.766247012599, 7845.137034926153, 7933.404994625426, 8043.1554686757045, 8046.114927357986, 7753.883691744629, 7799.142094369615, 7840.255175758294, 7845.607719613997, 7853.921460785434, 6111.786087487006, 6206.968965155145, 6208.81373558794, 6242.469390101802, 6320.747170113236, 6197.411245931629, 6306.274778400542, 6344.080108384351, 6352.205974253218, 6365.04524321337, 6990.6504674767075, 7032.472564557781, 7124.857502850017, 7164.426845852215, 7194.964025179841, 7205.819854503469, 7261.056062711814, 7276.0, 7336.193018768038, 7469.925300747141, 5428.864278393072, 5569.972150139223, 5954.970225148846, 6046.2139921809885, 6055.2430946131735, 6087.847803804941, 6364.809055728336, 6546.476281897341, 6547.214334279917, 6574.638394888327, 5728.79949201776, 5920.496757775637, 5970.253718285215, 6095.451409373178, 6132.98805697055, 5866.354700982974, 5931.406859314034, 5990.251218597676, 6003.939960600338, 6051.334353221054, 5823.534117270524, 6070.726817293321, 6077.787277445445, 6141.969290153699, 6142.109394137914, 5391.838244852661, 5426.7829286829665, 5431.972840135774, 5447.046766815871, 5451.945480545144, 5494.0, 5583.050881350099, 5610.158476228598, 5614.04561224601, 5618.69097199658], "ext.html": [430.1332814379026, 438.16529511281, 453.74816976577983, 461.3034318179549, 479.9776476105894, 32285.838570807144, 32870.342593148125, 32885.67114328856, 32916.50625240617, 33321.833390833075, 34773.47839782405, 35481.46777798335, 35545.644543554554, 35715.0, 35903.281934361294, 7514.924850751505, 7723.459357844953, 7809.219078092202, 7816.0, 7842.019747531559, 7550.6602202901, 7672.1560628330835, 7698.422618303622, 7761.611919404036, 7779.9222007780045, 7533.6986520539385, 7647.961760191191, 7658.425618078639, 7692.538447693129, 7734.265244801763, 7600.50596711212, 7715.382769378436, 7750.0, 7757.030371203599, 7793.96103019487, 7537.773866784005, 7655.540667559909, 7676.309132178131, 7726.613669316568, 7767.53394796314, 32415.351692966007, 32873.83563082193, 32879.67120328814, 33019.504707429405, 33228.00315990524, 2409.5180963807134, 2488.8675652578036, 2796.2170592234206, 2931.2818359501844, 2977.0919869439813, 22526.66210006851, 22853.7714622855, 23190.3042908713, 23810.0, 24027.038918443242, 1948.756405449319, 1962.1562728026943, 1965.557749506364, 1980.5939782344585, 1980.6236815005102, 223153.0, 223591.8820405904, 223664.0, 225736.0, 225805.0, 46387.0, 46551.30173047407, 46569.534304657194, 46598.0, 46813.76593117013, 46624.0, 47656.52343476521, 50862.23706644403, 51396.48603513992, 52229.7388513055, 11876.168668193317, 12070.698232544257, 12091.939540302243, 12224.694382640506, 12230.938845305716, 9138.451692898447, 9312.90687093134, 9360.90639093614, 9362.297827662816, 9391.107844754737, 15358.462453814063, 15520.456784012731, 15524.456644017406, 15596.92201538985, 15924.92037539805, 6805.523613347117, 7045.154581450259, 7051.435885129177, 7067.71729130829, 7090.220075791659, 780.8399278147966, 787.6809891993752, 868.1795703060674, 949.8052899155656, 952.0574631115146, 23483.178088767152, 23578.646320305208, 23772.405689857893, 23859.284221473383, 24104.915278812146, 827.0943317067921, 843.2705709561185, 852.4757274276276, 859.4070091636751, 899.3434792601438, 12192.756144877052, 12391.566295179626, 12547.372631368395, 12646.936765316299, 12693.428795704216, 260351.0, 263505.0, 264441.0, 266048.0, 268158.0, 43865.78067109644, 43942.34086488705, 44070.33894491585, 44130.55869441265, 44833.55166448359, 1144.113312183048, 1148.4257871064467, 1163.0172504234079, 1164.3886959346412, 1181.1436708386352, 23048.539029218988, 23207.419814504774, 23312.417189570395, 23536.176233831735, 23567.41081472977, 39036.21927561376, 39073.0, 39157.412638809874, 39574.40638390484, 39605.80197098996, 228973.0, 232520.0, 233056.0, 234830.0, 236256.0, 25475.36311592225, 26143.215703528924, 26199.0, 26272.868635656698, 26442.471150577265, 31210.21974450657, 31644.683553165094, 31675.20811979719, 32423.513647294836, 32485.350292993535, 26471.229509821685, 28622.0, 28645.713542864305, 28704.0, 28728.425431491672, 28479.857600711865, 28852.711472885003, 28853.134405967856, 28858.855705721337, 28948.855255723585, 29000.7099928998, 29139.7086029137, 29358.853205733834, 29564.113076607737, 29660.25849353697, 23614.763852361255, 24410.389740256636, 25274.0, 25546.74453255518, 25804.225873223833, 19379.4186174415, 19394.0, 19571.804281956996, 19709.704354434984, 20133.899330503253], "prototype.html": [264.876832272993, 269.70736750625576, 269.96220529125924, 270.4051087607265, 271.22024180481117, 5312.574994000481, 5329.546988505972, 5341.359036915571, 5355.384130824957, 5375.677459352437, 5238.79044838206, 5395.919061214076, 5433.266509021281, 5439.238506609078, 5466.726663666821, 4076.2866498362814, 4083.959160408395, 4098.262312783698, 4143.958560414388, 4168.208040472316, 4088.2641124597562, 4097.262492751303, 4105.44576482174, 4121.752694838305, 4158.688098392633, 3799.1262009737775, 4061.3704875744306, 4075.8369665213354, 4095.8361665533344, 4106.993786522306, 3890.824912878927, 3961.98019009906, 3981.402789581557, 4009.3585026395635, 4031.173609410064, 3387.8814241501427, 3387.915302117442, 3404.5233667286598, 3414.197663549064, 3414.641462646436, 5048.1418158913075, 5148.588112950955, 5168.198929165947, 5228.08508511009, 5267.420583735786, 4508.909821803545, 4509.977450112761, 4535.387722657432, 4576.0619073090265, 4583.220852455091, 5642.633228840113, 5662.518685911702, 5674.865026994617, 5687.118496632987, 5707.657540547539, 3678.2459595782802, 3692.7045836333027, 3709.017110465729, 3716.572594151653, 3723.962760372389, 5753.88492230153, 5902.0, 5945.108233764927, 5971.641701497924, 6012.549058820606, 3774.5470543534952, 3778.3387907116144, 3779.508663873679, 3781.7541859779576, 3817.560980487224, 3852.152526444178, 3859.3632050711317, 3863.6715879150024, 3872.3997780344093, 3892.766434013968, 4479.70881892676, 4507.166174257773, 4525.230710779176, 4534.959268329265, 4563.748993805372, 5499.092649712833, 5688.317401911797, 5690.4025077367105, 5696.401877802854, 5706.629069110578, 1320.1485042147954, 1345.3744009035845, 1351.094766506443, 1355.213975893979, 1358.809766632672, 846.9195426434479, 858.2576071697937, 860.3719284921917, 880.0803160697087, 885.6988623867916, 5364.6512976656395, 5404.675719456766, 5428.212909128154, 5430.5384042356845, 5485.0, 5879.206307148565, 5904.321003084614, 5907.202527658711, 5912.586118971717, 5924.111383292455, 5411.756470958816, 5429.945700543023, 5430.8099216527235, 5469.835904922858, 5474.39781624021, 3094.8607312670983, 3174.682531746807, 3207.1821685470054, 3213.5983002124735, 3216.533602627606, 6108.389161083945, 6130.233720784902, 6132.908006379907, 6164.506839452833, 6174.876502469925, 5890.705464726747, 5952.9107063394085, 6040.939590604038, 6111.083337499411, 6113.6855576050475, 6118.1128736332985, 6125.693715314216, 6126.938730612636, 6190.473809726223, 6198.752049917953, 5939.762409503572, 5941.1385349125, 5975.312839023568, 5986.6707331097205, 5990.460858522754, 5594.0769772987005, 5803.448672376117, 5806.82579522615, 5857.209276747584, 5889.234399528034, 6107.175531303217, 6121.602095863755, 6132.202813634199, 6174.289956655042, 6195.628262304276, 3803.372443546784, 3824.8661296854475, 3825.846966121324, 3835.386338185877, 3849.5188101487315, 5835.912461312999, 5954.851128721816, 5957.463828255478, 5973.223480947449, 6000.429959153874, 5752.252207213036, 5772.422757724194, 5774.422557744192, 5819.516023414002, 5825.388334225015, 5708.57185711065, 5727.713614319351, 5732.111522713986, 5756.625819321731, 5779.913301300568, 5587.189857470563, 5589.748461319169, 5652.321721393295, 5656.1798539212405, 5671.0, 5558.138488534122, 5742.971285143548, 5753.482186603226, 5794.594378393641, 5814.186013958134, 5636.0, 5641.830745077655, 5650.350209725934, 5656.123300888369, 5697.0], "yui.html": [607.4259824465881, 609.198903441974, 636.0999186151595, 636.3064259956647, 638.3297537585534, 11282.0, 11475.426228688564, 12593.370331483424, 12924.15992960457, 12930.935345323283, 11775.882241177585, 11787.0, 11813.645590632274, 11849.7630047399, 11855.0, 713.568291183834, 715.4133610439429, 718.8706032914073, 720.3444865172694, 734.7612026091515, 572.7794799002394, 583.2738240890097, 672.9528932974694, 716.3517017099533, 717.4188906985332, 724.7173602295109, 731.4843035659874, 740.5741698523344, 741.636598066946, 746.9626518674072, 728.7777227945475, 729.0631538473064, 730.3536370312258, 730.5543618392776, 731.1336066760905, 537.4115343698644, 537.4517991648536, 542.6282996147652, 542.7449098923539, 546.1343770124357, 11176.944115279453, 11316.321020738782, 11339.603113891057, 11377.089832813355, 11451.0, 7534.54792712439, 7582.203868593773, 7688.769336919901, 7941.166177551389, 8505.106963768778, 7431.8142046449275, 7506.887396689054, 7661.118971318314, 7902.328302094329, 7903.0, 2443.3402981195154, 2472.7527247275307, 2502.436951685874, 2525.747425257478, 2554.106062877978, 38239.80880095582, 39245.41131883024, 39287.214255715015, 39399.8030009851, 39431.802840985896, 5490.231367608538, 5737.971310143423, 5864.941350586525, 5923.970380148072, 6108.511319094462, 9934.900650993397, 9947.253955953187, 10023.348482348623, 10057.547410366551, 10061.597536098621, 4901.264810278415, 4935.555799978019, 4977.950220497821, 5028.874278143003, 5228.712420816815, 2991.6110905582136, 3075.0928476099157, 3101.5347697845505, 3128.8279144647263, 3172.682731726809, 2234.441389652587, 2282.0529480265836, 2295.1966811615803, 2309.203324852923, 2317.154238702861, 326.87905474973934, 327.22284574136427, 328.9029736227819, 333.98635142342874, 338.40609729923824, 400.37941191153595, 434.60668095373103, 453.78445238511443, 487.9438864530624, 492.32797231778363, 6541.542092053605, 6665.600063996176, 6734.3602357775935, 6748.358905903931, 6848.657567121624, 495.45747406589726, 501.9949800502021, 508.6464906889676, 509.5846884788885, 523.2831021500568, 3255.5279484474618, 3408.2672225471147, 3445.3109378124477, 3463.203463203427, 3554.5201397810965, 50005.49994500081, 50611.24083138756, 50714.74642626763, 51291.0, 51352.48647513552, 41912.790436047624, 42222.57777422186, 42527.36208956868, 42767.0, 42891.78554107272, 40404.15150181997, 41377.37933931054, 41452.585474145475, 41960.0, 42174.578254217064, 6865.691043902936, 6889.586624802528, 6926.307369263033, 6970.79087627372, 7133.607651579213, 29380.0, 29478.705212947596, 29649.70079338527, 30010.699893001663, 30015.0, 36541.45187822238, 37265.6273437273, 40293.39559906662, 40545.391819123324, 40601.79699101485, 6024.581805882344, 6061.212042434456, 6288.968555157195, 6325.082862984934, 6545.312742162005, 8962.283017358726, 9091.814776440498, 9144.131307525775, 9153.17621414076, 9156.542172891195, 8602.91397086021, 8604.311655067704, 8609.48343099416, 8634.266087382643, 8721.389502734748, 8373.455725377831, 8643.308535317285, 8673.609687563949, 8739.0, 8764.035956044703, 8523.190296921783, 8524.488530688179, 8559.486430814171, 8634.913650863411, 8710.69512567057, 7363.668634911549, 7472.701091956478, 7629.0, 7897.605119744105, 7950.045994480699, 7617.885731714139, 7641.197674244347, 7648.8144337627755, 7671.501352412075, 7817.570033648204]}, "summary": {"lowerIsBetter": false, "suite": 5546.348905743262, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5449.443867953887, "unit": "ms", "value": 5449.443867953887}, "dojo.html": {"lowerIsBetter": false, "filtered": 4536.05468437349, "unit": "ms", "value": 4536.05468437349}, "mootools.html": {"lowerIsBetter": false, "filtered": 3827.0444473891107, "unit": "ms", "value": 3827.0444473891107}, "ext.html": {"lowerIsBetter": false, "filtered": 15028.287805360145, "unit": "ms", "value": 15028.287805360145}, "prototype.html": {"lowerIsBetter": false, "filtered": 4225.1875220647535, "unit": "ms", "value": 4225.1875220647535}, "yui.html": {"lowerIsBetter": false, "filtered": 4845.663535113909, "unit": "ms", "value": 4845.663535113909}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447714712, "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": "20151116131535", "branch": "Fx-Team", "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 217.0, 208.0, 206.0, 198.0, 202.0, 202.0, 202.0, 205.0, 211.0], "ai-astar": [132.0, 124.0, 142.0, 138.0, 137.0, 146.0, 132.0, 132.0, 133.0, 142.0], "imaging-gaussian-blur": [150.0, 150.0, 150.0, 156.0, 155.0, 149.0, 149.0, 157.0, 157.0, 147.0], "audio-beat-detection": [185.0, 170.0, 195.0, 203.0, 165.0, 184.0, 180.0, 161.0, 202.0, 166.0], "json-stringify-tinderbox": [79.0, 87.0, 85.0, 85.0, 89.0, 90.0, 89.0, 89.0, 87.0, 85.0], "stanford-crypto-pbkdf2": [193.0, 197.0, 199.0, 198.0, 192.0, 193.0, 193.0, 191.0, 195.0, 190.0], "json-parse-financial": [70.0, 75.0, 79.0, 81.0, 80.0, 84.0, 81.0, 86.0, 80.0, 80.0], "stanford-crypto-sha256-iterative": [82.0, 86.0, 86.0, 88.0, 90.0, 92.0, 92.0, 93.0, 90.0, 87.0], "audio-fft": [84.0, 92.0, 100.0, 152.0, 84.0, 89.0, 91.0, 96.0, 127.0, 85.0], "imaging-darkroom": [165.0, 164.0, 158.0, 157.0, 157.0, 164.0, 164.0, 162.0, 156.0, 165.0], "stanford-crypto-ccm": [168.0, 180.0, 160.0, 180.0, 166.0, 174.0, 166.0, 160.0, 164.0, 153.0], "audio-oscillator": [104.0, 109.0, 155.0, 111.0, 114.0, 114.0, 150.0, 110.0, 108.0, 157.0], "stanford-crypto-aes": [106.0, 107.0, 112.0, 112.0, 112.0, 114.0, 111.0, 107.0, 106.0, 108.0], "imaging-desaturate": [119.0, 140.0, 123.0, 138.0, 128.0, 126.0, 126.0, 123.0, 123.0, 133.0]}, "summary": {"lowerIsBetter": true, "suite": 1911.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 100.0, "unit": "ms", "value": 100.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 194.1, "unit": "ms", "value": 194.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 181.1, "unit": "ms", "value": 181.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 167.1, "unit": "ms", "value": 167.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 161.2, "unit": "ms", "value": 161.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 79.6, "unit": "ms", "value": 79.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 123.2, "unit": "ms", "value": 123.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 135.8, "unit": "ms", "value": 135.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 204.8, "unit": "ms", "value": 204.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.6, "unit": "ms", "value": 88.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 86.5, "unit": "ms", "value": 86.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 152.0, "unit": "ms", "value": 152.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 127.9, "unit": "ms", "value": 127.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447714712, "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": "20151116131535", "branch": "Fx-Team", "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245"}}, {"talos_counters": {}, "results": {"DeltaBlue": [236.35074450484518], "Encrypt": [376.9317753486619], "NavierStokes": [6883.561643835616], "Decrypt": [6951.388888888889], "Splay": [884.9557522123894], "Richards": [876.4241893076249], "RegExp": [34741.379310344826], "Earley": [953.2888465204957], "Boyer": [16426.22950819672], "RayTrace": [1369.86301369863]}, "summary": {"lowerIsBetter": false, "suite": 13846.467159871805, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 279.74525800000004, "unit": "score", "value": 279.74525800000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 706.1781930000002, "unit": "score", "value": 706.1781930000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 215.5860696517415, "unit": "score", "value": 215.5860696517415}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.29177222777224, "unit": "score", "value": 38.29177222777224}, "Splay": {"lowerIsBetter": false, "filtered": 92.08483000000004, "unit": "score", "value": 92.08483000000004}, "RegExp": {"lowerIsBetter": false, "filtered": 26.221900744416892, "unit": "score", "value": 26.221900744416892}, "Richards": {"lowerIsBetter": false, "filtered": 40.279582000000005, "unit": "score", "value": 40.279582000000005}, "Earley": {"lowerIsBetter": false, "filtered": 699.1196869999998, "unit": "score", "value": 699.1196869999998}, "Boyer": {"lowerIsBetter": false, "filtered": 40.573096806387234, "unit": "score", "value": 40.573096806387234}, "RayTrace": {"lowerIsBetter": false, "filtered": 540.1919699999999, "unit": "score", "value": 540.1919699999999}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0057.e"}, "testrun": {"date": 1447714712, "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": "20151116131535", "branch": "Fx-Team", "revision": "4e0d0bf80b36e05be962ef860cbd62b63fe8b245"}}] 15:18:50 INFO - RETURN: dromaeo_css: 5546.35 15:18:50 INFO - RETURN: kraken: 1911.40 15:18:50 INFO - RETURN: v8_7: 13846.47 15:18:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "13846.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1911.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5546.35"}}} 15:18:50 INFO - Return code: 0 15:18:50 INFO - # TBPL SUCCESS # 15:18:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:50 INFO - 2015-11-16 15:18:50.214 screenresolution[1665:10678] starting screenresolution argv=screenresolution get 15:18:50 INFO - 2015-11-16 15:18:50.218 screenresolution[1665:10678] Display 0: 1600x1200x32@60 15:18:50 INFO - 2015-11-16 15:18:50.224 screenresolution[1666:10681] starting screenresolution argv=screenresolution list 15:18:50 INFO - Available Modes on Display 0 15:18:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:50 INFO - Intel HD Graphics 3000: 15:18:50 INFO - Chipset Model: Intel HD Graphics 3000 15:18:50 INFO - Type: GPU 15:18:50 INFO - Bus: Built-In 15:18:50 INFO - VRAM (Total): 512 MB 15:18:50 INFO - VRAM (Dynamic, Max): 10 15:18:50 INFO - Vendor: Intel (0x8086) 15:18:50 INFO - Device ID: 0x0116 15:18:50 INFO - Revision ID: 0x0009 15:18:50 INFO - Displays: 15:18:50 INFO - Display: 15:18:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:50 INFO - Display Serial Number: 1600x1200 60 15:18:50 INFO - Main Display: Yes 15:18:50 INFO - Mirror: Off 15:18:50 INFO - Online: Yes 15:18:50 INFO - Rotation: Supported 15:18:50 INFO - Return code: 0 15:18:50 INFO - Running post-action listener: _resource_record_post_action 15:18:50 INFO - Running post-run listener: _resource_record_post_run 15:18:51 INFO - Total resource usage - Wall time: 1262s; CPU: 30.0%; Read bytes: 40772608; Write bytes: 689531904; Read time: 5402; Write time: 56563 15:18:51 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 335301120; Write bytes: 333850624; Read time: 37243; Write time: 3935 15:18:51 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 39814144; Write bytes: 345318400; Read time: 4904; Write time: 52115 15:18:51 INFO - Running post-run listener: _upload_blobber_files 15:18:51 INFO - Blob upload gear active. 15:18:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:18:51 INFO - Copying logs to upload dir... 15:18:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1321.650014 ========= master_lag: 6.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 8 secs) (at 2015-11-16 15:18:58.027347) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:18:58.036747) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010277 build_url: 'https://queue.taskcluster.net/v1/task/3j5wJpciR9-ZSG8DcC1F5w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.80 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:18:58.842262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:18:58.842657) ========= 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.DmEjgzSfkr/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.lug1TqLUhC/Listeners TMPDIR=/var/folders/4p/yf9nkh653_7_rtvs20d81y_400000w/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.005364 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:18:58.893210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:18:58.893576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:18:58.898968) ========= ========= Total master_lag: 7.79 =========