builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0097 starttime: 1447863023.49 results: success (0) buildid: 20151118062325 builduid: 5d0b600731194e44af48852715ead046 revision: 44f58c7fc121e68854da500798ef84c0f432a32a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.489410) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.489832) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.490669) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.006276 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.574511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.574818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.624852) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.625175) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005448 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.685941) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.686236) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.686623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:23.686930) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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-18 08:10:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.41G=0s 2015-11-18 08:10:24 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326923 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.040415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.040738) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.019687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:24.092251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 08:10:24.092673) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 44f58c7fc121e68854da500798ef84c0f432a32a --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 44f58c7fc121e68854da500798ef84c0f432a32a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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-18 08:10:24,174 truncating revision to first 12 chars 2015-11-18 08:10:24,175 Setting DEBUG logging. 2015-11-18 08:10:24,175 attempt 1/10 2015-11-18 08:10:24,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/44f58c7fc121?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 08:10:24,975 unpacking tar archive at: fx-team-44f58c7fc121/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-18 08:10:25.160545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.160905) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.174639) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.175097) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 08:10:25.176047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-18 08:10:25.176395) ========= /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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:10:25 INFO - MultiFileLogger online at 20151118 08:10:25 in /builds/slave/test 08:10:25 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 08:10:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:25 INFO - {'append_to_log': False, 08:10:25 INFO - 'base_work_dir': '/builds/slave/test', 08:10:25 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:25 INFO - 'branch': 'Fx-Team', 08:10:25 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:25 INFO - 'config_files': ('talos/mac_config.py',), 08:10:25 INFO - 'default_actions': ('clobber', 08:10:25 INFO - 'read-buildbot-config', 08:10:25 INFO - 'download-and-extract', 08:10:25 INFO - 'populate-webroot', 08:10:25 INFO - 'create-virtualenv', 08:10:25 INFO - 'install', 08:10:25 INFO - 'run-tests'), 08:10:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:25 INFO - 'download_minidump_stackwalk': True, 08:10:25 INFO - 'download_symbols': 'ondemand', 08:10:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:25 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:25 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:25 INFO - 'installer_path': 'installer.exe', 08:10:25 INFO - 'log_level': 'info', 08:10:25 INFO - 'log_name': 'talos', 08:10:25 INFO - 'log_to_console': True, 08:10:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:10:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:10:25 INFO - 'opt_config_files': (), 08:10:25 INFO - 'pip_index': False, 08:10:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:10:25 INFO - 'cmd': ('bash', 08:10:25 INFO - '-c', 08:10:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:10:25 INFO - 'enabled': True, 08:10:25 INFO - 'halt_on_failure': False, 08:10:25 INFO - 'name': 'check_screen_resolution'},), 08:10:25 INFO - 'run_cmd_checks_enabled': True, 08:10:25 INFO - 'sps_profile': False, 08:10:25 INFO - 'sps_profile_interval': 0, 08:10:25 INFO - 'suite': 'dromaeojs-e10s', 08:10:25 INFO - 'system_bits': '64', 08:10:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:25 INFO - 'title': 't-yosemite-r5-0097', 08:10:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:25 INFO - 'use_talos_json': True, 08:10:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:25 INFO - 'work_dir': 'build'} 08:10:25 INFO - ##### 08:10:25 INFO - ##### Running clobber step. 08:10:25 INFO - ##### 08:10:25 INFO - Running pre-action listener: _resource_record_pre_action 08:10:25 INFO - Running main action method: clobber 08:10:25 INFO - rmtree: /builds/slave/test/build 08:10:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:27 INFO - Running post-action listener: _resource_record_post_action 08:10:27 INFO - ##### 08:10:27 INFO - ##### Running read-buildbot-config step. 08:10:27 INFO - ##### 08:10:27 INFO - Running pre-action listener: _resource_record_pre_action 08:10:27 INFO - Running main action method: read_buildbot_config 08:10:27 INFO - Using buildbot properties: 08:10:27 INFO - { 08:10:27 INFO - "properties": { 08:10:27 INFO - "buildnumber": 69, 08:10:27 INFO - "product": "firefox", 08:10:27 INFO - "script_repo_revision": "production", 08:10:27 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 08:10:27 INFO - "repository": "", 08:10:27 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 08:10:27 INFO - "buildid": "20151118062325", 08:10:27 INFO - "slavename": "t-yosemite-r5-0097", 08:10:27 INFO - "pgo_build": "False", 08:10:27 INFO - "basedir": "/builds/slave/test", 08:10:27 INFO - "project": "", 08:10:27 INFO - "platform": "yosemite", 08:10:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:10:27 INFO - "slavebuilddir": "test", 08:10:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:10:27 INFO - "branch": "fx-team", 08:10:27 INFO - "repo_path": "integration/fx-team", 08:10:27 INFO - "stage_platform": "macosx64", 08:10:27 INFO - "builduid": "5d0b600731194e44af48852715ead046", 08:10:27 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:27 INFO - }, 08:10:27 INFO - "sourcestamp": { 08:10:27 INFO - "repository": "", 08:10:27 INFO - "hasPatch": false, 08:10:27 INFO - "project": "", 08:10:27 INFO - "branch": "fx-team-macosx64-talos", 08:10:27 INFO - "changes": [ 08:10:27 INFO - { 08:10:27 INFO - "category": null, 08:10:27 INFO - "files": [ 08:10:27 INFO - { 08:10:27 INFO - "url": null, 08:10:27 INFO - "name": "https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:10:27 INFO - } 08:10:27 INFO - ], 08:10:27 INFO - "repository": "", 08:10:27 INFO - "rev": "44f58c7fc121e68854da500798ef84c0f432a32a", 08:10:27 INFO - "who": "cbook@mozilla.com", 08:10:27 INFO - "when": 1447862968, 08:10:27 INFO - "number": 6677436, 08:10:27 INFO - "comments": "Merge mozilla-central to fx-team", 08:10:27 INFO - "project": "", 08:10:27 INFO - "at": "Wed 18 Nov 2015 08:09:28", 08:10:27 INFO - "branch": "fx-team-macosx64-talos", 08:10:27 INFO - "revlink": "", 08:10:27 INFO - "properties": [ 08:10:27 INFO - [ 08:10:27 INFO - "buildid", 08:10:27 INFO - "20151118062325", 08:10:27 INFO - "Change" 08:10:27 INFO - ], 08:10:27 INFO - [ 08:10:27 INFO - "builduid", 08:10:27 INFO - "5d0b600731194e44af48852715ead046", 08:10:27 INFO - "Change" 08:10:27 INFO - ], 08:10:27 INFO - [ 08:10:27 INFO - "pgo_build", 08:10:27 INFO - "False", 08:10:27 INFO - "Change" 08:10:27 INFO - ] 08:10:27 INFO - ], 08:10:27 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:27 INFO - } 08:10:27 INFO - ], 08:10:27 INFO - "revision": "44f58c7fc121e68854da500798ef84c0f432a32a" 08:10:27 INFO - } 08:10:27 INFO - } 08:10:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:10:27 INFO - Running post-action listener: _resource_record_post_action 08:10:27 INFO - ##### 08:10:27 INFO - ##### Running download-and-extract step. 08:10:27 INFO - ##### 08:10:27 INFO - Running pre-action listener: _resource_record_pre_action 08:10:27 INFO - Running main action method: download_and_extract 08:10:27 INFO - mkdir: /builds/slave/test/build/tests 08:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:27 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json 08:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json 08:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:10:30 INFO - Downloaded 1149 bytes. 08:10:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:10:30 INFO - Using the following test package requirements: 08:10:30 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:10:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'jsshell-mac.zip'], 08:10:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:10:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:10:30 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:10:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:10:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:10:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:10:30 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:10:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:30 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:32 INFO - Downloaded 17463580 bytes. 08:10:32 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 08:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:10:37 INFO - Return code: 0 08:10:37 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 08:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:37 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:38 INFO - Downloaded 17463580 bytes. 08:10:38 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 08:10:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:10:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:10:43 INFO - Return code: 0 08:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:43 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:45 INFO - Downloaded 11130997 bytes. 08:10:45 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 08:10:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:10:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:10:45 INFO - Return code: 0 08:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:45 INFO - https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:10:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:10:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:10:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:10:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RBAZ_rkYSWmHDaun07unzA/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 08:10:49 INFO - Downloaded 108846386 bytes. 08:10:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:10:49 INFO - mkdir: /builds/slave/test/properties 08:10:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:49 INFO - Contents: 08:10:49 INFO - build_url:https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:10:49 INFO - Running post-action listener: _resource_record_post_action 08:10:49 INFO - Running post-action listener: set_extra_try_arguments 08:10:49 INFO - ##### 08:10:49 INFO - ##### Running populate-webroot step. 08:10:49 INFO - ##### 08:10:49 INFO - Running pre-action listener: _resource_record_pre_action 08:10:49 INFO - Running main action method: populate_webroot 08:10:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:10:49 INFO - '../fennec_ids.txt'], 08:10:49 INFO - 'tests': ['tcheck2']}, 08:10:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:49 INFO - '--tppagecycles', 08:10:49 INFO - '7'], 08:10:49 INFO - 'tests': ['tsvgm']}}, 08:10:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:10:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:10:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['damp', 'tps']}, 08:10:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:49 INFO - 'other': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'other_l64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'other_nol64': {'tests': ['a11yr', 08:10:49 INFO - 'ts_paint', 08:10:49 INFO - 'tpaint', 08:10:49 INFO - 'sessionrestore', 08:10:49 INFO - 'sessionrestore_no_auto_restore']}, 08:10:49 INFO - 'svgr': {'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart']}, 08:10:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['tsvgx', 08:10:49 INFO - 'tsvgr_opacity', 08:10:49 INFO - 'tart', 08:10:49 INFO - 'tscrollx', 08:10:49 INFO - 'cart']}, 08:10:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'tests': ['tp5o']}, 08:10:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--e10s'], 08:10:49 INFO - 'tests': ['tp5o']}, 08:10:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}, 08:10:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:49 INFO - 'talos_options': ['--e10s', 08:10:49 INFO - '--xperf_path', 08:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:49 INFO - 'tests': ['tp5n']}}, 08:10:49 INFO - 'talos.zip': {'path': '', 08:10:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:49 INFO - Running post-action listener: _resource_record_post_action 08:10:49 INFO - ##### 08:10:49 INFO - ##### Running create-virtualenv step. 08:10:49 INFO - ##### 08:10:49 INFO - Running pre-action listener: _resource_record_pre_action 08:10:49 INFO - Running main action method: create_virtualenv 08:10:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:49 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 08:10:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:49 INFO - Using real prefix '/tools/python27' 08:10:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:54 INFO - Installing pip.................done. 08:10:54 INFO - Return code: 0 08:10:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:54 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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:10:54 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 08:10:54 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 08:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:54 INFO - 'HOME': '/Users/cltbld', 08:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:54 INFO - 'LOGNAME': 'cltbld', 08:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:54 INFO - 'MOZ_NO_REMOTE': '1', 08:10:54 INFO - 'NO_EM_RESTART': '1', 08:10:54 INFO - 'PAGER': '/bin/cat', 08:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:54 INFO - 'PWD': '/builds/slave/test', 08:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:54 INFO - 'SHELL': '/bin/bash', 08:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:10:54 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:54 INFO - 'USER': 'cltbld', 08:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:54 INFO - 'XPC_FLAGS': '0x0', 08:10:54 INFO - 'XPC_SERVICE_NAME': '0', 08:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:54 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 08:10:54 INFO - Cleaning up... 08:10:54 INFO - Return code: 0 08:10:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:54 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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:10:54 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 08:10:54 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 08:10:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:10:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:54 INFO - 'HOME': '/Users/cltbld', 08:10:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:54 INFO - 'LOGNAME': 'cltbld', 08:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:54 INFO - 'MOZ_NO_REMOTE': '1', 08:10:54 INFO - 'NO_EM_RESTART': '1', 08:10:54 INFO - 'PAGER': '/bin/cat', 08:10:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:54 INFO - 'PWD': '/builds/slave/test', 08:10:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:54 INFO - 'SHELL': '/bin/bash', 08:10:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:10:54 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:10:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:54 INFO - 'USER': 'cltbld', 08:10:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:54 INFO - 'XPC_FLAGS': '0x0', 08:10:54 INFO - 'XPC_SERVICE_NAME': '0', 08:10:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:55 INFO - Downloading/unpacking psutil>=0.7.1 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:10:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:57 INFO - Installing collected packages: psutil 08:10:57 INFO - Running setup.py install for psutil 08:10:57 INFO - building 'psutil._psutil_osx' extension 08:10:57 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 08:10:58 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 08:10:58 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 08:10:58 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 08:10:58 INFO - building 'psutil._psutil_posix' extension 08:10:58 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 08:10:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:10:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:10:58 INFO - ^ 08:10:58 INFO - 1 warning generated. 08:10:58 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 08:10:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:58 INFO - Successfully installed psutil 08:10:58 INFO - Cleaning up... 08:10:58 INFO - Return code: 0 08:10:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:10:58 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 08:10:58 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 08:10:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:10:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:58 INFO - 'HOME': '/Users/cltbld', 08:10:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:58 INFO - 'LOGNAME': 'cltbld', 08:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:58 INFO - 'MOZ_NO_REMOTE': '1', 08:10:58 INFO - 'NO_EM_RESTART': '1', 08:10:58 INFO - 'PAGER': '/bin/cat', 08:10:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:58 INFO - 'PWD': '/builds/slave/test', 08:10:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:58 INFO - 'SHELL': '/bin/bash', 08:10:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:10:58 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:10:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:58 INFO - 'USER': 'cltbld', 08:10:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:58 INFO - 'XPC_FLAGS': '0x0', 08:10:58 INFO - 'XPC_SERVICE_NAME': '0', 08:10:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:10:59 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 08:11:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:11:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:11:01 INFO - Installing collected packages: mozsystemmonitor 08:11:01 INFO - Running setup.py install for mozsystemmonitor 08:11:01 INFO - Successfully installed mozsystemmonitor 08:11:01 INFO - Cleaning up... 08:11:01 INFO - Return code: 0 08:11:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:01 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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:11:01 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 08:11:01 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 08:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:01 INFO - 'HOME': '/Users/cltbld', 08:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:01 INFO - 'LOGNAME': 'cltbld', 08:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:01 INFO - 'MOZ_NO_REMOTE': '1', 08:11:01 INFO - 'NO_EM_RESTART': '1', 08:11:01 INFO - 'PAGER': '/bin/cat', 08:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:01 INFO - 'PWD': '/builds/slave/test', 08:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:01 INFO - 'SHELL': '/bin/bash', 08:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:11:01 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:01 INFO - 'USER': 'cltbld', 08:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:01 INFO - 'XPC_FLAGS': '0x0', 08:11:01 INFO - 'XPC_SERVICE_NAME': '0', 08:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:02 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 08:11:02 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 08:11:02 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 08:11:02 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 08:11:02 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 08:11:02 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 08:11:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:05 INFO - Downloading docopt-0.6.1.tar.gz 08:11:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:11:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:05 INFO - Running setup.py install for blobuploader 08:11:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:05 INFO - Running setup.py install for requests 08:11:06 INFO - Running setup.py install for docopt 08:11:06 INFO - Successfully installed blobuploader requests docopt 08:11:06 INFO - Cleaning up... 08:11:06 INFO - Return code: 0 08:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:06 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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:11:06 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 08:11:06 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 08:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:06 INFO - 'HOME': '/Users/cltbld', 08:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:06 INFO - 'LOGNAME': 'cltbld', 08:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:06 INFO - 'MOZ_NO_REMOTE': '1', 08:11:06 INFO - 'NO_EM_RESTART': '1', 08:11:06 INFO - 'PAGER': '/bin/cat', 08:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:06 INFO - 'PWD': '/builds/slave/test', 08:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:06 INFO - 'SHELL': '/bin/bash', 08:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:11:06 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:06 INFO - 'USER': 'cltbld', 08:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:06 INFO - 'XPC_FLAGS': '0x0', 08:11:06 INFO - 'XPC_SERVICE_NAME': '0', 08:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-BR9v59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-h18hbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-x9p4rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-z2X6tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-bkpazI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-XuPGVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-qhghoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:07 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-BgquHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-N793te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-GRnt2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-aeuemp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-HqXp_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-BOmQ_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-_xdxnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-evKjkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:08 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-kzjTgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:09 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-PczGVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:09 INFO - Running setup.py install for manifestparser 08:11:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:09 INFO - Running setup.py install for mozcrash 08:11:09 INFO - Running setup.py install for mozdebug 08:11:09 INFO - Running setup.py install for mozdevice 08:11:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:09 INFO - Running setup.py install for mozfile 08:11:10 INFO - Running setup.py install for mozhttpd 08:11:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Running setup.py install for mozinfo 08:11:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Running setup.py install for mozInstall 08:11:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Running setup.py install for mozleak 08:11:10 INFO - Running setup.py install for mozlog 08:11:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:10 INFO - Running setup.py install for moznetwork 08:11:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:11 INFO - Running setup.py install for mozprocess 08:11:11 INFO - Running setup.py install for mozprofile 08:11:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:11 INFO - Running setup.py install for mozrunner 08:11:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:11 INFO - Running setup.py install for mozscreenshot 08:11:11 INFO - Running setup.py install for moztest 08:11:12 INFO - Running setup.py install for mozversion 08:11:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:12 INFO - Cleaning up... 08:11:12 INFO - Return code: 0 08:11:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:11:12 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 08:11:12 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 08:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:12 INFO - 'HOME': '/Users/cltbld', 08:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:12 INFO - 'LOGNAME': 'cltbld', 08:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:12 INFO - 'MOZ_NO_REMOTE': '1', 08:11:12 INFO - 'NO_EM_RESTART': '1', 08:11:12 INFO - 'PAGER': '/bin/cat', 08:11:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:12 INFO - 'PWD': '/builds/slave/test', 08:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:12 INFO - 'SHELL': '/bin/bash', 08:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:11:12 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:12 INFO - 'USER': 'cltbld', 08:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:12 INFO - 'XPC_FLAGS': '0x0', 08:11:12 INFO - 'XPC_SERVICE_NAME': '0', 08:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:12 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-wmXkj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:12 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)) 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:12 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-bbbpO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:12 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)) 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:12 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-c8ULuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:12 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)) 08:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:12 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-h4Ps0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-LG0TaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-LjCV1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-EI9WzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-LaoZgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-MQS0lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-DRztu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-HF1rh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:13 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)) 08:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:13 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-mm_OYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:14 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)) 08:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:14 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-2uDf9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:14 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)) 08:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:14 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-0g5GR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:14 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)) 08:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:14 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-rzfRML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:14 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)) 08:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:14 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-zydqYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:14 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)) 08:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:14 INFO - Running setup.py (path:/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/pip-RZXLXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:14 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)) 08:11:14 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)) 08:11:14 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)) 08:11:14 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)) 08:11:14 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)) 08:11:14 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)) 08:11:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:14 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 08:11:17 INFO - Downloading blessings-1.5.1.tar.gz 08:11:17 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 08:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:17 INFO - Installing collected packages: blessings 08:11:17 INFO - Running setup.py install for blessings 08:11:17 INFO - Successfully installed blessings 08:11:17 INFO - Cleaning up... 08:11:17 INFO - Return code: 0 08:11:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:17 INFO - Reading from file tmpfile_stdout 08:11:17 INFO - Current package versions: 08:11:17 INFO - blessings == 1.5.1 08:11:17 INFO - blobuploader == 1.2.4 08:11:17 INFO - docopt == 0.6.1 08:11:17 INFO - manifestparser == 1.1 08:11:17 INFO - mozInstall == 1.12 08:11:17 INFO - mozcrash == 0.16 08:11:17 INFO - mozdebug == 0.1 08:11:17 INFO - mozdevice == 0.47 08:11:17 INFO - mozfile == 1.2 08:11:17 INFO - mozhttpd == 0.7 08:11:17 INFO - mozinfo == 0.9 08:11:17 INFO - mozleak == 0.1 08:11:17 INFO - mozlog == 3.0 08:11:17 INFO - moznetwork == 0.27 08:11:17 INFO - mozprocess == 0.22 08:11:17 INFO - mozprofile == 0.27 08:11:17 INFO - mozrunner == 6.11 08:11:17 INFO - mozscreenshot == 0.1 08:11:17 INFO - mozsystemmonitor == 0.0 08:11:17 INFO - moztest == 0.7 08:11:17 INFO - mozversion == 1.4 08:11:17 INFO - psutil == 3.1.1 08:11:17 INFO - requests == 1.2.3 08:11:17 INFO - wsgiref == 0.1.2 08:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:17 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')]} 08:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 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')]} 08:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:17 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 0x10a931490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a90e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85c2e4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, '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.fFM5kOrDLP/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.txsAmO8emq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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 08:11:17 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 08:11:17 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 08:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:17 INFO - 'HOME': '/Users/cltbld', 08:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:17 INFO - 'LOGNAME': 'cltbld', 08:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:17 INFO - 'MOZ_NO_REMOTE': '1', 08:11:17 INFO - 'NO_EM_RESTART': '1', 08:11:17 INFO - 'PAGER': '/bin/cat', 08:11:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:17 INFO - 'PWD': '/builds/slave/test', 08:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:17 INFO - 'SHELL': '/bin/bash', 08:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:11:17 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:17 INFO - 'USER': 'cltbld', 08:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:17 INFO - 'XPC_FLAGS': '0x0', 08:11:17 INFO - 'XPC_SERVICE_NAME': '0', 08:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 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)) 08:11:18 INFO - Cleaning up... 08:11:18 INFO - Return code: 0 08:11:18 INFO - Running post-action listener: _resource_record_post_action 08:11:18 INFO - Running post-action listener: _start_resource_monitoring 08:11:18 INFO - Starting resource monitoring. 08:11:18 INFO - ##### 08:11:18 INFO - ##### Running install step. 08:11:18 INFO - ##### 08:11:18 INFO - Running pre-action listener: _resource_record_pre_action 08:11:18 INFO - Running main action method: install 08:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:18 INFO - Reading from file tmpfile_stdout 08:11:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:18 INFO - Reading from file tmpfile_stdout 08:11:18 INFO - Output received: 08:11:18 INFO - Usage: mozinstall [options] installer 08:11:18 INFO - Options: 08:11:18 INFO - -h, --help show this help message and exit 08:11:18 INFO - -d DEST, --destination=DEST 08:11:18 INFO - Directory to install application into. [default: 08:11:18 INFO - "/builds/slave/test"] 08:11:18 INFO - --app=APP Application being installed. [default: firefox] 08:11:18 INFO - mkdir: /builds/slave/test/build/application 08:11:18 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'] 08:11:18 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 08:11:57 INFO - Reading from file tmpfile_stdout 08:11:57 INFO - Output received: 08:11:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:11:57 INFO - Running post-action listener: _resource_record_post_action 08:11:57 INFO - ##### 08:11:57 INFO - ##### Running run-tests step. 08:11:57 INFO - ##### 08:11:57 INFO - Running pre-action listener: _resource_record_pre_action 08:11:57 INFO - Running main action method: run_tests 08:11:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:11:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:11:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:11:57 INFO - 2015-11-18 08:11:57.574 screenresolution[1914:12490] starting screenresolution argv=screenresolution get 08:11:57 INFO - 2015-11-18 08:11:57.577 screenresolution[1914:12490] Display 0: 1600x1200x32@60 08:11:57 INFO - 2015-11-18 08:11:57.584 screenresolution[1915:12492] starting screenresolution argv=screenresolution list 08:11:57 INFO - Available Modes on Display 0 08:11:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:11:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:11:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:11:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:11:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:11:57 INFO - Intel HD Graphics 3000: 08:11:57 INFO - Chipset Model: Intel HD Graphics 3000 08:11:57 INFO - Type: GPU 08:11:57 INFO - Bus: Built-In 08:11:57 INFO - VRAM (Total): 512 MB 08:11:57 INFO - VRAM (Dynamic, Max): 10 08:11:57 INFO - Vendor: Intel (0x8086) 08:11:57 INFO - Device ID: 0x0116 08:11:57 INFO - Revision ID: 0x0009 08:11:57 INFO - Displays: 08:11:57 INFO - Display: 08:11:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:11:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:11:57 INFO - Display Serial Number: 1600x1200 60 08:11:57 INFO - Main Display: Yes 08:11:57 INFO - Mirror: Off 08:11:57 INFO - Online: Yes 08:11:57 INFO - Rotation: Supported 08:11:57 INFO - Return code: 0 08:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:57 INFO - Python 2.7.3 08:11:57 INFO - Return code: 0 08:11:57 INFO - grabbing minidump binary from tooltool 08:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:57 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 0x10a8559f0>, '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 0x10a5b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a8488c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:57 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 08:11:57 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 08:11:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:57 INFO - Return code: 0 08:11:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:11:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:11:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:57 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/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] in /builds/slave/test/build 08:11:57 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/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0097 --webServer localhost 08:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fFM5kOrDLP/Render', 08:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:11:57 INFO - 'HOME': '/Users/cltbld', 08:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:11:57 INFO - 'LOGNAME': 'cltbld', 08:11:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:57 INFO - 'MOZ_NO_REMOTE': '1', 08:11:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:57 INFO - 'NO_EM_RESTART': '1', 08:11:57 INFO - 'PAGER': '/bin/cat', 08:11:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:57 INFO - 'PWD': '/builds/slave/test', 08:11:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:11:57 INFO - 'SHELL': '/bin/bash', 08:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.txsAmO8emq/Listeners', 08:11:57 INFO - 'TMPDIR': '/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/', 08:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:11:57 INFO - 'USER': 'cltbld', 08:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:57 INFO - 'XPC_FLAGS': '0x0', 08:11:57 INFO - 'XPC_SERVICE_NAME': '0', 08:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:11:57 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/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0097', '--webServer', 'localhost'] with output_timeout 3600 08:11:58 INFO - mozversion INFO | application_buildid: 20151118062325 08:11:58 INFO - mozversion INFO | application_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 08:11:58 INFO - mozversion INFO | application_display_name: Nightly 08:11:58 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:58 INFO - mozversion INFO | application_name: Firefox 08:11:58 INFO - mozversion INFO | application_remotingname: firefox 08:11:58 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:11:58 INFO - mozversion INFO | application_vendor: Mozilla 08:11:58 INFO - mozversion INFO | application_version: 45.0a1 08:11:58 INFO - mozversion INFO | platform_buildid: 20151118062325 08:11:58 INFO - mozversion INFO | platform_changeset: 44f58c7fc121e68854da500798ef84c0f432a32a 08:11:58 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:58 INFO - mozversion INFO | platform_version: 45.0a1 08:11:58 INFO - 2015-11-18 08:11:58,209 DEBUG : using testdate: 1447863118 08:11:58 INFO - 2015-11-18 08:11:58,209 DEBUG : actual date: 1447863118 08:11:58 INFO - 2015-11-18 08:11:58,221 INFO : starting webserver on 'localhost:50080' 08:11:58 INFO - 2015-11-18 08:11:58,223 INFO : Starting test suite t-yosemite-r5-0097.e 08:11:58 INFO - 2015-11-18 08:11:58,223 INFO : Starting test dromaeo_css 08:11:58 INFO - 2015-11-18 08:11:58,223 DEBUG : operating with platform_type : mac_ 08:11:58 INFO - 2015-11-18 08:11:58,224 INFO : Initialising browser for dromaeo_css test... 08:11:58 INFO - 2015-11-18 08:11:58,259 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpUEW6Qn/profile http://localhost:50080/getInfo.html 08:12:01 INFO - 2015-11-18 08:12:01,959 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:12:01 INFO - 2015-11-18 08:12:01,959 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:12:01 INFO - 2015-11-18 08:12:01,960 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:12:01 INFO - 2015-11-18 08:12:01,960 DEBUG : BROWSER_OUTPUT: __metrics 08:12:02 INFO - 2015-11-18 08:12:02,648 INFO : Browser initialized. 08:12:02 INFO - 2015-11-18 08:12:02,649 INFO : Running cycle 1/1 for dromaeo_css test... 08:12:02 INFO - 2015-11-18 08:12:02,649 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmpUEW6Qn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:12:14 INFO - 2015-11-18 08:12:14,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 240881664 08:12:14 INFO - 2015-11-18 08:12:14,808 DEBUG : BROWSER_OUTPUT: 08:13:04 INFO - 2015-11-18 08:13:04,641 DEBUG : BROWSER_OUTPUT: 1447863184638 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] 08:15:13 INFO - 2015-11-18 08:15:13,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50080/tests/dromaeo/cssquery-ext.html) 08:15:15 INFO - 2015-11-18 08:15:15,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 266510336 08:15:15 INFO - 2015-11-18 08:15:15,019 DEBUG : BROWSER_OUTPUT: 08:18:17 INFO - 2015-11-18 08:18:17,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-ext.html (next: http://localhost:50080/tests/dromaeo/cssquery-jquery.html) 08:18:17 INFO - 2015-11-18 08:18:17,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 271560704 08:18:17 INFO - 2015-11-18 08:18:17,722 DEBUG : BROWSER_OUTPUT: 08:21:19 INFO - 2015-11-18 08:21:19,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50080/tests/dromaeo/cssquery-mootools.html) 08:21:20 INFO - 2015-11-18 08:21:20,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 275488768 08:21:20 INFO - 2015-11-18 08:21:20,136 DEBUG : BROWSER_OUTPUT: 08:24:21 INFO - 2015-11-18 08:24:21,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50080/tests/dromaeo/cssquery-prototype.html) 08:24:22 INFO - 2015-11-18 08:24:22,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 278806528 08:24:22 INFO - 2015-11-18 08:24:22,519 DEBUG : BROWSER_OUTPUT: 08:27:25 INFO - 2015-11-18 08:27:25,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50080/tests/dromaeo/cssquery-yui.html) 08:27:25 INFO - 2015-11-18 08:27:25,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 284307456 08:27:25 INFO - 2015-11-18 08:27:25,690 DEBUG : BROWSER_OUTPUT: 08:30:27 INFO - 2015-11-18 08:30:27,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/dromaeo/cssquery-yui.html (next: http://localhost:50080/tests/dromaeo/cssquery-dojo.html) 08:30:28 INFO - 2015-11-18 08:30:28,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 289914880 08:30:28 INFO - 2015-11-18 08:30:28,098 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,098 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:30:28 INFO - 2015-11-18 08:30:28,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:30:28 INFO - 2015-11-18 08:30:28,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:30:28 INFO - 2015-11-18 08:30:28,099 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:30:28 INFO - 2015-11-18 08:30:28,099 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2899.275181204699;2909.3017675757824;2977.2110390746457;3039.7568194544438;3105.1616063662814;4692.859214223575;4721.834735784244;4738.905221895564;4835.395575553056;4854.902901941968;4521.502634710179;4596.287575425815;4685.2035154023815;4715.174844402233;4733.313669517918;4362.650987920959;4379.474463064421;4422.11557688462;4467.106578684276;4536.682432229745;185.59577240769605;4349.826006959734;4422.646188304944;4539.046800171968;4567.177907976563;4275.166342563201;4407.07451435199;4431.512533621299;4503.572160644733;4532.864014079583;4460.286354183348;4470.307102399133;4470.75410852403;4493.101379724036;4500.504944456107;4194.266003449415;4403.251447253974;4457.531959144308;4505.076459325863;4558.817647294104;4449.777511124463;4567.771611419449;4689.906201875943;4716.221823399135;4757.0723708876785;5044.9747751261375;5052.444231134572;5093.261477085802;5097.5667068299235;5232.8691782705355;4956.553910148104;4961.82633607822;5016.272640467148;5124.769385377667;5172.767225474825;4807.591354734852;4825.855224343275;4847.054824309261;4856.004519073582;4910.8772280693265;5174.223866419992;5233.764480598382;5275.155975043975;5277.102892508283;5278.81524146653;4864.027194561102;4885.071836351153;4941.604671626261;4972.925406118911;5004.47453017428;4838.080764654705;4950.77721502526;4965.47862474435;4997.5002499749735;5003.524665156804;4856.077345304451;4866.0511200316305;4887.266909963534;4901.58336541398;4909.484504127086;4883.267509873476;4910.877228069256;4936.111499929975;4961.627877909171;5057.924131138036;3899.5905429930017;3901.063744701308;3922.254771593445;3970.4242884781543;3972.980135099306;3543.362194804908;3607.1703508192736;3609.0616439725336;3639.5450568678916;3663.8900832975055;4643.303504474288;4679.625629949596;4740.597049250783;4780.641451891122;4822.95177048225;5146.794128234828;5167.612429067835;5189.922151167735;5190.2214667800135;5206.140986737146;4621.607163391082;4791.95208047922;4854.150523658345;4858.198397264482;4862.246351815475;4366.14860102277;4421.093675796454;4437.489688685842;4473.060657261946;4476.060027394218;5209.947900520946;5228.712420816892;5247.737613119329;5256.132738098171;5261.973690131601;4861.392325959255;4979.278004689372;5042.647014708935;5179.533841954242;5227.137522308929;5218.452062533379;5221.712805795566;5270.130428479258;5272;5285.471452854684;5059.772310245974;5072.213806859942;5084.3898732152375;5123.154679477844;5138.486151384832;4822.638302127425;4959.057779021974;4980.750962451791;5081.745912704276;5145.3568303962;4925.950740492549;4959.380077490314;4985.501449854985;5012.899742005066;5031.84904452867;4953.975230123826;4967.652264341461;4975.203967365204;4982.252662100569;5016.297718319365;4623.352730617649;4712.976435117803;4860.392450943632;4896;4939.43196532389;4902.117618828645;4926.48271931442;5012.3233363495465;5012.899742005213;5112.74436278192;4662.184117779443;4928.975355123202;4934.309196712535;4968.22992436173;4973.055119527278 08:30:28 INFO - 2015-11-18 08:30:28,100 DEBUG : BROWSER_OUTPUT: |1;ext.html;519.0138736400838;520.2118790033101;532.2442132172315;536.4796147736695;551.2200236665121;36215.45676814846;36678;36729.26541469173;36733.81633091837;36989.260214795686;39352.21295574094;39392.60607393925;39792;40069.599304007024;40129.39805902914;8399.664013439471;8579.914200857975;8622.180892815173;8746.344024198179;8749.781255468632;8483.872741908875;8518.27594654455;8525.360597955147;8535.274501667334;8571.871421928645;8508.149185081504;8516.361272904525;8517.36119791018;8528.829423411527;8645.135486451367;8504.107068757785;8586.356023298278;8631.43895646784;8642;8657.82684346316;8394.118617545131;8538.82922341556;8560.101189375087;8568.228859402683;8613.353998450142;37060.81469592635;37122;37136.25727485462;37149.628503714885;37333.62666373356;2431.234161239204;2708.3635345693747;2851.8574071296352;2908.3165456117795;2956.9260768480744;25246.24261272165;25413.872930635414;25807.708835080542;25893.611595826078;25910.74089259102;2104.2845432552854;2130.286354071388;2147.9248226312;2164.491344534033;2310.595645761985;218828;220815.89592052097;221422;221788;222017;47361.52638473571;48064.27903581449;53910.46089539133;54284.45715542873;55074.724626377414;50951;50998.49001510011;51040.234396484084;51227.23159152616;51486.22770658443;15647.139407332706;15675.529734107995;15691.058536487619;15743.291551880193;15877.682446351238;11686.590969316203;11961.46173422198;11984.101192410604;11994.76010479803;12029.699257518458;18009.54976125581;18338.17478213457;18345.266189352278;18409.631807363778;18538.814611853708;7970.800729981681;8195.467294625949;8233.259006689426;8259.091499935003;8282.80505665999;820.0364571628313;875.9956200218958;883.8143989762222;1016.6289304403839;1046.053321743823;25866.51375003139;26073.348166295993;26101.477970440486;26296.605550916753;26529.33676658099;901.9278457723366;965.4014511003082;996.1881066930573;1064.2709743825503;1065.1053115383115;12716.936415318049;12866.614001579968;12882.355882205853;13003.479860805652;13033.218006919615;220263;220869;221664;223032;225280;45706.771466142454;45894.770526147826;45959.54040459553;46287.76856115765;46496;1224.5714000099895;1293.0625296660035;1298.5195477673133;1298.6039258026392;1306.751717173734;24688;25000.624990625518;25107.87446062758;25131.24606261815;25355.74644253534;42562;43031.78484107685;43075.56924430841;43089;43151;261921;263855;264813;265274;267278;29202;29683.851580741957;29895.850520747255;29931.55102673418;30000.099997000125;35243.64756352506;35743.64256357507;36026.63973360233;36132.63867361293;36577.63422365742;30197.547036794906;32186;33069.503957440174;33593.83203083969;34328.48507272443;31730.365392691554;31936.52095218527;32088.358232834744;32206.516902246953;32665;33176.1705957353;33473;33624.831875841446;33647.495287570215;35719.64280357267;33903.66096339005;35465.46801798027;35507.82246088753;35649.643503564635;37019.25961480809;27834.721652783213;28228.294292642848;28518.714812852435;28543.28641783972;28634.85682571657 08:30:28 INFO - 2015-11-18 08:30:28,104 DEBUG : BROWSER_OUTPUT: |2;jquery.html;307.3790942296561;307.4749243750995;310.73587450666935;312.8623405701491;317.75374085084064;10911.345319280828;11199.832002519948;15630.92184539077;16012.919935400321;16560.503184904443;10479.318844275116;10597.364158150496;10760.892391076088;10827.83758243627;11018.283811552243;4057.9391309130388;4121.690873184523;4172.687048471362;4178.791060446965;4182.477190351206;4059.4113853491226;4139.875803725878;4162.687798415116;4189.518205406387;4208.852690155845;4103.97948010261;4143.337066069429;4145.191687620915;4147.896302592444;4322.805473753673;4261.5738426157295;4265.232258193524;4341.500727416356;4344;4351.521332653406;3647.7993710345922;3675.3568125578186;3681.208540163878;3753.1367785409234;3795.203007368428;12216.633500994983;12289.56986505477;12549.1215614907;12565.93717031409;12625.368731563385;1580.3678528588657;1629.3726915137638;1646;1674.815770265282;1831.706926891691;8607.741767746978;8752.606132724042;8986.37095403322;9120.908790912072;9126.77183070422;1415.9504417345447;1449.9202543860083;1468.5080498033064;1541.9614509637236;1550.2403822127076;51385.48614513844;53842;54533;54652.18021729677;54812;5949.542362121308;5997.190379298739;6027;6057.939420605826;6093.99449090895;6776.220734615484;6828.726850926007;6854.588724676535;6860.897086543706;6868.656567171622;4882.389701287339;4883.633727470454;5023.372078490189;5060.84817455477;5116.718580478035;5271.288376069181;5369.865753356197;5500.58745594074;5525.889482210414;5560.221568980346;2705.8511781851794;2724.087430710734;2725.7819374449996;2734.6718393792476;2739.178246526074;950.5978681444814;952.6094301336558;953.6948176583427;966.5795379010153;1018.8944994680854;340.3397409026481;347.147752268181;360.5799243880902;381.21469772269216;428.29759194920354;8932.374733768575;9122.270218382513;9237.307201959746;9548.522573871418;10406.536468712575;420.55421253471417;424.1114864359163;425.1263653192719;428.0924440186824;430.9482862056573;5139.357580302462;5334.839954801362;5797.2173756542325;5983.282006159288;6031.396860313934;511272;513994;538993;549677;553171;56788;59269.70365148147;61992.380076199566;66138;66248;453.72549607487656;461.4877485990548;462.7686156921539;466.60338712095125;467.7661169415292;9723.77771390625;10136.189104871444;10316.896831031894;10394.01256880595;10491.318064325795;31638.367232655677;32314.676853231165;32441;32585.511217332234;33133;42346;43025.56974430341;43542.12915741731;44400;45120.77439612781;5543.1408131738035;5604.719764011702;5699.344575373885;5765.308163020464;5794.101914203306;10600;10725;10768.838467422838;10850.837237441287;10887.129029677766;8935.910640893768;9078;9245.214156796748;9277.814443711222;9405.05949405054;8789.34079943994;8965.148310910454;9020.413673111227;9122.726318210463;9340.859887101564;9457.148856602938;9478.810423791349;9563.665271715456;9584.952075239578;9726.319157658896;5735.254416925773;5785.479306862402;5826.737796799239;5828.883422331614;5877.500412464989;7880.605969701377;8076.353891688534;9552.283578731483;9725.805483890425;9738.902610974083 08:30:28 INFO - 2015-11-18 08:30:28,105 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1240.652617267165;1270.5235536673747;1344.6100630817064;1505.096941834899;1587.9206039698013;5504.91742623861;5604.215409842615;5985.072313791364;6213.658248796314;6301.40136687014;6176.382361763822;6236.282827474842;6367.49060075194;6422.389872962073;6438.0986661867255;1948.8246057854826;1950.229659284589;1962.9607407851834;1971.0932970833362;1985.2852972929734;1919.9808001919941;1943.6112777444569;1967.0263219706264;1968.694852297889;1972.1815446589649;1929.3536665217168;1947.8344340731055;1951.2780271299569;1956.1001939108028;1977.2486455147025;1922.3079691311116;1928.7878333383317;1942.3298961858206;1955.5404479947201;1958.696402057669;1927.3158028899818;1927.9903600482048;1968.5964377302762;2008.6742749785217;2008.8895110768901;6327.620342779402;6467.126937863375;6469.708863101125;6473.83815404614;6541.28045914949;3942.2115576884453;4027.2952233359047;4032.193561287725;4045.170739998323;4048.554658987509;2149.140343862452;2197.835162362829;2405.0860672944345;2437.585610446228;2455.7789798918006;767.458941446279;775.25962705616;793.6983946100503;797.1749239537052;802.0896282719098;8165.061017982948;8213.932188815475;8264.8347033059;8288.461250018669;8293.792655183608;3571.8035508047305;3604.008897553141;3654.250878569887;3713.1088538751046;3713.832877520518;7231.45764067697;7234.493585449073;7321.597312147883;7330.193678695339;7337;4090.9386359204636;4112.876613701594;4116;4126.7523948563185;4133.545310015896;3719.925601487955;3736.065983504124;3767.566729826105;3769.981150094232;3785.5835858055593;3067.5245336972803;3101.7828751987595;3101.8604162812726;3136.6079240094987;3160.620725512953;989.737719504332;991.6628346362271;993.4238141877838;1001.9949900250598;1011.014261095426;1192.0642295797757;1202.8376169217045;1210.2133613151523;1215.2647648172906;1221.1207930290177;5914.467697907209;5943.613665111754;5960.940390596039;5986.910196347058;6029.969850150721;420.17645414986356;421.4079218697735;421.61211685249646;424.980875860587;425.03304981167474;4782.3543821584335;4831.637627177975;4834.081524510332;4847.103285892122;4884.877878053077;7093.751718689821;7104.467164962649;7224.385927196142;7375.18872923978;7431.2197219292275;7175.425965922714;7224.927750722531;7270.600116993616;7316.158641756266;7320.267973202744;5698.344690360579;5973.044312909914;6012.098185272244;6102.298235702862;6118.694065296718;5899.882002359843;5955.642661440327;6012.128241405059;6012.669303188367;6034.668093254913;6503.349665033459;6549.934500654933;6577.967110164419;6625.337466253529;6642.5018123641885;6617.470602351704;6812.693428795617;6816.522843401112;6833.214180369321;6870.828229294308;5830.708464576839;5832.766689332379;5904.0553511437965;5922.348541660328;5951.821445356646;6174.38256174379;6231.594946328474;6289;6301.338359472189;6304.338044505261;5545.195946587803;5800.622959507618;5805.129230615442;5807.912881306699;5925.140854575976;5720.399358067343;5732.3121225453215;5750.7987220447085;5876.853078673067;5879.382664820132;5836.678982655825;5875.94124058771;5888.558358123244;5934.347221805511;5951.7024148791525;5364.30264065669;5415.187721841755;5423.105187643994;5449.891002180014;5450.373207081077;5154.278401023935;5329.067413202752;5367.865803354791;5389.946100538945;5473.06957817164 08:30:28 INFO - 2015-11-18 08:30:28,108 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.7380410022779;290.21496851018;291.73743630732343;298.3332252415852;299.7871511227029;5926.674032928187;5929.2884853817495;5949.315828679703;5993.370696076914;6141.416565426277;5971;6009.26578406825;6051.334353221142;6054.364291749369;6113.32753397126;4360.8691739247715;4525.2533332000185;4566.999999999992;4575.633949284066;4577;4440.111977604476;4449.84425545106;4476.753778542179;4528.43394575678;4569.565891240343;4464.620507256887;4490.97754511227;4500.459944806627;4504;4509.053098849229;4455.398521199629;4481.395011673431;4501.504834468222;4505.504394516601;4510.774461276923;3799.772013679188;3824.770513769183;3831;3831.425286207091;3835.7314987950854;5609.270794796691;5750.539956803487;5791.276090488689;5797.855053623651;5798.10129429939;4967.081089998362;5012.473690262506;5015.269731942474;5018.548330650259;5027.723475208862;6202.410770976795;6229.719662615194;6229.968850155766;6235.781747638856;6254.405831446005;3892.902677433087;4058.147788964321;4101.5488296287385;4107.363358679379;4107.835686572534;6505.251896031969;6509.2839787623325;6588.176477940257;6601.834954126137;6604.537682362188;4131.29767939451;4154.771487568213;4160.1471698301775;4191.517975432804;4210.431591735138;4205.810738516774;4217.135487225111;4222.19778242133;4273.978630106892;4278.294081476583;4823.541763532458;4899.436564795023;4916.410030796327;4969.701817890938;5010.649254552146;6172.876542469216;6184.845378865564;6193.473554747897;6240;6277.905831412532;1476.0700758522278;1485.524632117712;1490.2697678137852;1500.7073620644087;1503.361071544589;937.2595649437005;939.5959737313021;948.3219498058921;963.2390411574918;963.3834346018554;5904.61619994699;5920.31916329619;5924.644521328734;5963.731632076567;5966.910496342558;6441.227052753699;6447.871042579122;6493.8701225976165;6655.434288085567;6667.799966001027;6026.487748541423;6032.939670603326;6048.6975651218145;6052.848678783065;6054.001089820218;3538.610752817188;3540.3804334241404;3540.6282340354405;3582.068662147808;3589.5513060867393;6616.27221005689;6708.094407255056;6761;6805.251422343538;6821.93178068213;6710.66446677674;6738.561993470506;6818.352256535622;6821.863562728718;6836.965815170893;6742;6754.493412994045;6764.5603035802515;6806.5235433520165;6814.76148334796;6319.146915166578;6532.934670653232;6575.572587781779;6581.506387021088;6597.439217666552;6348.71430785625;6371.617702937839;6388.488920886411;6457.4511166551365;6477.902831457626;6697.531172817856;6728.562643428358;6730.46156307504;6782.762603308861;6795.150606174228;4138.710290279651;4153.293940030262;4185.644220241192;4333.891652708581;4385.188740082967;6441.871162576816;6499.122618446449;6521.67391630426;6536.215654121535;6551.279359270381;6255.937440625536;6272.560920735505;6282.246130464374;6359.777407790705;6368.5860419072615;6055.3944605540855;6183.165272688309;6245.6252624842655;6258.311585725475;6285.5600107992;6113.14415981754;6128.111423843428;6133.570650054632;6156.846078847885;6160.353162917829;6248.094026366242;6270.623762574261;6287.654179020014;6292.307846137013;6343.302236754045;5704.885902281848;6016.4585187331595;6141.785037523665;6176.166217560572;6239.500839932885 08:30:28 INFO - 2015-11-18 08:30:28,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;620.0606081786098;637.0348921384101;680.2143524229517;691.5159388428102;708.4438715608247;12673.112882098245;12775.425105870236;13073.934630326836;13113.54102606409;13251.337433128354;12398;12428.93785531071;12440.25358478492;12477.937610311936;12508;783.0407750505642;805.0822062848329;820.8440396324694;839.6725277141919;849.2102344819316;793.8650429426982;800.0399520575304;806.9717559885405;807.9636416361278;808.975730728079;823.6375994562374;834.6911642692182;836.8995720513547;837.656560810065;839.9412041157121;809.5628360685223;820.5445977482494;821.7945513621595;823.6375994562374;824.3364091906013;594.8156071617769;601.1553766957431;602.0848310567912;602.57518449493;603.3483837455537;12532.686682832911;12670.746585068247;12726.872731272753;12761.234325940473;12904.54834080812;8546.40175187737;8584.570771461402;8627.352948528885;8918.598663060178;9176.44941303524;8272.462289951194;8351;8354.331653467709;8493.683479060755;8524.8721269181;2593.8314009589317;2624.042224588031;2626.0677459501794;2681.115231973444;2752.174347695703;41805.37291940593;42231.577684223375;44586.33120503162;45007.549924500665;45348;8278.710245141512;8360.189668180677;8417.200365965224;8431.325493960469;8883.511406872683;17585.7362139568;17692.646147076986;17693.380731674588;17724.645507089786;17824.91087544554;6670.599764014175;6698.66506674674;6707.463402927754;6794.116764820542;6996.6851491683;3581.28374325136;3587.0852932502567;3606.2246616977477;3632.909177270589;3641.7268704847243;2436.1229957215387;2489.7302375788477;2518.2948774343213;2549.5538280800783;2555.067400398841;382.1897577136433;383.68154431821523;384.7633705271294;386.5786292940708;387.76540193182717;442.40275627902076;527.8363707250764;532.238898375327;542.4331573505696;563.3155715805316;6964.421646525027;7201.243869393743;7265.818354541073;7283.890741638879;7414.406847452191;533.2454576773822;548.3036543589619;576.7692922830818;576.8125359258174;590.2680675961863;3456.9654303457146;3591.497190393347;3659.8536058557893;3685.3182161300247;3747.5315585551807;50515.49484505181;51264.74367628138;51359.22961155586;51708;51828.74085629548;47855;48514.75742621264;48534.845235059605;48629;48671.269930951064;43413.782931085145;43861.78069109698;44700.3294950576;44790.77604611956;45015.32477012847;7460.552366858006;7483.588402637907;7714.228577142465;7760.650770715219;7815.374770018499;32181.35637287288;32733.672663274014;33529.16177095592;33549.987000780035;33676.158096047795;42290.788546058306;43363.56636433595;43524.12951741011;43553.12893742044;43759.12481750284;6517.804465866032;6801.421879140328;6876.896846547406;7092.893606596009;7097.077379940574;10187.541560629938;10226.693199204035;10635.840462392916;10659.520321585393;10793.67618971432;9849.26130540198;9858.704238872846;10162.847557286499;10334;10381.740456488647;9487.430754154497;9519.666811661558;9769.413835169913;10087.949560252151;10336.793264134525;9344.252459803336;9772.755681108029;9798.461084640128;10128.34165779222;10640.308379955279;7872.606369681607;7971.481853679492;8255.669773209005;8269.875951860848;8554.743357699279;7392.297731715694;7447.840126363294;7652.740184376967;8211.302039326485;8480.363972702195 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,291 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864228095__endTimestamp 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,110 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:30:28 INFO - 2015-11-18 08:30:28,111 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:30:28 INFO - 2015-11-18 08:30:28,111 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,111 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4708.50 Median:4864.03 stddev:596.59 (12.3%) stddev-sans-first:581.29 08:30:28 INFO - 2015-11-18 08:30:28,112 DEBUG : BROWSER_OUTPUT: Values: 2899.3 2909.3 2977.2 3039.8 3105.2 4692.9 4721.8 4738.9 4835.4 4854.9 4521.5 4596.3 4685.2 4715.2 4733.3 4362.7 4379.5 4422.1 4467.1 4536.7 185.6 4349.8 4422.6 4539.0 4567.2 4275.2 4407.1 4431.5 4503.6 4532.9 4460.3 4470.3 4470.8 4493.1 4500.5 4194.3 4403.3 4457.5 4505.1 4558.8 4449.8 4567.8 4689.9 4716.2 4757.1 5045.0 5052.4 5093.3 5097.6 5232.9 4956.6 4961.8 5016.3 5124.8 5172.8 4807.6 4825.9 4847.1 4856.0 4910.9 5174.2 5233.8 5275.2 5277.1 5278.8 4864.0 4885.1 4941.6 4972.9 5004.5 4838.1 4950.8 4965.5 4997.5 5003.5 4856.1 4866.1 4887.3 4901.6 4909.5 4883.3 4910.9 4936.1 4961.6 5057.9 3899.6 3901.1 3922.3 3970.4 3973.0 3543.4 3607.2 3609.1 3639.5 3663.9 4643.3 4679.6 4740.6 4780.6 4823.0 5146.8 5167.6 5189.9 5190.2 5206.1 4621.6 4792.0 4854.2 4858.2 4862.2 4366.1 4421.1 4437.5 4473.1 4476.1 5209.9 5228.7 5247.7 5256.1 5262.0 4861.4 4979.3 5042.6 5179.5 5227.1 5218.5 5221.7 5270.1 5272.0 5285.5 5059.8 5072.2 5084.4 5123.2 5138.5 4822.6 4959.1 4980.8 5081.7 5145.4 4926.0 4959.4 4985.5 5012.9 5031.8 4954.0 4967.7 4975.2 4982.3 5016.3 4623.4 4713.0 4860.4 4896.0 4939.4 4902.1 4926.5 5012.3 5012.9 5112.7 4662.2 4929.0 4934.3 4968.2 4973.1 08:30:28 INFO - 2015-11-18 08:30:28,112 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,113 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39918.99 Median:33636.16 stddev:61469.35 (182.7%) stddev-sans-first:61570.59 08:30:28 INFO - 2015-11-18 08:30:28,114 DEBUG : BROWSER_OUTPUT: Values: 519.0 520.2 532.2 536.5 551.2 36215.5 36678.0 36729.3 36733.8 36989.3 39352.2 39392.6 39792.0 40069.6 40129.4 8399.7 8579.9 8622.2 8746.3 8749.8 8483.9 8518.3 8525.4 8535.3 8571.9 8508.1 8516.4 8517.4 8528.8 8645.1 8504.1 8586.4 8631.4 8642.0 8657.8 8394.1 8538.8 8560.1 8568.2 8613.4 37060.8 37122.0 37136.3 37149.6 37333.6 2431.2 2708.4 2851.9 2908.3 2956.9 25246.2 25413.9 25807.7 25893.6 25910.7 2104.3 2130.3 2147.9 2164.5 2310.6 218828.0 220815.9 221422.0 221788.0 222017.0 47361.5 48064.3 53910.5 54284.5 55074.7 50951.0 50998.5 51040.2 51227.2 51486.2 15647.1 15675.5 15691.1 15743.3 15877.7 11686.6 11961.5 11984.1 11994.8 12029.7 18009.5 18338.2 18345.3 18409.6 18538.8 7970.8 8195.5 8233.3 8259.1 8282.8 820.0 876.0 883.8 1016.6 1046.1 25866.5 26073.3 26101.5 26296.6 26529.3 901.9 965.4 996.2 1064.3 1065.1 12716.9 12866.6 12882.4 13003.5 13033.2 220263.0 220869.0 221664.0 223032.0 225280.0 45706.8 45894.8 45959.5 46287.8 46496.0 1224.6 1293.1 1298.5 1298.6 1306.8 24688.0 25000.6 25107.9 25131.2 25355.7 42562.0 43031.8 43075.6 43089.0 43151.0 261921.0 263855.0 264813.0 265274.0 267278.0 29202.0 29683.9 29895.9 29931.6 30000.1 35243.6 35743.6 36026.6 36132.6 36577.6 30197.5 32186.0 33069.5 33593.8 34328.5 31730.4 31936.5 32088.4 32206.5 32665.0 33176.2 33473.0 33624.8 33647.5 35719.6 33903.7 35465.5 35507.8 35649.6 37019.3 27834.7 28228.3 28518.7 28543.3 28634.9 08:30:28 INFO - 2015-11-18 08:30:28,114 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,115 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25228.26 Median:22787.25 stddev:87357.88 (383.4%) stddev-sans-first:87582.89 08:30:28 INFO - 2015-11-18 08:30:28,115 DEBUG : BROWSER_OUTPUT: Values: 307.4 307.5 310.7 312.9 317.8 10911.3 11199.8 15630.9 16012.9 16560.5 10479.3 10597.4 10760.9 10827.8 11018.3 4057.9 4121.7 4172.7 4178.8 4182.5 4059.4 4139.9 4162.7 4189.5 4208.9 4104.0 4143.3 4145.2 4147.9 4322.8 4261.6 4265.2 4341.5 4344.0 4351.5 3647.8 3675.4 3681.2 3753.1 3795.2 12216.6 12289.6 12549.1 12565.9 12625.4 1580.4 1629.4 1646.0 1674.8 1831.7 8607.7 8752.6 8986.4 9120.9 9126.8 1416.0 1449.9 1468.5 1542.0 1550.2 51385.5 53842.0 54533.0 54652.2 54812.0 5949.5 5997.2 6027.0 6057.9 6094.0 6776.2 6828.7 6854.6 6860.9 6868.7 4882.4 4883.6 5023.4 5060.8 5116.7 5271.3 5369.9 5500.6 5525.9 5560.2 2705.9 2724.1 2725.8 2734.7 2739.2 950.6 952.6 953.7 966.6 1018.9 340.3 347.1 360.6 381.2 428.3 8932.4 9122.3 9237.3 9548.5 10406.5 420.6 424.1 425.1 428.1 430.9 5139.4 5334.8 5797.2 5983.3 6031.4 511272.0 513994.0 538993.0 549677.0 553171.0 56788.0 59269.7 61992.4 66138.0 66248.0 453.7 461.5 462.8 466.6 467.8 9723.8 10136.2 10316.9 10394.0 10491.3 31638.4 32314.7 32441.0 32585.5 33133.0 42346.0 43025.6 43542.1 44400.0 45120.8 5543.1 5604.7 5699.3 5765.3 5794.1 10600.0 10725.0 10768.8 10850.8 10887.1 8935.9 9078.0 9245.2 9277.8 9405.1 8789.3 8965.1 9020.4 9122.7 9340.9 9457.1 9478.8 9563.7 9585.0 9726.3 5735.3 5785.5 5826.7 5828.9 5877.5 7880.6 8076.4 9552.3 9725.8 9738.9 08:30:28 INFO - 2015-11-18 08:30:28,115 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,115 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4467.64 Median:5709.37 stddev:2231.66 (39.1%) stddev-sans-first:2224.74 08:30:28 INFO - 2015-11-18 08:30:28,116 DEBUG : BROWSER_OUTPUT: Values: 1240.7 1270.5 1344.6 1505.1 1587.9 5504.9 5604.2 5985.1 6213.7 6301.4 6176.4 6236.3 6367.5 6422.4 6438.1 1948.8 1950.2 1963.0 1971.1 1985.3 1920.0 1943.6 1967.0 1968.7 1972.2 1929.4 1947.8 1951.3 1956.1 1977.2 1922.3 1928.8 1942.3 1955.5 1958.7 1927.3 1928.0 1968.6 2008.7 2008.9 6327.6 6467.1 6469.7 6473.8 6541.3 3942.2 4027.3 4032.2 4045.2 4048.6 2149.1 2197.8 2405.1 2437.6 2455.8 767.5 775.3 793.7 797.2 802.1 8165.1 8213.9 8264.8 8288.5 8293.8 3571.8 3604.0 3654.3 3713.1 3713.8 7231.5 7234.5 7321.6 7330.2 7337.0 4090.9 4112.9 4116.0 4126.8 4133.5 3719.9 3736.1 3767.6 3770.0 3785.6 3067.5 3101.8 3101.9 3136.6 3160.6 989.7 991.7 993.4 1002.0 1011.0 1192.1 1202.8 1210.2 1215.3 1221.1 5914.5 5943.6 5960.9 5986.9 6030.0 420.2 421.4 421.6 425.0 425.0 4782.4 4831.6 4834.1 4847.1 4884.9 7093.8 7104.5 7224.4 7375.2 7431.2 7175.4 7224.9 7270.6 7316.2 7320.3 5698.3 5973.0 6012.1 6102.3 6118.7 5899.9 5955.6 6012.1 6012.7 6034.7 6503.3 6549.9 6578.0 6625.3 6642.5 6617.5 6812.7 6816.5 6833.2 6870.8 5830.7 5832.8 5904.1 5922.3 5951.8 6174.4 6231.6 6289.0 6301.3 6304.3 5545.2 5800.6 5805.1 5807.9 5925.1 5720.4 5732.3 5750.8 5876.9 5879.4 5836.7 5875.9 5888.6 5934.3 5951.7 5364.3 5415.2 5423.1 5449.9 5450.4 5154.3 5329.1 5367.9 5389.9 5473.1 08:30:28 INFO - 2015-11-18 08:30:28,116 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,117 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5209.48 Median:6050.02 stddev:1631.24 (27.0%) stddev-sans-first:1593.39 08:30:28 INFO - 2015-11-18 08:30:28,118 DEBUG : BROWSER_OUTPUT: Values: 284.7 290.2 291.7 298.3 299.8 5926.7 5929.3 5949.3 5993.4 6141.4 5971.0 6009.3 6051.3 6054.4 6113.3 4360.9 4525.3 4567.0 4575.6 4577.0 4440.1 4449.8 4476.8 4528.4 4569.6 4464.6 4491.0 4500.5 4504.0 4509.1 4455.4 4481.4 4501.5 4505.5 4510.8 3799.8 3824.8 3831.0 3831.4 3835.7 5609.3 5750.5 5791.3 5797.9 5798.1 4967.1 5012.5 5015.3 5018.5 5027.7 6202.4 6229.7 6230.0 6235.8 6254.4 3892.9 4058.1 4101.5 4107.4 4107.8 6505.3 6509.3 6588.2 6601.8 6604.5 4131.3 4154.8 4160.1 4191.5 4210.4 4205.8 4217.1 4222.2 4274.0 4278.3 4823.5 4899.4 4916.4 4969.7 5010.6 6172.9 6184.8 6193.5 6240.0 6277.9 1476.1 1485.5 1490.3 1500.7 1503.4 937.3 939.6 948.3 963.2 963.4 5904.6 5920.3 5924.6 5963.7 5966.9 6441.2 6447.9 6493.9 6655.4 6667.8 6026.5 6032.9 6048.7 6052.8 6054.0 3538.6 3540.4 3540.6 3582.1 3589.6 6616.3 6708.1 6761.0 6805.3 6821.9 6710.7 6738.6 6818.4 6821.9 6837.0 6742.0 6754.5 6764.6 6806.5 6814.8 6319.1 6532.9 6575.6 6581.5 6597.4 6348.7 6371.6 6388.5 6457.5 6477.9 6697.5 6728.6 6730.5 6782.8 6795.2 4138.7 4153.3 4185.6 4333.9 4385.2 6441.9 6499.1 6521.7 6536.2 6551.3 6255.9 6272.6 6282.2 6359.8 6368.6 6055.4 6183.2 6245.6 6258.3 6285.6 6113.1 6128.1 6133.6 6156.8 6160.4 6248.1 6270.6 6287.7 6292.3 6343.3 5704.9 6016.5 6141.8 6176.2 6239.5 08:30:28 INFO - 2015-11-18 08:30:28,118 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,118 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12478.27 Median:537.84 stddev:14987.09 (2786.5%) stddev-sans-first:15002.68 08:30:28 INFO - 2015-11-18 08:30:28,119 DEBUG : BROWSER_OUTPUT: Values: 620.1 637.0 680.2 691.5 708.4 12673.1 12775.4 13073.9 13113.5 13251.3 12398.0 12428.9 12440.3 12477.9 12508.0 783.0 805.1 820.8 839.7 849.2 793.9 800.0 807.0 808.0 809.0 823.6 834.7 836.9 837.7 839.9 809.6 820.5 821.8 823.6 824.3 594.8 601.2 602.1 602.6 603.3 12532.7 12670.7 12726.9 12761.2 12904.5 8546.4 8584.6 8627.4 8918.6 9176.4 8272.5 8351.0 8354.3 8493.7 8524.9 2593.8 2624.0 2626.1 2681.1 2752.2 41805.4 42231.6 44586.3 45007.5 45348.0 8278.7 8360.2 8417.2 8431.3 8883.5 17585.7 17692.6 17693.4 17724.6 17824.9 6670.6 6698.7 6707.5 6794.1 6996.7 3581.3 3587.1 3606.2 3632.9 3641.7 2436.1 2489.7 2518.3 2549.6 2555.1 382.2 383.7 384.8 386.6 387.8 442.4 527.8 532.2 542.4 563.3 6964.4 7201.2 7265.8 7283.9 7414.4 533.2 548.3 576.8 576.8 590.3 3457.0 3591.5 3659.9 3685.3 3747.5 50515.5 51264.7 51359.2 51708.0 51828.7 47855.0 48514.8 48534.8 48629.0 48671.3 43413.8 43861.8 44700.3 44790.8 45015.3 7460.6 7483.6 7714.2 7760.7 7815.4 32181.4 32733.7 33529.2 33550.0 33676.2 42290.8 43363.6 43524.1 43553.1 43759.1 6517.8 6801.4 6876.9 7092.9 7097.1 10187.5 10226.7 10635.8 10659.5 10793.7 9849.3 9858.7 10162.8 10334.0 10381.7 9487.4 9519.7 9769.4 10087.9 10336.8 9344.3 9772.8 9798.5 10128.3 10640.3 7872.6 7971.5 8255.7 8269.9 8554.7 7392.3 7447.8 7652.7 8211.3 8480.4 08:30:28 INFO - 2015-11-18 08:30:28,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:30:28 INFO - 2015-11-18 08:30:28,119 DEBUG : BROWSER_OUTPUT: 08:30:28 INFO - 2015-11-18 08:30:28,605 INFO : Browser exited with error code: 0 08:30:28 INFO - 2015-11-18 08:30:28,637 INFO : Completed test dromaeo_css (00:18:30) 08:30:28 INFO - 2015-11-18 08:30:28,637 INFO : Starting test kraken 08:30:28 INFO - 2015-11-18 08:30:28,637 DEBUG : operating with platform_type : mac_ 08:30:28 INFO - 2015-11-18 08:30:28,637 INFO : Initialising browser for kraken test... 08:30:28 INFO - 2015-11-18 08:30:28,655 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp7rC68C/profile http://localhost:50080/getInfo.html 08:30:31 INFO - 2015-11-18 08:30:31,735 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:30:31 INFO - 2015-11-18 08:30:31,735 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:30:31 INFO - 2015-11-18 08:30:31,735 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:30:31 INFO - 2015-11-18 08:30:31,735 DEBUG : BROWSER_OUTPUT: __metrics 08:30:32 INFO - 2015-11-18 08:30:32,420 INFO : Browser initialized. 08:30:32 INFO - 2015-11-18 08:30:32,421 INFO : Running cycle 1/1 for kraken test... 08:30:32 INFO - 2015-11-18 08:30:32,421 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp7rC68C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:30:44 INFO - 2015-11-18 08:30:44,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 241377280 08:30:44 INFO - 2015-11-18 08:30:44,526 DEBUG : BROWSER_OUTPUT: 08:30:47 INFO - 2015-11-18 08:30:47,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50080/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:47 INFO - 2015-11-18 08:30:47,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 260358144 08:30:47 INFO - 2015-11-18 08:30:47,671 DEBUG : BROWSER_OUTPUT: 08:30:50 INFO - 2015-11-18 08:30:50,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50080/tests/kraken/driver.html?testName=audio-dft) 08:30:51 INFO - 2015-11-18 08:30:51,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 267739136 08:30:51 INFO - 2015-11-18 08:30:51,105 DEBUG : BROWSER_OUTPUT: 08:30:54 INFO - 2015-11-18 08:30:54,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50080/tests/kraken/driver.html?testName=audio-fft) 08:30:54 INFO - 2015-11-18 08:30:54,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 267677696 08:30:54 INFO - 2015-11-18 08:30:54,815 DEBUG : BROWSER_OUTPUT: 08:30:56 INFO - 2015-11-18 08:30:56,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50080/tests/kraken/driver.html?testName=audio-oscillator) 08:30:57 INFO - 2015-11-18 08:30:57,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 267919360 08:30:57 INFO - 2015-11-18 08:30:57,568 DEBUG : BROWSER_OUTPUT: 08:30:59 INFO - 2015-11-18 08:30:59,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:00 INFO - 2015-11-18 08:31:00,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 268374016 08:31:00 INFO - 2015-11-18 08:31:00,393 DEBUG : BROWSER_OUTPUT: 08:31:03 INFO - 2015-11-18 08:31:03,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50080/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:04 INFO - 2015-11-18 08:31:04,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 269742080 08:31:04 INFO - 2015-11-18 08:31:04,210 DEBUG : BROWSER_OUTPUT: 08:31:07 INFO - 2015-11-18 08:31:07,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50080/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:08 INFO - 2015-11-18 08:31:08,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 269955072 08:31:08 INFO - 2015-11-18 08:31:08,192 DEBUG : BROWSER_OUTPUT: 08:31:11 INFO - 2015-11-18 08:31:11,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50080/tests/kraken/driver.html?testName=json-parse-financial) 08:31:11 INFO - 2015-11-18 08:31:11,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 270209024 08:31:11 INFO - 2015-11-18 08:31:11,830 DEBUG : BROWSER_OUTPUT: 08:31:13 INFO - 2015-11-18 08:31:13,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:14 INFO - 2015-11-18 08:31:14,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 269152256 08:31:14 INFO - 2015-11-18 08:31:14,121 DEBUG : BROWSER_OUTPUT: 08:31:16 INFO - 2015-11-18 08:31:16,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:16 INFO - 2015-11-18 08:31:16,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 268771328 08:31:16 INFO - 2015-11-18 08:31:16,694 DEBUG : BROWSER_OUTPUT: 08:31:18 INFO - 2015-11-18 08:31:18,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:19 INFO - 2015-11-18 08:31:19,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 269156352 08:31:19 INFO - 2015-11-18 08:31:19,513 DEBUG : BROWSER_OUTPUT: 08:31:22 INFO - 2015-11-18 08:31:22,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:22 INFO - 2015-11-18 08:31:22,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 268726272 08:31:22 INFO - 2015-11-18 08:31:22,887 DEBUG : BROWSER_OUTPUT: 08:31:25 INFO - 2015-11-18 08:31:25,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:26 INFO - 2015-11-18 08:31:26,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 269225984 08:31:26 INFO - 2015-11-18 08:31:26,285 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50080/tests/kraken/driver.html?testName=ai-astar) 08:31:28 INFO - 2015-11-18 08:31:28,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 270569472 08:31:28 INFO - 2015-11-18 08:31:28,317 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,318 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:31:28 INFO - 2015-11-18 08:31:28,318 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;111;111;110;122;111;120;111;121 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;148;176;188;143;170;168;149;179;144 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: |2;audio-dft;174;186;184;186;190;188;203;194;188;187 08:31:28 INFO - 2015-11-18 08:31:28,319 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;76;76;78;80;80;135;77;80;80 08:31:28 INFO - 2015-11-18 08:31:28,320 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;95;140;97;100;100;140;102;103;144 08:31:28 INFO - 2015-11-18 08:31:28,320 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;125;130;131;130;129;130;136;130;130;136 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;139;143;143;144;143;143;142;143;143;142 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;107;120;113;123;108;106;112;113;119;117 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;68;68;74;75;75;75;83;76;74 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;75;84;85;83;81;83;79;78;78 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;97;99;97;99;97;100;98;99;101 08:31:28 INFO - 2015-11-18 08:31:28,321 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;148;144;151;152;138;141;159;161;145 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;162;166;176;172;175;161;174;173;167;174 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;75;78;81;80;80;81;81;82;82 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,719 08:31:28 INFO - 2015-11-18 08:31:28,322 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:31:28 INFO - 2015-11-18 08:31:28,323 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864288318__endTimestamp 08:31:28 INFO - 2015-11-18 08:31:28,323 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:31:28 INFO - 2015-11-18 08:31:28,323 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:31:28 INFO - 2015-11-18 08:31:28,323 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,324 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:111.00 stddev:5.86 (5.3%) stddev-sans-first:6.11 08:31:28 INFO - 2015-11-18 08:31:28,324 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 111.0 111.0 110.0 122.0 111.0 120.0 111.0 121.0 08:31:28 INFO - 2015-11-18 08:31:28,324 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,326 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:162.50 Median:169.00 stddev:16.03 (9.5%) stddev-sans-first:16.98 08:31:28 INFO - 2015-11-18 08:31:28,326 DEBUG : BROWSER_OUTPUT: Values: 160.0 148.0 176.0 188.0 143.0 170.0 168.0 149.0 179.0 144.0 08:31:28 INFO - 2015-11-18 08:31:28,326 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,326 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:188.00 Median:188.00 stddev:7.35 (3.9%) stddev-sans-first:5.79 08:31:28 INFO - 2015-11-18 08:31:28,326 DEBUG : BROWSER_OUTPUT: Values: 174.0 186.0 184.0 186.0 190.0 188.0 203.0 194.0 188.0 187.0 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.70 Median:79.00 stddev:18.13 (22.9%) stddev-sans-first:18.95 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 76.0 78.0 80.0 80.0 135.0 77.0 80.0 80.0 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:111.20 Median:142.00 stddev:21.11 (14.9%) stddev-sans-first:21.08 08:31:28 INFO - 2015-11-18 08:31:28,327 DEBUG : BROWSER_OUTPUT: Values: 91.0 95.0 140.0 97.0 100.0 100.0 140.0 102.0 103.0 144.0 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:130.70 Median:130.00 stddev:3.23 (2.5%) stddev-sans-first:2.69 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: Values: 125.0 130.0 131.0 130.0 129.0 130.0 136.0 130.0 130.0 136.0 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:142.50 Median:143.00 stddev:1.35 (0.9%) stddev-sans-first:0.60 08:31:28 INFO - 2015-11-18 08:31:28,328 DEBUG : BROWSER_OUTPUT: Values: 139.0 143.0 143.0 144.0 143.0 143.0 142.0 143.0 143.0 142.0 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.80 Median:115.00 stddev:5.83 (5.1%) stddev-sans-first:5.64 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: Values: 107.0 120.0 113.0 123.0 108.0 106.0 112.0 113.0 119.0 117.0 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.50 Median:75.00 stddev:4.79 (6.4%) stddev-sans-first:4.47 08:31:28 INFO - 2015-11-18 08:31:28,329 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 74.0 75.0 75.0 75.0 83.0 76.0 74.0 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.80 Median:82.00 stddev:4.18 (5.1%) stddev-sans-first:3.35 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 84.0 85.0 83.0 81.0 83.0 79.0 78.0 78.0 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:97.50 stddev:2.74 (2.8%) stddev-sans-first:1.42 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: Values: 91.0 97.0 99.0 97.0 99.0 97.0 100.0 98.0 99.0 101.0 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:149.50 stddev:8.22 (5.5%) stddev-sans-first:7.77 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: Values: 137.0 148.0 144.0 151.0 152.0 138.0 141.0 159.0 161.0 145.0 08:31:28 INFO - 2015-11-18 08:31:28,330 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:173.50 stddev:5.54 (3.2%) stddev-sans-first:5.06 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: Values: 162.0 166.0 176.0 172.0 175.0 161.0 174.0 173.0 167.0 174.0 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:81.00 stddev:3.29 (4.1%) stddev-sans-first:2.24 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 78.0 81.0 80.0 80.0 81.0 81.0 82.0 82.0 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:31:28 INFO - 2015-11-18 08:31:28,331 DEBUG : BROWSER_OUTPUT: 08:31:29 INFO - 2015-11-18 08:31:29,028 INFO : Browser exited with error code: 0 08:31:29 INFO - 2015-11-18 08:31:29,082 INFO : Completed test kraken (00:01:00) 08:31:29 INFO - 2015-11-18 08:31:29,082 INFO : Starting test v8_7 08:31:29 INFO - 2015-11-18 08:31:29,082 DEBUG : operating with platform_type : mac_ 08:31:29 INFO - 2015-11-18 08:31:29,082 INFO : Initialising browser for v8_7 test... 08:31:29 INFO - 2015-11-18 08:31:29,096 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp9LsTpF/profile http://localhost:50080/getInfo.html 08:31:32 INFO - 2015-11-18 08:31:32,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:31:32 INFO - 2015-11-18 08:31:32,128 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:31:32 INFO - 2015-11-18 08:31:32,128 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:31:32 INFO - 2015-11-18 08:31:32,128 DEBUG : BROWSER_OUTPUT: __metrics 08:31:32 INFO - 2015-11-18 08:31:32,821 INFO : Browser initialized. 08:31:32 INFO - 2015-11-18 08:31:32,821 INFO : Running cycle 1/1 for v8_7 test... 08:31:32 INFO - 2015-11-18 08:31:32,822 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/T/tmp9LsTpF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:31:44 INFO - 2015-11-18 08:31:44,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 242290688 08:31:44 INFO - 2015-11-18 08:31:44,941 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50080/tests/v8_7/run.html (next: http://localhost:50080/tests/v8_7/run.html) 08:32:06 INFO - 2015-11-18 08:32:06,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 262295552 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |0;Richards;171.29153819801303 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;209.55574182732607 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |2;Encrypt;346.5003465003465 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6191.358024691358 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1226.993865030675 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |5;Earley;881.0572687224669 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |6;Boyer;14735.29411764706 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |7;RegExp;31625 08:32:06 INFO - 2015-11-18 08:32:06,675 DEBUG : BROWSER_OUTPUT: |8;Splay;772.2007722007722 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6197.530864197531 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: __startTimestamp1447864326666__endTimestamp 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.29 Median:171.29 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: Values: 171.3 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:209.56 Median:209.56 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: Values: 209.6 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,676 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:346.50 Median:346.50 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: Values: 346.5 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6191.36 Median:6191.36 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: Values: 6191.4 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1226.99 Median:1226.99 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: Values: 1227.0 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:881.06 Median:881.06 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: Values: 881.1 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14735.29 Median:14735.29 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: Values: 14735.3 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,677 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31625.00 Median:31625.00 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: Values: 31625.0 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: Values: 772.2 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6197.53 Median:6197.53 stddev:0.00 (0.0%) 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: Values: 6197.5 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:32:06 INFO - 2015-11-18 08:32:06,678 DEBUG : BROWSER_OUTPUT: 08:32:07 INFO - 2015-11-18 08:32:07,348 INFO : Browser exited with error code: 0 08:32:07 INFO - 2015-11-18 08:32:07,370 INFO : Completed test v8_7 (00:00:38) 08:32:07 INFO - 2015-11-18 08:32:07,755 INFO : Completed test suite (00:20:09) 08:32:07 INFO - 2015-11-18 08:32:07,755 DEBUG : Working with test: dromaeo_css 08:32:07 INFO - 2015-11-18 08:32:07,755 DEBUG : Generating results file: dromaeo_css 08:32:07 INFO - 2015-11-18 08:32:07,756 DEBUG : Working with test: kraken 08:32:07 INFO - 2015-11-18 08:32:07,756 DEBUG : Generating results file: kraken 08:32:07 INFO - 2015-11-18 08:32:07,756 INFO : javascript benchmark 08:32:07 INFO - 2015-11-18 08:32:07,756 DEBUG : Working with test: v8_7 08:32:07 INFO - 2015-11-18 08:32:07,757 DEBUG : Generating results file: v8_7 08:32:07 INFO - 2015-11-18 08:32:07,757 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:07 INFO - 2015-11-18 08:32:07,810 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 08:32:07 INFO - 2015-11-18 08:32:07,810 DEBUG : process_Request line: dromaeo_css 5956.08 graph.html#tests=[[72,64,57]] 08:32:07 INFO - 2015-11-18 08:32:07,811 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:07 INFO - 2015-11-18 08:32:07,842 DEBUG : process_Request line: kraken 1693.40 graph.html#tests=[[232,64,57]] 08:32:07 INFO - 2015-11-18 08:32:07,842 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:32:07 INFO - 2015-11-18 08:32:07,872 DEBUG : process_Request line: v8_7 17905.87 graph.html#tests=[[230,64,57]] 08:32:07 INFO - 2015-11-18 08:32:07,872 INFO : javascript benchmark 08:32:07 INFO - 2015-11-18 08:32:07,874 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2899.275181204699, 2909.3017675757824, 2977.2110390746457, 3039.7568194544438, 3105.1616063662814, 4692.859214223575, 4721.834735784244, 4738.905221895564, 4835.395575553056, 4854.902901941968, 4521.502634710179, 4596.287575425815, 4685.2035154023815, 4715.174844402233, 4733.313669517918, 4362.650987920959, 4379.474463064421, 4422.11557688462, 4467.106578684276, 4536.682432229745, 185.59577240769605, 4349.826006959734, 4422.646188304944, 4539.046800171968, 4567.177907976563, 4275.166342563201, 4407.07451435199, 4431.512533621299, 4503.572160644733, 4532.864014079583, 4460.286354183348, 4470.307102399133, 4470.75410852403, 4493.101379724036, 4500.504944456107, 4194.266003449415, 4403.251447253974, 4457.531959144308, 4505.076459325863, 4558.817647294104, 4449.777511124463, 4567.771611419449, 4689.906201875943, 4716.221823399135, 4757.0723708876785, 5044.9747751261375, 5052.444231134572, 5093.261477085802, 5097.5667068299235, 5232.8691782705355, 4956.553910148104, 4961.82633607822, 5016.272640467148, 5124.769385377667, 5172.767225474825, 4807.591354734852, 4825.855224343275, 4847.054824309261, 4856.004519073582, 4910.8772280693265, 5174.223866419992, 5233.764480598382, 5275.155975043975, 5277.102892508283, 5278.81524146653, 4864.027194561102, 4885.071836351153, 4941.604671626261, 4972.925406118911, 5004.47453017428, 4838.080764654705, 4950.77721502526, 4965.47862474435, 4997.5002499749735, 5003.524665156804, 4856.077345304451, 4866.0511200316305, 4887.266909963534, 4901.58336541398, 4909.484504127086, 4883.267509873476, 4910.877228069256, 4936.111499929975, 4961.627877909171, 5057.924131138036, 3899.5905429930017, 3901.063744701308, 3922.254771593445, 3970.4242884781543, 3972.980135099306, 3543.362194804908, 3607.1703508192736, 3609.0616439725336, 3639.5450568678916, 3663.8900832975055, 4643.303504474288, 4679.625629949596, 4740.597049250783, 4780.641451891122, 4822.95177048225, 5146.794128234828, 5167.612429067835, 5189.922151167735, 5190.2214667800135, 5206.140986737146, 4621.607163391082, 4791.95208047922, 4854.150523658345, 4858.198397264482, 4862.246351815475, 4366.14860102277, 4421.093675796454, 4437.489688685842, 4473.060657261946, 4476.060027394218, 5209.947900520946, 5228.712420816892, 5247.737613119329, 5256.132738098171, 5261.973690131601, 4861.392325959255, 4979.278004689372, 5042.647014708935, 5179.533841954242, 5227.137522308929, 5218.452062533379, 5221.712805795566, 5270.130428479258, 5272.0, 5285.471452854684, 5059.772310245974, 5072.213806859942, 5084.3898732152375, 5123.154679477844, 5138.486151384832, 4822.638302127425, 4959.057779021974, 4980.750962451791, 5081.745912704276, 5145.3568303962, 4925.950740492549, 4959.380077490314, 4985.501449854985, 5012.899742005066, 5031.84904452867, 4953.975230123826, 4967.652264341461, 4975.203967365204, 4982.252662100569, 5016.297718319365, 4623.352730617649, 4712.976435117803, 4860.392450943632, 4896.0, 4939.43196532389, 4902.117618828645, 4926.48271931442, 5012.3233363495465, 5012.899742005213, 5112.74436278192, 4662.184117779443, 4928.975355123202, 4934.309196712535, 4968.22992436173, 4973.055119527278], "unit": "ms", "name": "dojo.html", "value": 4676.4659902320855}, {"lowerIsBetter": false, "replicates": [519.0138736400838, 520.2118790033101, 532.2442132172315, 536.4796147736695, 551.2200236665121, 36215.45676814846, 36678.0, 36729.26541469173, 36733.81633091837, 36989.260214795686, 39352.21295574094, 39392.60607393925, 39792.0, 40069.599304007024, 40129.39805902914, 8399.664013439471, 8579.914200857975, 8622.180892815173, 8746.344024198179, 8749.781255468632, 8483.872741908875, 8518.27594654455, 8525.360597955147, 8535.274501667334, 8571.871421928645, 8508.149185081504, 8516.361272904525, 8517.36119791018, 8528.829423411527, 8645.135486451367, 8504.107068757785, 8586.356023298278, 8631.43895646784, 8642.0, 8657.82684346316, 8394.118617545131, 8538.82922341556, 8560.101189375087, 8568.228859402683, 8613.353998450142, 37060.81469592635, 37122.0, 37136.25727485462, 37149.628503714885, 37333.62666373356, 2431.234161239204, 2708.3635345693747, 2851.8574071296352, 2908.3165456117795, 2956.9260768480744, 25246.24261272165, 25413.872930635414, 25807.708835080542, 25893.611595826078, 25910.74089259102, 2104.2845432552854, 2130.286354071388, 2147.9248226312, 2164.491344534033, 2310.595645761985, 218828.0, 220815.89592052097, 221422.0, 221788.0, 222017.0, 47361.52638473571, 48064.27903581449, 53910.46089539133, 54284.45715542873, 55074.724626377414, 50951.0, 50998.49001510011, 51040.234396484084, 51227.23159152616, 51486.22770658443, 15647.139407332706, 15675.529734107995, 15691.058536487619, 15743.291551880193, 15877.682446351238, 11686.590969316203, 11961.46173422198, 11984.101192410604, 11994.76010479803, 12029.699257518458, 18009.54976125581, 18338.17478213457, 18345.266189352278, 18409.631807363778, 18538.814611853708, 7970.800729981681, 8195.467294625949, 8233.259006689426, 8259.091499935003, 8282.80505665999, 820.0364571628313, 875.9956200218958, 883.8143989762222, 1016.6289304403839, 1046.053321743823, 25866.51375003139, 26073.348166295993, 26101.477970440486, 26296.605550916753, 26529.33676658099, 901.9278457723366, 965.4014511003082, 996.1881066930573, 1064.2709743825503, 1065.1053115383115, 12716.936415318049, 12866.614001579968, 12882.355882205853, 13003.479860805652, 13033.218006919615, 220263.0, 220869.0, 221664.0, 223032.0, 225280.0, 45706.771466142454, 45894.770526147826, 45959.54040459553, 46287.76856115765, 46496.0, 1224.5714000099895, 1293.0625296660035, 1298.5195477673133, 1298.6039258026392, 1306.751717173734, 24688.0, 25000.624990625518, 25107.87446062758, 25131.24606261815, 25355.74644253534, 42562.0, 43031.78484107685, 43075.56924430841, 43089.0, 43151.0, 261921.0, 263855.0, 264813.0, 265274.0, 267278.0, 29202.0, 29683.851580741957, 29895.850520747255, 29931.55102673418, 30000.099997000125, 35243.64756352506, 35743.64256357507, 36026.63973360233, 36132.63867361293, 36577.63422365742, 30197.547036794906, 32186.0, 33069.503957440174, 33593.83203083969, 34328.48507272443, 31730.365392691554, 31936.52095218527, 32088.358232834744, 32206.516902246953, 32665.0, 33176.1705957353, 33473.0, 33624.831875841446, 33647.495287570215, 35719.64280357267, 33903.66096339005, 35465.46801798027, 35507.82246088753, 35649.643503564635, 37019.25961480809, 27834.721652783213, 28228.294292642848, 28518.714812852435, 28543.28641783972, 28634.85682571657], "unit": "ms", "name": "ext.html", "value": 16877.953997540535}, {"lowerIsBetter": false, "replicates": [307.3790942296561, 307.4749243750995, 310.73587450666935, 312.8623405701491, 317.75374085084064, 10911.345319280828, 11199.832002519948, 15630.92184539077, 16012.919935400321, 16560.503184904443, 10479.318844275116, 10597.364158150496, 10760.892391076088, 10827.83758243627, 11018.283811552243, 4057.9391309130388, 4121.690873184523, 4172.687048471362, 4178.791060446965, 4182.477190351206, 4059.4113853491226, 4139.875803725878, 4162.687798415116, 4189.518205406387, 4208.852690155845, 4103.97948010261, 4143.337066069429, 4145.191687620915, 4147.896302592444, 4322.805473753673, 4261.5738426157295, 4265.232258193524, 4341.500727416356, 4344.0, 4351.521332653406, 3647.7993710345922, 3675.3568125578186, 3681.208540163878, 3753.1367785409234, 3795.203007368428, 12216.633500994983, 12289.56986505477, 12549.1215614907, 12565.93717031409, 12625.368731563385, 1580.3678528588657, 1629.3726915137638, 1646.0, 1674.815770265282, 1831.706926891691, 8607.741767746978, 8752.606132724042, 8986.37095403322, 9120.908790912072, 9126.77183070422, 1415.9504417345447, 1449.9202543860083, 1468.5080498033064, 1541.9614509637236, 1550.2403822127076, 51385.48614513844, 53842.0, 54533.0, 54652.18021729677, 54812.0, 5949.542362121308, 5997.190379298739, 6027.0, 6057.939420605826, 6093.99449090895, 6776.220734615484, 6828.726850926007, 6854.588724676535, 6860.897086543706, 6868.656567171622, 4882.389701287339, 4883.633727470454, 5023.372078490189, 5060.84817455477, 5116.718580478035, 5271.288376069181, 5369.865753356197, 5500.58745594074, 5525.889482210414, 5560.221568980346, 2705.8511781851794, 2724.087430710734, 2725.7819374449996, 2734.6718393792476, 2739.178246526074, 950.5978681444814, 952.6094301336558, 953.6948176583427, 966.5795379010153, 1018.8944994680854, 340.3397409026481, 347.147752268181, 360.5799243880902, 381.21469772269216, 428.29759194920354, 8932.374733768575, 9122.270218382513, 9237.307201959746, 9548.522573871418, 10406.536468712575, 420.55421253471417, 424.1114864359163, 425.1263653192719, 428.0924440186824, 430.9482862056573, 5139.357580302462, 5334.839954801362, 5797.2173756542325, 5983.282006159288, 6031.396860313934, 511272.0, 513994.0, 538993.0, 549677.0, 553171.0, 56788.0, 59269.70365148147, 61992.380076199566, 66138.0, 66248.0, 453.72549607487656, 461.4877485990548, 462.7686156921539, 466.60338712095125, 467.7661169415292, 9723.77771390625, 10136.189104871444, 10316.896831031894, 10394.01256880595, 10491.318064325795, 31638.367232655677, 32314.676853231165, 32441.0, 32585.511217332234, 33133.0, 42346.0, 43025.56974430341, 43542.12915741731, 44400.0, 45120.77439612781, 5543.1408131738035, 5604.719764011702, 5699.344575373885, 5765.308163020464, 5794.101914203306, 10600.0, 10725.0, 10768.838467422838, 10850.837237441287, 10887.129029677766, 8935.910640893768, 9078.0, 9245.214156796748, 9277.814443711222, 9405.05949405054, 8789.34079943994, 8965.148310910454, 9020.413673111227, 9122.726318210463, 9340.859887101564, 9457.148856602938, 9478.810423791349, 9563.665271715456, 9584.952075239578, 9726.319157658896, 5735.254416925773, 5785.479306862402, 5826.737796799239, 5828.883422331614, 5877.500412464989, 7880.605969701377, 8076.353891688534, 9552.283578731483, 9725.805483890425, 9738.902610974083], "unit": "ms", "name": "jquery.html", "value": 6016.842988716156}, {"lowerIsBetter": false, "replicates": [1240.652617267165, 1270.5235536673747, 1344.6100630817064, 1505.096941834899, 1587.9206039698013, 5504.91742623861, 5604.215409842615, 5985.072313791364, 6213.658248796314, 6301.40136687014, 6176.382361763822, 6236.282827474842, 6367.49060075194, 6422.389872962073, 6438.0986661867255, 1948.8246057854826, 1950.229659284589, 1962.9607407851834, 1971.0932970833362, 1985.2852972929734, 1919.9808001919941, 1943.6112777444569, 1967.0263219706264, 1968.694852297889, 1972.1815446589649, 1929.3536665217168, 1947.8344340731055, 1951.2780271299569, 1956.1001939108028, 1977.2486455147025, 1922.3079691311116, 1928.7878333383317, 1942.3298961858206, 1955.5404479947201, 1958.696402057669, 1927.3158028899818, 1927.9903600482048, 1968.5964377302762, 2008.6742749785217, 2008.8895110768901, 6327.620342779402, 6467.126937863375, 6469.708863101125, 6473.83815404614, 6541.28045914949, 3942.2115576884453, 4027.2952233359047, 4032.193561287725, 4045.170739998323, 4048.554658987509, 2149.140343862452, 2197.835162362829, 2405.0860672944345, 2437.585610446228, 2455.7789798918006, 767.458941446279, 775.25962705616, 793.6983946100503, 797.1749239537052, 802.0896282719098, 8165.061017982948, 8213.932188815475, 8264.8347033059, 8288.461250018669, 8293.792655183608, 3571.8035508047305, 3604.008897553141, 3654.250878569887, 3713.1088538751046, 3713.832877520518, 7231.45764067697, 7234.493585449073, 7321.597312147883, 7330.193678695339, 7337.0, 4090.9386359204636, 4112.876613701594, 4116.0, 4126.7523948563185, 4133.545310015896, 3719.925601487955, 3736.065983504124, 3767.566729826105, 3769.981150094232, 3785.5835858055593, 3067.5245336972803, 3101.7828751987595, 3101.8604162812726, 3136.6079240094987, 3160.620725512953, 989.737719504332, 991.6628346362271, 993.4238141877838, 1001.9949900250598, 1011.014261095426, 1192.0642295797757, 1202.8376169217045, 1210.2133613151523, 1215.2647648172906, 1221.1207930290177, 5914.467697907209, 5943.613665111754, 5960.940390596039, 5986.910196347058, 6029.969850150721, 420.17645414986356, 421.4079218697735, 421.61211685249646, 424.980875860587, 425.03304981167474, 4782.3543821584335, 4831.637627177975, 4834.081524510332, 4847.103285892122, 4884.877878053077, 7093.751718689821, 7104.467164962649, 7224.385927196142, 7375.18872923978, 7431.2197219292275, 7175.425965922714, 7224.927750722531, 7270.600116993616, 7316.158641756266, 7320.267973202744, 5698.344690360579, 5973.044312909914, 6012.098185272244, 6102.298235702862, 6118.694065296718, 5899.882002359843, 5955.642661440327, 6012.128241405059, 6012.669303188367, 6034.668093254913, 6503.349665033459, 6549.934500654933, 6577.967110164419, 6625.337466253529, 6642.5018123641885, 6617.470602351704, 6812.693428795617, 6816.522843401112, 6833.214180369321, 6870.828229294308, 5830.708464576839, 5832.766689332379, 5904.0553511437965, 5922.348541660328, 5951.821445356646, 6174.38256174379, 6231.594946328474, 6289.0, 6301.338359472189, 6304.338044505261, 5545.195946587803, 5800.622959507618, 5805.129230615442, 5807.912881306699, 5925.140854575976, 5720.399358067343, 5732.3121225453215, 5750.7987220447085, 5876.853078673067, 5879.382664820132, 5836.678982655825, 5875.94124058771, 5888.558358123244, 5934.347221805511, 5951.7024148791525, 5364.30264065669, 5415.187721841755, 5423.105187643994, 5449.891002180014, 5450.373207081077, 5154.278401023935, 5329.067413202752, 5367.865803354791, 5389.946100538945, 5473.06957817164], "unit": "ms", "name": "mootools.html", "value": 3661.626186684961}, {"lowerIsBetter": false, "replicates": [284.7380410022779, 290.21496851018, 291.73743630732343, 298.3332252415852, 299.7871511227029, 5926.674032928187, 5929.2884853817495, 5949.315828679703, 5993.370696076914, 6141.416565426277, 5971.0, 6009.26578406825, 6051.334353221142, 6054.364291749369, 6113.32753397126, 4360.8691739247715, 4525.2533332000185, 4566.999999999992, 4575.633949284066, 4577.0, 4440.111977604476, 4449.84425545106, 4476.753778542179, 4528.43394575678, 4569.565891240343, 4464.620507256887, 4490.97754511227, 4500.459944806627, 4504.0, 4509.053098849229, 4455.398521199629, 4481.395011673431, 4501.504834468222, 4505.504394516601, 4510.774461276923, 3799.772013679188, 3824.770513769183, 3831.0, 3831.425286207091, 3835.7314987950854, 5609.270794796691, 5750.539956803487, 5791.276090488689, 5797.855053623651, 5798.10129429939, 4967.081089998362, 5012.473690262506, 5015.269731942474, 5018.548330650259, 5027.723475208862, 6202.410770976795, 6229.719662615194, 6229.968850155766, 6235.781747638856, 6254.405831446005, 3892.902677433087, 4058.147788964321, 4101.5488296287385, 4107.363358679379, 4107.835686572534, 6505.251896031969, 6509.2839787623325, 6588.176477940257, 6601.834954126137, 6604.537682362188, 4131.29767939451, 4154.771487568213, 4160.1471698301775, 4191.517975432804, 4210.431591735138, 4205.810738516774, 4217.135487225111, 4222.19778242133, 4273.978630106892, 4278.294081476583, 4823.541763532458, 4899.436564795023, 4916.410030796327, 4969.701817890938, 5010.649254552146, 6172.876542469216, 6184.845378865564, 6193.473554747897, 6240.0, 6277.905831412532, 1476.0700758522278, 1485.524632117712, 1490.2697678137852, 1500.7073620644087, 1503.361071544589, 937.2595649437005, 939.5959737313021, 948.3219498058921, 963.2390411574918, 963.3834346018554, 5904.61619994699, 5920.31916329619, 5924.644521328734, 5963.731632076567, 5966.910496342558, 6441.227052753699, 6447.871042579122, 6493.8701225976165, 6655.434288085567, 6667.799966001027, 6026.487748541423, 6032.939670603326, 6048.6975651218145, 6052.848678783065, 6054.001089820218, 3538.610752817188, 3540.3804334241404, 3540.6282340354405, 3582.068662147808, 3589.5513060867393, 6616.27221005689, 6708.094407255056, 6761.0, 6805.251422343538, 6821.93178068213, 6710.66446677674, 6738.561993470506, 6818.352256535622, 6821.863562728718, 6836.965815170893, 6742.0, 6754.493412994045, 6764.5603035802515, 6806.5235433520165, 6814.76148334796, 6319.146915166578, 6532.934670653232, 6575.572587781779, 6581.506387021088, 6597.439217666552, 6348.71430785625, 6371.617702937839, 6388.488920886411, 6457.4511166551365, 6477.902831457626, 6697.531172817856, 6728.562643428358, 6730.46156307504, 6782.762603308861, 6795.150606174228, 4138.710290279651, 4153.293940030262, 4185.644220241192, 4333.891652708581, 4385.188740082967, 6441.871162576816, 6499.122618446449, 6521.67391630426, 6536.215654121535, 6551.279359270381, 6255.937440625536, 6272.560920735505, 6282.246130464374, 6359.777407790705, 6368.5860419072615, 6055.3944605540855, 6183.165272688309, 6245.6252624842655, 6258.311585725475, 6285.5600107992, 6113.14415981754, 6128.111423843428, 6133.570650054632, 6156.846078847885, 6160.353162917829, 6248.094026366242, 6270.623762574261, 6287.654179020014, 6292.307846137013, 6343.302236754045, 5704.885902281848, 6016.4585187331595, 6141.785037523665, 6176.166217560572, 6239.500839932885], "unit": "ms", "name": "prototype.html", "value": 4656.670027513175}, {"lowerIsBetter": false, "replicates": [620.0606081786098, 637.0348921384101, 680.2143524229517, 691.5159388428102, 708.4438715608247, 12673.112882098245, 12775.425105870236, 13073.934630326836, 13113.54102606409, 13251.337433128354, 12398.0, 12428.93785531071, 12440.25358478492, 12477.937610311936, 12508.0, 783.0407750505642, 805.0822062848329, 820.8440396324694, 839.6725277141919, 849.2102344819316, 793.8650429426982, 800.0399520575304, 806.9717559885405, 807.9636416361278, 808.975730728079, 823.6375994562374, 834.6911642692182, 836.8995720513547, 837.656560810065, 839.9412041157121, 809.5628360685223, 820.5445977482494, 821.7945513621595, 823.6375994562374, 824.3364091906013, 594.8156071617769, 601.1553766957431, 602.0848310567912, 602.57518449493, 603.3483837455537, 12532.686682832911, 12670.746585068247, 12726.872731272753, 12761.234325940473, 12904.54834080812, 8546.40175187737, 8584.570771461402, 8627.352948528885, 8918.598663060178, 9176.44941303524, 8272.462289951194, 8351.0, 8354.331653467709, 8493.683479060755, 8524.8721269181, 2593.8314009589317, 2624.042224588031, 2626.0677459501794, 2681.115231973444, 2752.174347695703, 41805.37291940593, 42231.577684223375, 44586.33120503162, 45007.549924500665, 45348.0, 8278.710245141512, 8360.189668180677, 8417.200365965224, 8431.325493960469, 8883.511406872683, 17585.7362139568, 17692.646147076986, 17693.380731674588, 17724.645507089786, 17824.91087544554, 6670.599764014175, 6698.66506674674, 6707.463402927754, 6794.116764820542, 6996.6851491683, 3581.28374325136, 3587.0852932502567, 3606.2246616977477, 3632.909177270589, 3641.7268704847243, 2436.1229957215387, 2489.7302375788477, 2518.2948774343213, 2549.5538280800783, 2555.067400398841, 382.1897577136433, 383.68154431821523, 384.7633705271294, 386.5786292940708, 387.76540193182717, 442.40275627902076, 527.8363707250764, 532.238898375327, 542.4331573505696, 563.3155715805316, 6964.421646525027, 7201.243869393743, 7265.818354541073, 7283.890741638879, 7414.406847452191, 533.2454576773822, 548.3036543589619, 576.7692922830818, 576.8125359258174, 590.2680675961863, 3456.9654303457146, 3591.497190393347, 3659.8536058557893, 3685.3182161300247, 3747.5315585551807, 50515.49484505181, 51264.74367628138, 51359.22961155586, 51708.0, 51828.74085629548, 47855.0, 48514.75742621264, 48534.845235059605, 48629.0, 48671.269930951064, 43413.782931085145, 43861.78069109698, 44700.3294950576, 44790.77604611956, 45015.32477012847, 7460.552366858006, 7483.588402637907, 7714.228577142465, 7760.650770715219, 7815.374770018499, 32181.35637287288, 32733.672663274014, 33529.16177095592, 33549.987000780035, 33676.158096047795, 42290.788546058306, 43363.56636433595, 43524.12951741011, 43553.12893742044, 43759.12481750284, 6517.804465866032, 6801.421879140328, 6876.896846547406, 7092.893606596009, 7097.077379940574, 10187.541560629938, 10226.693199204035, 10635.840462392916, 10659.520321585393, 10793.67618971432, 9849.26130540198, 9858.704238872846, 10162.847557286499, 10334.0, 10381.740456488647, 9487.430754154497, 9519.666811661558, 9769.413835169913, 10087.949560252151, 10336.793264134525, 9344.252459803336, 9772.755681108029, 9798.461084640128, 10128.34165779222, 10640.308379955279, 7872.606369681607, 7971.481853679492, 8255.669773209005, 8269.875951860848, 8554.743357699279, 7392.297731715694, 7447.840126363294, 7652.740184376967, 8211.302039326485, 8480.363972702195], "unit": "ms", "name": "yui.html", "value": 5512.687975523066}], "name": "dromaeo_css", "value": 5956.0798282804935}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 111.0, 111.0, 110.0, 122.0, 111.0, 120.0, 111.0, 121.0], "unit": "ms", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [160.0, 148.0, 176.0, 188.0, 143.0, 170.0, 168.0, 149.0, 179.0, 144.0], "unit": "ms", "name": "audio-beat-detection", "value": 162.5}, {"lowerIsBetter": true, "replicates": [174.0, 186.0, 184.0, 186.0, 190.0, 188.0, 203.0, 194.0, 188.0, 187.0], "unit": "ms", "name": "audio-dft", "value": 188.0}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 76.0, 78.0, 80.0, 80.0, 135.0, 77.0, 80.0, 80.0], "unit": "ms", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 140.0, 97.0, 100.0, 100.0, 140.0, 102.0, 103.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [125.0, 130.0, 131.0, 130.0, 129.0, 130.0, 136.0, 130.0, 130.0, 136.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 130.7}, {"lowerIsBetter": true, "replicates": [139.0, 143.0, 143.0, 144.0, 143.0, 143.0, 142.0, 143.0, 143.0, 142.0], "unit": "ms", "name": "imaging-darkroom", "value": 142.5}, {"lowerIsBetter": true, "replicates": [107.0, 120.0, 113.0, 123.0, 108.0, 106.0, 112.0, 113.0, 119.0, 117.0], "unit": "ms", "name": "imaging-desaturate", "value": 113.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 74.0, 75.0, 75.0, 75.0, 83.0, 76.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 73.5}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 84.0, 85.0, 83.0, 81.0, 83.0, 79.0, 78.0, 78.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 79.8}, {"lowerIsBetter": true, "replicates": [91.0, 97.0, 99.0, 97.0, 99.0, 97.0, 100.0, 98.0, 99.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 97.8}, {"lowerIsBetter": true, "replicates": [137.0, 148.0, 144.0, 151.0, 152.0, 138.0, 141.0, 159.0, 161.0, 145.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 147.6}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 176.0, 172.0, 175.0, 161.0, 174.0, 173.0, 167.0, 174.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 170.0}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 78.0, 81.0, 80.0, 80.0, 81.0, 81.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 79.2}], "name": "kraken", "value": 1693.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.29153819801303], "unit": "score", "name": "Richards", "value": 206.09307599999988}, {"lowerIsBetter": false, "replicates": [209.55574182732607], "unit": "score", "name": "DeltaBlue", "value": 315.515096}, {"lowerIsBetter": false, "replicates": [346.5003465003465], "unit": "score", "name": "Encrypt", "value": 768.1983660000003}, {"lowerIsBetter": false, "replicates": [6191.358024691358], "unit": "score", "name": "Decrypt", "value": 42.99234496510472}, {"lowerIsBetter": false, "replicates": [1226.993865030675], "unit": "score", "name": "RayTrace", "value": 603.0910349999999}, {"lowerIsBetter": false, "replicates": [881.0572687224669], "unit": "score", "name": "Earley", "value": 756.4355050000001}, {"lowerIsBetter": false, "replicates": [14735.29411764706], "unit": "score", "name": "Boyer", "value": 45.229025948103796}, {"lowerIsBetter": false, "replicates": [31625.0], "unit": "score", "name": "RegExp", "value": 28.80584980237153}, {"lowerIsBetter": false, "replicates": [772.2007722007722], "unit": "score", "name": "Splay", "value": 105.53084499999999}, {"lowerIsBetter": false, "replicates": [6197.530864197531], "unit": "score", "name": "NavierStokes", "value": 239.45019920318714}], "name": "v8_7", "value": 17905.866615732142}]} 08:32:07 INFO - RETURN: dromaeo_css: 5956.08 08:32:07 INFO - RETURN: kraken: 1693.40 08:32:07 INFO - RETURN: v8_7: 17905.87 08:32:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "17905.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1693.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5956.08"}}} 08:32:07 INFO - Return code: 0 08:32:07 INFO - # TBPL SUCCESS # 08:32:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:32:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:32:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:32:07 INFO - 2015-11-18 08:32:07.984 screenresolution[1951:15592] starting screenresolution argv=screenresolution get 08:32:07 INFO - 2015-11-18 08:32:07.988 screenresolution[1951:15592] Display 0: 1600x1200x32@60 08:32:07 INFO - 2015-11-18 08:32:07.994 screenresolution[1952:15595] starting screenresolution argv=screenresolution list 08:32:07 INFO - Available Modes on Display 0 08:32:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:32:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:32:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:32:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:32:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:32:08 INFO - Intel HD Graphics 3000: 08:32:08 INFO - Chipset Model: Intel HD Graphics 3000 08:32:08 INFO - Type: GPU 08:32:08 INFO - Bus: Built-In 08:32:08 INFO - VRAM (Total): 512 MB 08:32:08 INFO - VRAM (Dynamic, Max): 10 08:32:08 INFO - Vendor: Intel (0x8086) 08:32:08 INFO - Device ID: 0x0116 08:32:08 INFO - Revision ID: 0x0009 08:32:08 INFO - Displays: 08:32:08 INFO - Display: 08:32:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:32:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:32:08 INFO - Display Serial Number: 1600x1200 60 08:32:08 INFO - Main Display: Yes 08:32:08 INFO - Mirror: Off 08:32:08 INFO - Online: Yes 08:32:08 INFO - Rotation: Supported 08:32:08 INFO - Return code: 0 08:32:08 INFO - Running post-action listener: _resource_record_post_action 08:32:08 INFO - Running post-run listener: _resource_record_post_run 08:32:09 INFO - Total resource usage - Wall time: 1250s; CPU: 30.0%; Read bytes: 3657728; Write bytes: 694327296; Read time: 1820; Write time: 56608 08:32:09 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 341334528; Write bytes: 339261440; Read time: 34067; Write time: 6569 08:32:09 INFO - run-tests - Wall time: 1211s; CPU: 30.0%; Read bytes: 3612672; Write bytes: 344543232; Read time: 1755; Write time: 49188 08:32:09 INFO - Running post-run listener: _upload_blobber_files 08:32:09 INFO - Blob upload gear active. 08:32:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:32:09 INFO - Copying logs to upload dir... 08:32:09 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1304.191821 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-18 08:32:09.402679) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:09.405811) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010101 build_url: 'https://queue.taskcluster.net/v1/task/RBAZ_rkYSWmHDaun07unzA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:09.432717) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:09.433083) ========= 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.fFM5kOrDLP/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.txsAmO8emq/Listeners TMPDIR=/var/folders/8v/skhgdwld40j_ymk_9yz3bdqh00000w/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.005537 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 08:32:09.483829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:32:09.484185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 08:32:09.485026) ========= ========= Total master_lag: 0.31 =========