builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0063 starttime: 1448043344.96 results: success (0) buildid: 20151120074836 builduid: fc2d1b10c4a7483eab14d1bc458a8b4b revision: 403e24f367aec778c7b3b5fbf8025bc25bde0540 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:44.962852) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:44.963258) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2015-11-20 10:15:44.963580) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005228 basedir: '/builds/slave/test' ========= master_lag: 4.76 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2015-11-20 10:15:49.732310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.732678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.755134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.755523) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005295 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.803308) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.803621) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.803990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.804260) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-20 10:15:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.35M=0.001s 2015-11-20 10:15:49 (8.35 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.994031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:49.994377) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025369 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:50.043349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 10:15:50.043691) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 403e24f367aec778c7b3b5fbf8025bc25bde0540 --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 403e24f367aec778c7b3b5fbf8025bc25bde0540 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-20 10:15:50,120 truncating revision to first 12 chars 2015-11-20 10:15:50,120 Setting DEBUG logging. 2015-11-20 10:15:50,120 attempt 1/10 2015-11-20 10:15:50,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/403e24f367ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 10:15:51,064 unpacking tar archive at: fx-team-403e24f367ae/testing/mozharness/ program finished with exit code 0 elapsedTime=1.182923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 10:15:51.240807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:51.241184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:51.252473) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:51.252726) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 10:15:51.253110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-11-20 10:15:51.253414) ========= /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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:15:51 INFO - MultiFileLogger online at 20151120 10:15:51 in /builds/slave/test 10:15:51 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 10:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:51 INFO - {'append_to_log': False, 10:15:51 INFO - 'base_work_dir': '/builds/slave/test', 10:15:51 INFO - 'blob_upload_branch': 'Fx-Team', 10:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:51 INFO - 'branch': 'Fx-Team', 10:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:51 INFO - 'config_files': ('talos/mac_config.py',), 10:15:51 INFO - 'default_actions': ('clobber', 10:15:51 INFO - 'read-buildbot-config', 10:15:51 INFO - 'download-and-extract', 10:15:51 INFO - 'populate-webroot', 10:15:51 INFO - 'create-virtualenv', 10:15:51 INFO - 'install', 10:15:51 INFO - 'run-tests'), 10:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:51 INFO - 'download_minidump_stackwalk': True, 10:15:51 INFO - 'download_symbols': 'ondemand', 10:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:51 INFO - 'installer_path': 'installer.exe', 10:15:51 INFO - 'log_level': 'info', 10:15:51 INFO - 'log_name': 'talos', 10:15:51 INFO - 'log_to_console': True, 10:15:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:51 INFO - 'opt_config_files': (), 10:15:51 INFO - 'pip_index': False, 10:15:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:51 INFO - 'cmd': ('bash', 10:15:51 INFO - '-c', 10:15:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:51 INFO - 'enabled': True, 10:15:51 INFO - 'halt_on_failure': False, 10:15:51 INFO - 'name': 'check_screen_resolution'},), 10:15:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:51 INFO - 'cmd': ('bash', 10:15:51 INFO - '-c', 10:15:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:51 INFO - 'enabled': True, 10:15:51 INFO - 'halt_on_failure': False, 10:15:51 INFO - 'name': 'check_screen_resolution'},), 10:15:51 INFO - 'run_cmd_checks_enabled': True, 10:15:51 INFO - 'sps_profile': False, 10:15:51 INFO - 'sps_profile_interval': 0, 10:15:51 INFO - 'suite': 'dromaeojs-e10s', 10:15:51 INFO - 'system_bits': '64', 10:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:51 INFO - 'title': 't-yosemite-r7-0063', 10:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:51 INFO - 'use_talos_json': True, 10:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:51 INFO - 'work_dir': 'build'} 10:15:51 INFO - ##### 10:15:51 INFO - ##### Running clobber step. 10:15:51 INFO - ##### 10:15:51 INFO - Running pre-action listener: _resource_record_pre_action 10:15:51 INFO - Running main action method: clobber 10:15:51 INFO - rmtree: /builds/slave/test/build 10:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:53 INFO - Running post-action listener: _resource_record_post_action 10:15:53 INFO - ##### 10:15:53 INFO - ##### Running read-buildbot-config step. 10:15:53 INFO - ##### 10:15:53 INFO - Running pre-action listener: _resource_record_pre_action 10:15:53 INFO - Running main action method: read_buildbot_config 10:15:53 INFO - Using buildbot properties: 10:15:53 INFO - { 10:15:53 INFO - "properties": { 10:15:53 INFO - "buildnumber": 9, 10:15:53 INFO - "product": "firefox", 10:15:53 INFO - "script_repo_revision": "production", 10:15:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:15:53 INFO - "repository": "", 10:15:53 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:15:53 INFO - "buildid": "20151120074836", 10:15:53 INFO - "slavename": "t-yosemite-r7-0063", 10:15:53 INFO - "pgo_build": "False", 10:15:53 INFO - "basedir": "/builds/slave/test", 10:15:53 INFO - "project": "", 10:15:53 INFO - "platform": "yosemite_r7", 10:15:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:15:53 INFO - "slavebuilddir": "test", 10:15:53 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:15:53 INFO - "branch": "fx-team", 10:15:53 INFO - "repo_path": "integration/fx-team", 10:15:53 INFO - "stage_platform": "macosx64", 10:15:53 INFO - "builduid": "fc2d1b10c4a7483eab14d1bc458a8b4b", 10:15:53 INFO - "revision": "403e24f367aec778c7b3b5fbf8025bc25bde0540" 10:15:53 INFO - }, 10:15:53 INFO - "sourcestamp": { 10:15:53 INFO - "repository": "", 10:15:53 INFO - "hasPatch": false, 10:15:53 INFO - "project": "", 10:15:53 INFO - "branch": "fx-team-macosx64-talos", 10:15:53 INFO - "changes": [ 10:15:53 INFO - { 10:15:53 INFO - "category": null, 10:15:53 INFO - "files": [ 10:15:53 INFO - { 10:15:53 INFO - "url": null, 10:15:53 INFO - "name": "https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:15:53 INFO - } 10:15:53 INFO - ], 10:15:53 INFO - "repository": "", 10:15:53 INFO - "rev": "403e24f367aec778c7b3b5fbf8025bc25bde0540", 10:15:53 INFO - "who": "cbook@mozilla.com", 10:15:53 INFO - "when": 1448040790, 10:15:53 INFO - "number": 6689647, 10:15:53 INFO - "comments": "Merge mozilla-central to fx-team", 10:15:53 INFO - "project": "", 10:15:53 INFO - "at": "Fri 20 Nov 2015 09:33:10", 10:15:53 INFO - "branch": "fx-team-macosx64-talos", 10:15:53 INFO - "revlink": "", 10:15:53 INFO - "properties": [ 10:15:53 INFO - [ 10:15:53 INFO - "buildid", 10:15:53 INFO - "20151120074836", 10:15:53 INFO - "Change" 10:15:53 INFO - ], 10:15:53 INFO - [ 10:15:53 INFO - "builduid", 10:15:53 INFO - "fc2d1b10c4a7483eab14d1bc458a8b4b", 10:15:53 INFO - "Change" 10:15:53 INFO - ], 10:15:53 INFO - [ 10:15:53 INFO - "pgo_build", 10:15:53 INFO - "False", 10:15:53 INFO - "Change" 10:15:53 INFO - ] 10:15:53 INFO - ], 10:15:53 INFO - "revision": "403e24f367aec778c7b3b5fbf8025bc25bde0540" 10:15:53 INFO - } 10:15:53 INFO - ], 10:15:53 INFO - "revision": "403e24f367aec778c7b3b5fbf8025bc25bde0540" 10:15:53 INFO - } 10:15:53 INFO - } 10:15:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:15:53 INFO - Running post-action listener: _resource_record_post_action 10:15:53 INFO - ##### 10:15:53 INFO - ##### Running download-and-extract step. 10:15:53 INFO - ##### 10:15:53 INFO - Running pre-action listener: _resource_record_pre_action 10:15:53 INFO - Running main action method: download_and_extract 10:15:53 INFO - mkdir: /builds/slave/test/build/tests 10:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:53 INFO - https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:15:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/test_packages.json 10:15:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/test_packages.json 10:15:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:15:54 INFO - Downloaded 1149 bytes. 10:15:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:15:54 INFO - Using the following test package requirements: 10:15:54 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:15:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:15:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'jsshell-mac.zip'], 10:15:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:15:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:15:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:15:54 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:15:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:15:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:15:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:15:54 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:15:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:15: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')]} 10:15:54 INFO - https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:15:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:15:55 INFO - Downloaded 17526116 bytes. 10:15:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 10:15:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:15:57 INFO - Return code: 0 10:15:57 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 10:15: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')]} 10:15:57 INFO - https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:15:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:15:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:15:59 INFO - Downloaded 17526116 bytes. 10:15:59 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 10:15:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:15:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:16:02 INFO - Return code: 0 10:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:02 INFO - https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:16:03 INFO - Downloaded 11130997 bytes. 10:16:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 10:16:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:16:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:16:03 INFO - Return code: 0 10:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:03 INFO - https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vE1-4m81QbaUwYCvBpXoyg/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 10:16:11 INFO - Downloaded 109415123 bytes. 10:16:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:16:11 INFO - mkdir: /builds/slave/test/properties 10:16:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:11 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:11 INFO - Contents: 10:16:11 INFO - build_url:https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:16:11 INFO - Running post-action listener: _resource_record_post_action 10:16:11 INFO - Running post-action listener: set_extra_try_arguments 10:16:11 INFO - ##### 10:16:11 INFO - ##### Running populate-webroot step. 10:16:11 INFO - ##### 10:16:11 INFO - Running pre-action listener: _resource_record_pre_action 10:16:11 INFO - Running main action method: populate_webroot 10:16:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:11 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:16:11 INFO - '../fennec_ids.txt'], 10:16:11 INFO - 'tests': ['tcheck2']}, 10:16:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:11 INFO - '--tppagecycles', 10:16:11 INFO - '7'], 10:16:11 INFO - 'tests': ['tsvgm']}}, 10:16:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:16:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:16:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:16:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'tests': ['damp', 'tps']}, 10:16:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['damp', 'tps']}, 10:16:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:16:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:11 INFO - 'other': {'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'other_l64': {'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'other_nol64': {'tests': ['a11yr', 10:16:11 INFO - 'ts_paint', 10:16:11 INFO - 'tpaint', 10:16:11 INFO - 'sessionrestore', 10:16:11 INFO - 'sessionrestore_no_auto_restore']}, 10:16:11 INFO - 'svgr': {'tests': ['tsvgx', 10:16:11 INFO - 'tsvgr_opacity', 10:16:11 INFO - 'tart', 10:16:11 INFO - 'tscrollx', 10:16:11 INFO - 'cart']}, 10:16:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['tsvgx', 10:16:11 INFO - 'tsvgr_opacity', 10:16:11 INFO - 'tart', 10:16:11 INFO - 'tscrollx', 10:16:11 INFO - 'cart']}, 10:16:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'tests': ['tp5o']}, 10:16:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'talos_options': ['--e10s'], 10:16:11 INFO - 'tests': ['tp5o']}, 10:16:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'talos_options': ['--xperf_path', 10:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:11 INFO - 'tests': ['tp5n']}, 10:16:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:11 INFO - 'talos_options': ['--e10s', 10:16:11 INFO - '--xperf_path', 10:16:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:11 INFO - 'tests': ['tp5n']}}, 10:16:11 INFO - 'talos.zip': {'path': '', 10:16:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:11 INFO - Running post-action listener: _resource_record_post_action 10:16:11 INFO - ##### 10:16:11 INFO - ##### Running create-virtualenv step. 10:16:11 INFO - ##### 10:16:11 INFO - Running pre-action listener: _resource_record_pre_action 10:16:11 INFO - Running main action method: create_virtualenv 10:16:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:11 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 10:16:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:11 INFO - Using real prefix '/tools/python27' 10:16:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:15 INFO - Installing pip.................done. 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:15 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')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:15 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 10:16:15 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 10:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:15 INFO - 'HOME': '/Users/cltbld', 10:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PAGER': '/bin/cat', 10:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:15 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - 'XPC_FLAGS': '0x0', 10:16:15 INFO - 'XPC_SERVICE_NAME': '0', 10:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 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 10:16:15 INFO - Cleaning up... 10:16:15 INFO - Return code: 0 10:16:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:16:15 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')]} 10:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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')]} 10:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:15 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:15 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 10:16:15 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 10:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:15 INFO - 'HOME': '/Users/cltbld', 10:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:15 INFO - 'LOGNAME': 'cltbld', 10:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:15 INFO - 'MOZ_NO_REMOTE': '1', 10:16:15 INFO - 'NO_EM_RESTART': '1', 10:16:15 INFO - 'PAGER': '/bin/cat', 10:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:15 INFO - 'PWD': '/builds/slave/test', 10:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:15 INFO - 'SHELL': '/bin/bash', 10:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:15 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:15 INFO - 'USER': 'cltbld', 10:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:15 INFO - 'XPC_FLAGS': '0x0', 10:16:15 INFO - 'XPC_SERVICE_NAME': '0', 10:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:15 INFO - Downloading/unpacking psutil>=0.7.1 10:16:15 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 10:16:15 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 10:16:15 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 10:16:15 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 10:16:15 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 10:16:15 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 10:16:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:18 INFO - Installing collected packages: psutil 10:16:18 INFO - Running setup.py install for psutil 10:16:18 INFO - building 'psutil._psutil_osx' extension 10:16:18 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 10:16:18 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 10:16:18 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 10:16:19 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 10:16:19 INFO - building 'psutil._psutil_posix' extension 10:16:19 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 10:16:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:16:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:16:19 INFO - ^ 10:16:19 INFO - 1 warning generated. 10:16:19 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 10:16:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:19 INFO - Successfully installed psutil 10:16:19 INFO - Cleaning up... 10:16:19 INFO - Return code: 0 10:16:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:16:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:16:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:19 INFO - 'HOME': '/Users/cltbld', 10:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:19 INFO - 'LOGNAME': 'cltbld', 10:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:19 INFO - 'MOZ_NO_REMOTE': '1', 10:16:19 INFO - 'NO_EM_RESTART': '1', 10:16:19 INFO - 'PAGER': '/bin/cat', 10:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:19 INFO - 'PWD': '/builds/slave/test', 10:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:19 INFO - 'SHELL': '/bin/bash', 10:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:19 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:19 INFO - 'USER': 'cltbld', 10:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:19 INFO - 'XPC_FLAGS': '0x0', 10:16:19 INFO - 'XPC_SERVICE_NAME': '0', 10:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:16:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:16:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:16:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:16:21 INFO - Installing collected packages: mozsystemmonitor 10:16:21 INFO - Running setup.py install for mozsystemmonitor 10:16:22 INFO - Successfully installed mozsystemmonitor 10:16:22 INFO - Cleaning up... 10:16:22 INFO - Return code: 0 10:16:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:16:22 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')]} 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:22 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')]} 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:22 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:22 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 10:16:22 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 10:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:22 INFO - 'HOME': '/Users/cltbld', 10:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:22 INFO - 'LOGNAME': 'cltbld', 10:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:22 INFO - 'MOZ_NO_REMOTE': '1', 10:16:22 INFO - 'NO_EM_RESTART': '1', 10:16:22 INFO - 'PAGER': '/bin/cat', 10:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:22 INFO - 'PWD': '/builds/slave/test', 10:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:22 INFO - 'SHELL': '/bin/bash', 10:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:22 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:22 INFO - 'USER': 'cltbld', 10:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:22 INFO - 'XPC_FLAGS': '0x0', 10:16:22 INFO - 'XPC_SERVICE_NAME': '0', 10:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:24 INFO - Downloading blobuploader-1.2.4.tar.gz 10:16:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:16:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:16:24 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 10:16:24 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 10:16:24 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 10:16:24 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 10:16:24 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 10:16:24 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 10:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:16:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:16:25 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 10:16:25 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 10:16:25 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 10:16:25 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 10:16:25 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 10:16:25 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 10:16:25 INFO - Downloading docopt-0.6.1.tar.gz 10:16:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:16:25 INFO - Installing collected packages: blobuploader, requests, docopt 10:16:25 INFO - Running setup.py install for blobuploader 10:16:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:16:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:16:25 INFO - Running setup.py install for requests 10:16:26 INFO - Running setup.py install for docopt 10:16:26 INFO - Successfully installed blobuploader requests docopt 10:16:26 INFO - Cleaning up... 10:16:26 INFO - Return code: 0 10:16:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:26 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:26 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 10:16:26 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 10:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:26 INFO - 'HOME': '/Users/cltbld', 10:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:26 INFO - 'LOGNAME': 'cltbld', 10:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:26 INFO - 'MOZ_NO_REMOTE': '1', 10:16:26 INFO - 'NO_EM_RESTART': '1', 10:16:26 INFO - 'PAGER': '/bin/cat', 10:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:26 INFO - 'PWD': '/builds/slave/test', 10:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:26 INFO - 'SHELL': '/bin/bash', 10:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:26 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:26 INFO - 'USER': 'cltbld', 10:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:26 INFO - 'XPC_FLAGS': '0x0', 10:16:26 INFO - 'XPC_SERVICE_NAME': '0', 10:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:26 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1UhtGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Z1XYXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-7yRsXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-4miB93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ryrkKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1tTfnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-jdZLLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-kkXAtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-NtzQUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0gFUoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:27 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Tq8eF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0zQgZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-zi4seG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-f0aOAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ZDDSlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XmnW7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:28 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-nK89nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:16:28 INFO - Running setup.py install for manifestparser 10:16:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:16:28 INFO - Running setup.py install for mozcrash 10:16:28 INFO - Running setup.py install for mozdebug 10:16:29 INFO - Running setup.py install for mozdevice 10:16:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Running setup.py install for mozfile 10:16:29 INFO - Running setup.py install for mozhttpd 10:16:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Running setup.py install for mozinfo 10:16:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Running setup.py install for mozInstall 10:16:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:16:29 INFO - Running setup.py install for mozleak 10:16:29 INFO - Running setup.py install for mozlog 10:16:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Running setup.py install for moznetwork 10:16:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Running setup.py install for mozprocess 10:16:30 INFO - Running setup.py install for mozprofile 10:16:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Running setup.py install for mozrunner 10:16:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:16:30 INFO - Running setup.py install for mozscreenshot 10:16:30 INFO - Running setup.py install for moztest 10:16:31 INFO - Running setup.py install for mozversion 10:16:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:16:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:16:31 INFO - Cleaning up... 10:16:31 INFO - Return code: 0 10:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:31 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:31 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 10:16:31 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 10:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:31 INFO - 'HOME': '/Users/cltbld', 10:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:31 INFO - 'LOGNAME': 'cltbld', 10:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:31 INFO - 'MOZ_NO_REMOTE': '1', 10:16:31 INFO - 'NO_EM_RESTART': '1', 10:16:31 INFO - 'PAGER': '/bin/cat', 10:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:31 INFO - 'PWD': '/builds/slave/test', 10:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:31 INFO - 'SHELL': '/bin/bash', 10:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:31 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:31 INFO - 'USER': 'cltbld', 10:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:31 INFO - 'XPC_FLAGS': '0x0', 10:16:31 INFO - 'XPC_SERVICE_NAME': '0', 10:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:16:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ttwVzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:16:31 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)) 10:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:16:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-2uLeV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:16:31 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)) 10:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:16:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-cr3FIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:16:31 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)) 10:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:16:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Lh8U5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:16:31 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)) 10:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:16:31 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-rC3dfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-RgKxXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-aCd5ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-os214E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-4v3Ee3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-vwJ6cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-c5kXTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0eaxit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-49EiMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:16:32 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)) 10:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:16:32 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XarSKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:16:33 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)) 10:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-AsThth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:16:33 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)) 10:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:16:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XDLCtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:16:33 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)) 10:16:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:16:33 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-soMIad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:16:33 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)) 10:16:33 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)) 10:16:33 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)) 10:16:33 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)) 10:16:33 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)) 10:16:33 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)) 10:16:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:35 INFO - Downloading blessings-1.5.1.tar.gz 10:16:35 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 10:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:16:35 INFO - Installing collected packages: blessings 10:16:35 INFO - Running setup.py install for blessings 10:16:35 INFO - Successfully installed blessings 10:16:35 INFO - Cleaning up... 10:16:35 INFO - Return code: 0 10:16:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:36 INFO - Reading from file tmpfile_stdout 10:16:36 INFO - Current package versions: 10:16:36 INFO - blessings == 1.5.1 10:16:36 INFO - blobuploader == 1.2.4 10:16:36 INFO - docopt == 0.6.1 10:16:36 INFO - manifestparser == 1.1 10:16:36 INFO - mozInstall == 1.12 10:16:36 INFO - mozcrash == 0.16 10:16:36 INFO - mozdebug == 0.1 10:16:36 INFO - mozdevice == 0.47 10:16:36 INFO - mozfile == 1.2 10:16:36 INFO - mozhttpd == 0.7 10:16:36 INFO - mozinfo == 0.9 10:16:36 INFO - mozleak == 0.1 10:16:36 INFO - mozlog == 3.0 10:16:36 INFO - moznetwork == 0.27 10:16:36 INFO - mozprocess == 0.22 10:16:36 INFO - mozprofile == 0.27 10:16:36 INFO - mozrunner == 6.11 10:16:36 INFO - mozscreenshot == 0.1 10:16:36 INFO - mozsystemmonitor == 0.0 10:16:36 INFO - moztest == 0.7 10:16:36 INFO - mozversion == 1.4 10:16:36 INFO - psutil == 3.1.1 10:16:36 INFO - requests == 1.2.3 10:16:36 INFO - wsgiref == 0.1.2 10:16:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:36 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 0x10b69f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b67c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc50547dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/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.5e5JMYc6rn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:36 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 10:16:36 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 10:16:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:16:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:36 INFO - 'HOME': '/Users/cltbld', 10:16:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:36 INFO - 'LOGNAME': 'cltbld', 10:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:36 INFO - 'MOZ_NO_REMOTE': '1', 10:16:36 INFO - 'NO_EM_RESTART': '1', 10:16:36 INFO - 'PAGER': '/bin/cat', 10:16:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:36 INFO - 'PWD': '/builds/slave/test', 10:16:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:36 INFO - 'SHELL': '/bin/bash', 10:16:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:16:36 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:16:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:36 INFO - 'USER': 'cltbld', 10:16:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:36 INFO - 'XPC_FLAGS': '0x0', 10:16:36 INFO - 'XPC_SERVICE_NAME': '0', 10:16:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 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)) 10:16:36 INFO - Cleaning up... 10:16:36 INFO - Return code: 0 10:16:36 INFO - Running post-action listener: _resource_record_post_action 10:16:36 INFO - Running post-action listener: _start_resource_monitoring 10:16:36 INFO - Starting resource monitoring. 10:16:36 INFO - ##### 10:16:36 INFO - ##### Running install step. 10:16:36 INFO - ##### 10:16:36 INFO - Running pre-action listener: _resource_record_pre_action 10:16:36 INFO - Running main action method: install 10:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:16:36 INFO - Reading from file tmpfile_stdout 10:16:36 INFO - Detecting whether we're running mozinstall >=1.0... 10:16:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:16:36 INFO - Reading from file tmpfile_stdout 10:16:36 INFO - Output received: 10:16:36 INFO - Usage: mozinstall [options] installer 10:16:36 INFO - Options: 10:16:36 INFO - -h, --help show this help message and exit 10:16:36 INFO - -d DEST, --destination=DEST 10:16:36 INFO - Directory to install application into. [default: 10:16:36 INFO - "/builds/slave/test"] 10:16:36 INFO - --app=APP Application being installed. [default: firefox] 10:16:36 INFO - mkdir: /builds/slave/test/build/application 10:16:36 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'] 10:16:36 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 10:17:06 INFO - Reading from file tmpfile_stdout 10:17:06 INFO - Output received: 10:17:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:17:06 INFO - Running post-action listener: _resource_record_post_action 10:17:06 INFO - ##### 10:17:06 INFO - ##### Running run-tests step. 10:17:06 INFO - ##### 10:17:06 INFO - Running pre-action listener: _resource_record_pre_action 10:17:06 INFO - Running main action method: run_tests 10:17:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:07 INFO - 2015-11-20 10:17:07.007 screenresolution[1675:7865] starting screenresolution argv=screenresolution get 10:17:07 INFO - 2015-11-20 10:17:07.010 screenresolution[1675:7865] Display 0: 1600x1200x32@60 10:17:07 INFO - 2015-11-20 10:17:07.016 screenresolution[1676:7867] starting screenresolution argv=screenresolution list 10:17:07 INFO - Available Modes on Display 0 10:17:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:07 INFO - Intel Iris: 10:17:07 INFO - Chipset Model: Intel Iris 10:17:07 INFO - Type: GPU 10:17:07 INFO - Bus: Built-In 10:17:07 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:07 INFO - Vendor: Intel (0x8086) 10:17:07 INFO - Device ID: 0x0a2e 10:17:07 INFO - Revision ID: 0x0009 10:17:07 INFO - Displays: 10:17:07 INFO - Display: 10:17:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:07 INFO - Display Serial Number: 1600x1200 60 10:17:07 INFO - Main Display: Yes 10:17:07 INFO - Mirror: Off 10:17:07 INFO - Online: Yes 10:17:07 INFO - Rotation: Supported 10:17:07 INFO - Return code: 0 10:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:17:07 INFO - Python 2.7.3 10:17:07 INFO - Return code: 0 10:17:07 INFO - grabbing minidump binary from tooltool 10:17:07 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')]} 10:17:07 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 0x10b5c39f0>, '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 0x10b322db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5b68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:17:07 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 10:17:07 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 10:17:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:17:07 INFO - Return code: 0 10:17:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:17:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:17:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:17:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:17:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:17:07 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/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost'] in /builds/slave/test/build 10:17:07 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/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --webServer localhost 10:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OjZtTXSFvu/Render', 10:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:07 INFO - 'HOME': '/Users/cltbld', 10:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:07 INFO - 'LOGNAME': 'cltbld', 10:17:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:17:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:07 INFO - 'MOZ_NO_REMOTE': '1', 10:17:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:17:07 INFO - 'NO_EM_RESTART': '1', 10:17:07 INFO - 'PAGER': '/bin/cat', 10:17:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:07 INFO - 'PWD': '/builds/slave/test', 10:17:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:07 INFO - 'SHELL': '/bin/bash', 10:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5e5JMYc6rn/Listeners', 10:17:07 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 10:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:07 INFO - 'USER': 'cltbld', 10:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:07 INFO - 'XPC_FLAGS': '0x0', 10:17:07 INFO - 'XPC_SERVICE_NAME': '0', 10:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:07 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/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost'] with output_timeout 3600 10:17:07 INFO - mozversion INFO | application_buildid: 20151120074836 10:17:07 INFO - mozversion INFO | application_changeset: 403e24f367aec778c7b3b5fbf8025bc25bde0540 10:17:07 INFO - mozversion INFO | application_display_name: Nightly 10:17:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:17:07 INFO - mozversion INFO | application_name: Firefox 10:17:07 INFO - mozversion INFO | application_remotingname: firefox 10:17:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:17:07 INFO - mozversion INFO | application_vendor: Mozilla 10:17:07 INFO - mozversion INFO | application_version: 45.0a1 10:17:07 INFO - mozversion INFO | platform_buildid: 20151120074836 10:17:07 INFO - mozversion INFO | platform_changeset: 403e24f367aec778c7b3b5fbf8025bc25bde0540 10:17:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:17:07 INFO - mozversion INFO | platform_version: 45.0a1 10:17:07 INFO - 2015-11-20 10:17:07,570 DEBUG : using testdate: 1448043427 10:17:07 INFO - 2015-11-20 10:17:07,570 DEBUG : actual date: 1448043427 10:17:07 INFO - 2015-11-20 10:17:07,914 INFO : starting webserver on 'localhost:49269' 10:17:07 INFO - 2015-11-20 10:17:07,915 INFO : Starting test suite t-yosemite-r7-0063.e 10:17:07 INFO - 2015-11-20 10:17:07,915 INFO : Starting test dromaeo_css 10:17:07 INFO - 2015-11-20 10:17:07,915 DEBUG : operating with platform_type : mac_ 10:17:07 INFO - 2015-11-20 10:17:07,916 INFO : Initialising browser for dromaeo_css test... 10:17:07 INFO - 2015-11-20 10:17:07,929 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpvvcZYy/profile http://localhost:49269/getInfo.html 10:17:10 INFO - 2015-11-20 10:17:10,590 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:10 INFO - 2015-11-20 10:17:10,590 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:10 INFO - 2015-11-20 10:17:10,590 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:17:10 INFO - 2015-11-20 10:17:10,590 DEBUG : BROWSER_OUTPUT: __metrics 10:17:11 INFO - 2015-11-20 10:17:11,164 INFO : Browser initialized. 10:17:11 INFO - 2015-11-20 10:17:11,165 INFO : Running cycle 1/1 for dromaeo_css test... 10:17:11 INFO - 2015-11-20 10:17:11,165 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpvvcZYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:17:22 INFO - 2015-11-20 10:17:22,996 DEBUG : BROWSER_OUTPUT: RSS: Main: 236056576 10:17:22 INFO - 2015-11-20 10:17:22,996 DEBUG : BROWSER_OUTPUT: 10:18:12 INFO - 2015-11-20 10:18:12,699 DEBUG : BROWSER_OUTPUT: 1448043492694 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] 10:20:23 INFO - 2015-11-20 10:20:23,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 10:20:24 INFO - 2015-11-20 10:20:24,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 253288448 10:20:24 INFO - 2015-11-20 10:20:24,967 DEBUG : BROWSER_OUTPUT: 10:23:26 INFO - 2015-11-20 10:23:26,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 10:23:27 INFO - 2015-11-20 10:23:27,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 261922816 10:23:27 INFO - 2015-11-20 10:23:27,531 DEBUG : BROWSER_OUTPUT: 10:26:29 INFO - 2015-11-20 10:26:29,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 10:26:29 INFO - 2015-11-20 10:26:29,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 264581120 10:26:29 INFO - 2015-11-20 10:26:29,859 DEBUG : BROWSER_OUTPUT: 10:29:31 INFO - 2015-11-20 10:29:31,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 10:29:32 INFO - 2015-11-20 10:29:32,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 266321920 10:29:32 INFO - 2015-11-20 10:29:32,078 DEBUG : BROWSER_OUTPUT: 10:32:34 INFO - 2015-11-20 10:32:34,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 10:32:35 INFO - 2015-11-20 10:32:35,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 268820480 10:32:35 INFO - 2015-11-20 10:32:35,052 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 10:35:37 INFO - 2015-11-20 10:35:37,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 272187392 10:35:37 INFO - 2015-11-20 10:35:37,731 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3358.143673363292;3505.3515099706574;3556.075420390701;3568.072301201687;3576.57081150262;5939.316978547463;5955.404459554043;5985.730642121104;6003.729832157553;6021.548383871216;5832.125181222808;5939.049752039675;5976.2230909981645;5981.342052374235;6047.213862197919;5324.76038578264;5381.112116500773;5392.875539881922;5394.05604019297;5421.620486565942;4598.609118224938;4941.703497790126;5481.862953426156;5502.394736578993;5531.695756733378;4216.47294088239;5248.343957005374;5350.732463376816;5408.945910540883;5462.972685136589;5355.169948657965;5365.731713414314;5366.114591092504;5390.595705322116;5401.918971215435;5315.760790764425;5318.25544423781;5340.25236466895;5382.0581398255545;5424.783008679648;5619.690916999563;5688.971555142198;5706.971465142689;5868.559858010623;6018.638881667114;6314.463270622003;6331.873362532723;6340.3659634036685;6349.619022858597;6362.045693146065;6421.101045853584;6431;6446.806595802086;6471.288158302583;6473.870522589569;5924.437178468082;6038.335783063815;6052.21321228242;6104.913929256131;6130.031268545464;6459.515536334794;6548.934510654833;6559.344065593403;6564.540482166202;6566.901496477557;6131.651934473265;6197.4732147767945;6273.466755325849;6278.905816412757;6288.308286088527;6247.750089996349;6248.625082495065;6352.301246862841;6359.3640635936035;6425.903611445832;6072.544559157993;6304.369563043659;6316.589421687576;6338.207724034496;6421.133147025185;5413.808962028347;6091.7563297467605;6230.034344676583;6312;6312.495000399957;5025.070361983045;5060.924086138711;5070.847874563769;5088;5109.540141387219;4525.886852828706;4529.207388706963;4581.862544123682;4584.541545845389;4607.838725644587;5378.924215156984;5685.516731077904;5994.910076348859;6025.367336429612;6185.969070154621;5720.170575266563;6236.282827474898;6406.391392817675;6446.967765161145;6471.385218404244;6145.446909778141;6167.321594624587;6194.194754681863;6196.442320191114;6201.441870231611;5430.212619170277;5530.142827861688;5554.055810512223;5622.718864056863;5633.6619802811965;6610.570312929644;6616.86766264672;6648.634325112165;6653.866922661617;6684;6432.742690292336;6454.322296158835;6465.3857883501;6488.253850807028;6495.1556297681;6430.742770289323;6432.58188217783;6489.805305840832;6550.574212676161;6559.180102487189;6296.118543403835;6361;6380.425761681471;6390.936090639034;6428.260750013621;5739.426057394227;6182.938170618416;6283.680427110358;6493.837654058686;6500.237399105456;6106.946079819618;6125.571219981412;6161.4146656067605;6181;6212.223472065992;6143.662098584621;6234.844128896814;6246.437820596168;6275.623462592076;6283.937160628335;4896.387951506062;5948.196993405835;6106.267247930276;6139.6009259398;6145.600535965148;5158.4583618721;5948.434898684618;6133.395871483965;6180.567360284737;6283.842903927439;5216.9739151304;6218.595791273553;6221.3156552778255;6243.8126856194385;6285.96857015712 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: |1;ext.html;539.5764325004872;557.8242853501147;575.312501560635;592.9415992453471;592.9889538337136;40492.59507404925;41321;41389;41450.58549414505;41517.58482415175;44318;45116.774416127955;45152;45212.547874521246;45312;9755.804883902318;9892.258080643944;9900.405975641448;9943.75140621483;9957.153641940407;9712.805743885117;9799.461029643368;9800.460974646392;9809.166220871235;9863.753406164831;9726.36778609388;9769.658061967833;9774;9774.16919561838;9784.608615655365;9736.26977976651;9767.706968790912;9789.314747967645;9819.558119884623;9845.45849978251;9671.323007389485;9712;9820.459874706889;9842.704718858375;9855.950720246425;40802.79598601988;40895;41066;41258.762237132934;41274;3266.411727214775;3425.3491836550975;3462.3767721810063;3464.393731097073;3514.068771775456;28764.856175719196;29641.40717185666;29780.40439191204;30223.244418889484;30391.848040759654;2820.0411859967503;2824.1859538105127;2846.08925143954;2858.3282928511785;2930.106317573139;428636;515742;516984.4150779222;517702;517904.9999999962;59623.10565341523;61021.38978610246;65024.34975650278;69525.65237173781;69753.65123174453;50346;61486.69256653688;64753;68222.31777682259;69278.96081558781;16383.180840957904;16480.752788708178;16532;16565.42021029258;16578.419755308507;12272.631821045205;12464.002879769596;12512.186707863959;12565.560205392767;12630.494780208688;20511.897440513;20539.870307133253;20645;20704.689429658567;20736.48158796042;7251.440940197883;8602.52686102258;8769.649214031495;8820.162084601952;8830.955845220862;1019.97450063749;1034.1416624201895;1041;1077.1813421799332;1140.5266814271984;30101.247468813453;30161.849190753906;30588.847055765025;30936.845315773277;31000.22499437487;1093.8359246113146;1095.5891540672249;1144.5193018932068;1150.9654710358702;1230.8642959655551;13993.30033498321;14415.351309191112;14562.563123106323;14716.632084197981;14737.778933316009;555600;557976;560911.1954440284;563726;565262;57355.42644573501;57650;57823;58223.417765821796;58424.70787646034;1428.6499807547218;1452.782082687584;1455.3087283540444;1455.4833034272892;1460.890433217513;28882.855585721936;28968.130956071353;29134.708652914047;29171;29400.85299573574;50838;50914.23628645647;51191.2321315188;51393.48606513887;51580.936762529076;531701;533036;534841;536481;536923;31386.05841824749;35236;35865;36015.459768104025;36171.63828361683;45114;45538.544614554754;45781.855453612596;46604;47384.526154738014;37752;38205.80897095497;38207;38640.22719545649;38868.80565597154;36734.081647959014;38195.29049911105;38195.42706859344;39884.401733973435;39984;37399.626003740705;37754.8112259437;37770.43344349892;38008;38131.04672383213;31812.681873181897;34126.63493460333;34325.31349372949;34516.48225276673;34623;25715.70329942942;25726.485470290863;25883.741162588132;25995;26171.214863554123 10:35:37 INFO - 2015-11-20 10:35:37,732 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.5390991710775;361.0054300402391;362.1832767110166;362.5142309305531;368.36089384917165;16735.91632041841;20335.389938301836;21547.67678484822;21584.028718707657;22151.667724984138;9627.518624068804;9728.270379721514;9787.21702263819;11868.821967670492;12058.974987126105;4855.5387238212315;5296.708681022552;5303.124984377573;5391.137418013119;6021.307549631804;5894.852628684296;5935.762569497215;5965.075413310922;5967.433093856099;5971.671558064305;3305.3719793239206;5735.369109397963;5890.823275301748;5962.403759624046;5971.716081042575;5823.097419899901;5830.242068531106;5869.207656966298;5880.500157486619;5895.174675545427;4773.856784296477;5502.98194833957;5648.152777083429;5688.943110568883;5695.45893140151;13400.128991615515;13407.195568265935;18093.819061809478;24925.875370623213;25946.22161335163;1864.794872564017;2116.0689296709397;2171.3051823416513;2334.043042352644;2346.894389752465;9412.62349506019;9931.15585175261;10014.59941602335;13165.473381064747;13846.65383365424;1777.9644407111784;1785.6250187460648;1798.0021088295991;1819.5814962558554;1822.3166312632763;100962;107752;108302;109989;111650.32524512139;8908.688195913242;8981.236594889508;11397.544098235978;11433.314001159957;11510.712232194262;13360.2651854147;13426.664333391547;13530.864691352961;13541.322933853267;13591.184528928097;8511.361647876434;8567;8602.623580227133;8620.956895215484;8700.52147131901;8744.606492707844;8768.473891566398;8774.561271936378;8834.29325653959;8862.42394244372;4369.868903932887;4402.515723270438;4414.426124603781;4432.578905004019;4461.174682683649;1549.7520396736468;1861.86036047297;1878.2768634075705;1903.6192761447767;1916.377177417345;368.9501917241192;370.0397468569059;372.4208855230143;374.8650485825101;1009.3086235928266;11076.723081923017;11503.654890353302;11656.358900260397;11849.052075833913;11887.346195959133;405.65120972765675;430.4877196136587;431.84885290148196;438.9956100439019;460.8479201863444;5609.242752228479;5722.170285308607;6066.332703402622;6134.723937422737;6155.753769849156;783147;785517;793061;796018.9582907598;804681;122396;126028;126802.36598816946;128186.71813281934;128746;465.74616833825644;468.3910915809434;473.5643208248351;476.1358134984991;478.533429905846;11132.666020019413;11197.384143872165;11274.661760147208;11291.322520648788;11327.773444530898;51508.227376590134;52313.21530177126;52346.21480677869;52501;52508.737456312476;72290;72648.54702905807;73015;74906;75329.87005194816;9542.713718588453;9642.71071867845;9691.612335506501;9889.406635601887;9955;11581.710457238636;11844.46699898524;12543.745625437383;17344.219510121824;17496.73754893703;15562.455314063953;15808.841911580737;15868.60328491797;16037;16173.75739363934;15828.841711582736;15839.52481425559;15921.601959951095;15999.68000640004;16098.678026439171;16313;16359.836401635832;16999.06505142229;17021;17123.828761712222;9871.309008369346;9947.253955953187;9978.60085596568;10055.29612927088;10220.386776793417;15715.371385144923;16132.274047667648;16208.67582648364;16771.58071048185;16885.24016419289 10:35:37 INFO - 2015-11-20 10:35:37,735 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.4061545689453;1529.3423827754061;1792.9282828686837;1887.9993603390199;1896.506908203867;6877.656117194139;7570;7664.693412263517;8692.869606955894;8732.912670873282;8283.585820708955;8434.578271086437;8520.701775437861;8521.531315777629;8554.101819308977;2395.580773364663;2404.2426635609813;2416.299273210767;2418.9395265118424;2419.7459266777;2430.0765709030543;2435.561598912195;2461.7661322174363;2462.0274991378396;2482.379405148713;2322.1640209524558;2333.18338581496;2337.322176568793;2350.788429041386;2368.384220102777;2391.294568102414;2394.724606670238;2400.579898517761;2423.09134074722;2431.5623187826186;2410.7348191698898;2438.6951631046118;2454.877256137204;2465.790407815338;2467.235157101304;8457.873131903027;8464.915350846475;8514.446560973578;8530.189631984951;8586.957065214634;5231.8168864089575;5264.947350526522;5272.446393128743;5311.415744268127;5352.116900711378;3536.098294934801;3611.223586928823;3644.97940576639;3706.499622550948;3710.9814450927843;1053.2463547183268;1075.5643964194514;1086.9347839129678;1098.1873413673904;1101.3612104979093;11240.437978101063;11301.208915375926;11336.773264534746;11336.829947550794;11339.376334301693;4723.149833030087;4758.833440829554;4773.952260477351;4774.3793306870575;4781.569658730661;9590.520473976274;9658.9034109658;9729.854052189223;9738.172255358233;9755.853662195073;5257.6056795739705;5267.762950667229;5298;5299.8410047698635;5307.230451584499;3649.5802982656805;4473.888152796141;4694.765261736899;4742.241241401359;4869.610431165569;3870.9806450967567;3892.3188442023097;3939.6454319111417;3948.993006783252;3970.662493688069;1308.9476420943056;1318.7164759576738;1322.5701646964776;1322.8280323557876;1325.787873940165;1346.5690978886857;1368.4594585139014;1373.1212024304452;1378.710470801123;1385.3835043405788;7984.560849153352;8070.83858322842;8078.636461359253;8079.111297757242;8079.394045446615;509.4447052712487;511.12342332898515;516.7209706758383;516.875949772052;516.9353830771154;6128.601640893327;6170.50635949123;6201.720922558406;6214.285357183981;6224.692814509004;10211.336263142872;10235.488225588691;10300.433476158883;10358.53386597605;10393.116585090353;9906.653267135616;10152.49237538135;10182.490875456198;10231.590736370461;10248.026437488426;6812.250652428229;7984.600769961595;8052.557109358924;8057.43597948138;8086.797830054295;7895.289423951872;7941.364690824605;7955.164707705608;7958.602069896598;7988.161243069627;9119.179273865118;9179.219766319937;9299.977002529851;9321.254299655875;9389.154976052188;8220.547869867214;9496.715098547054;9623.855642165234;9676.322657413913;9682.46746428925;5739.942600573941;6929.44564434834;6988.196357418962;7471.476996610402;7474.439417043634;6707.765228216989;8008;8013.4791238569305;8031.718889838828;8065.435419520577;6489.707963141575;7463.402927765657;7623.733169339046;7681.923180768121;7693.769186924401;7430.368418684472;7477.813054673677;7540.622968851426;7545.207753185837;7581.734639287599;7638.236176382317;7651.732189373345;7656.885146722915;7657.731979380695;7662.080550333995;6844.691988860413;6922.342377474132;6974.337437943387;6998.685059172248;7021.789346319619;7008.018877357072;7048.224695283412;7050.471214658818;7055.223925368103;7094.6097964612445 10:35:37 INFO - 2015-11-20 10:35:37,737 DEBUG : BROWSER_OUTPUT: |4;prototype.html;261.2619350335302;321.3653035255371;321.3781333120412;329.2000438933391;333.2634876922002;6005.939940600592;6441.710123044462;6808.217055038672;6984.196817366004;7031.964840175799;5328.5470734987575;6657.500687448449;6790.592564446137;6867.381935625793;6890.069840571521;5042.974785126078;5053.267276244942;5068.974655126719;5084.694918304895;5093.134167191586;5004.499550045003;5071.873203169914;5075.9746201268945;5090.720010399426;5095.802486415708;4967.428745694256;4993.775280112403;4998.450170481262;5015.5486006259425;5016.924746128811;3994.141259629194;4644.535546445362;4984.75076246188;5012.423571289312;5034.194528875399;3536.328097661462;4205.591126972437;4280.892977675552;4294.463192100988;4313.870583882489;6386.64873431961;6569.277379488252;6589.308122647149;6590.143281373391;6627.436667883236;4526.8868278292975;5940.435658612425;5966.254218222723;5988.251468566429;6001.969990150022;7360.043194384749;7365.3739432147795;7365.484416090876;7378.262173782632;7399.963000185018;4754.976225118887;4812;4813.614910807127;4817.349657796188;4826;6580.967095164541;7574.356179724675;7656.3874890008665;7804.219578042207;7887.881681774778;4900.313956046157;4910.48439913811;4917.704937703749;4925;4930.1865192243595;4969.055879382978;4997.700137991732;5016.147254966664;5027.874303142377;5029.823956161516;5833.7083145842535;5931;5971.19388882504;5975.282966044103;5980.521558275327;7414.851702965911;7417.480776345604;7420.443466740016;7427.25727427253;7451.3666338361845;1629.6414788746695;1679.1688114383458;1701.0814160353518;1735.5834599696234;1740.6779745747078;942.2791564453199;1118.4463690473267;1119.5689659480995;1127.6278827986744;1129.2490493821517;5564.221009058735;6840.828979275459;6904.896426553606;6905.723771049203;6919.515633905578;7617.124030736425;7619.885701714478;7624.42816788743;7668.194839541768;7691.50005249657;6870.793876183722;6909.689063992132;6917.9308206918295;6933.965330173317;7014.754483593049;4087.202995415865;4122.237386083584;4124.566920473307;4127.834886604563;4130.463039804806;8059.355251579859;8064.596770161468;8064.959675201587;8100;8124.22819832115;7772;8040.035195776544;8043.477173983672;8048.637811298506;8057.758267251992;8037.959810200911;8060.31487323584;8082.959585202037;8084.555349455719;8118.959405202936;7609.429292803173;7771.72798952034;7777.650005749641;7797.064352277763;7813.609319534115;7626.351760100453;7626.54240745557;7637.389008879388;7639.770806875803;7647.655855486405;6895.9656051592665;7662.578558179131;8053.516788992679;8081.393895457747;8085.312748416451;4697.154512187839;4700.858974230779;4740.952590474051;4746.2168742157155;4834.516548345137;7325;7482.139553951365;7609.961950190435;7749.147593764568;7763.301302882767;5981.312149102909;7263.382612477999;7356.816079598053;7416.6291685414435;7471.8879216812875;6046.516278697605;7408.407327413686;7430.479866409516;7447.069116360455;7498.58757768328;7071.292870712888;7221.819454513469;7232.42140628759;7238.203797582157;7289.562626242442;7400.222976587381;7409.110906691231;7410.333070023508;7430.851382972419;7455.65798156337;7058;7258.45561582894;7258.782236532912;7308.707651693872;7312.268773122645 10:35:37 INFO - 2015-11-20 10:35:37,740 DEBUG : BROWSER_OUTPUT: |5;yui.html;725.1986554856886;742.9665665045072;783.3615603283324;807.9798005049875;814.5723495165038;15050.548483545497;15313.234338283097;15433.922830385847;15470.922645386758;15494.767578486331;16723.498295051137;16943.983360998318;16951.89812662176;16970.915145424286;16999.150042497888;765.8123759678887;884.1114679746845;914.2594498456255;941.3739862991102;955.7801705607715;762.6834863531627;939.7650587353162;954.3367359685021;963.8939716631165;965.9857149992515;995.4574756757548;998.7203582996773;999.2355847776457;1013.5540362240628;1014.2139841622765;824.575343697996;979.3780949097339;997.3367710472527;1005.2058873489934;1010.3028910052041;734.7612026091488;743.5835931878112;745.2361329637112;745.8843879198732;747.8018325143842;15556.61108472286;15624.531264062096;15639.68720625581;15673.451429200037;15853.9694919831;12436.689082772913;12548.623541293775;12682.873171268353;12699.873001270054;13237;9653.324267301292;9890.505474726308;10346.12057975073;10964.232503724743;11373.943130284295;3497.615262321143;3546.556680414948;3562.8752993645357;3602.5496812898386;3607.4228123500116;78651.21348786553;79161.20838791596;79644;80569.79145312824;86721;9487.715368538955;9658.468784216795;9680.46757428334;9773.07155820196;10338.431386273827;21723.34829955104;21946.231881884058;22009.449763755714;22060;22107.447313816963;7416.814579635552;7552.093748750185;7802.843943121105;7896.249856263646;7979.16218797018;3771.076086358805;4155.8753237402925;4157.605027522381;4215.936760948588;4276.123394704078;3522.682958533744;3525.453554699026;3541.220931395089;3552;3563.002359339389;645.3127419298432;647.0326861342323;649.5096202367276;651.8728847874713;658.4666420199558;508.09812582666063;510.81099993002084;545.1876703711521;550.8815604645021;570.6519023395725;8959.552022398853;9451.858222126673;9462.337636365388;9523.333366664405;9694.175995040501;414.8465067924887;486.6301610775836;500.7821597604981;517.3868965276159;545.9372172200168;3811.515833403537;4077.55146933843;4167.708260421741;4258.701890867672;4306.2894622387585;102252.97747022583;104292.47853760835;104871;105666.4716676427;106252;89583;90010.64984025244;90169.54915225382;91332;92402.53798730964;78986.81519777208;80182.59908700536;80690.19309806945;81244.59377703191;82109;9019.143181397756;9069.546522673973;9213.631454741735;9328.347015708836;9367.297452690938;55018.72490637521;55502;55626.60933476695;55782.163267550204;56327;75730.24269757452;77034;78109.26617568357;78657;79515.60242198753;9442.575084121094;11249.887501124884;11575.942120289681;11643.41782910834;11959;10273.897261027592;12287.344886129982;12297.508099675913;12409.689757755767;12605.810912836498;11807.881921180679;11837.171398002058;11912.166148369532;12060.577879774166;12130;9500.287478439006;10267.7433064174;11456.427178641201;11925.463354148911;11927.582534611247;8323.791905202175;9604.567794449127;11229.550817967516;11748.823767643322;11770.52917883275;9600.66397676078;9715.417074975525;9808.754781130528;10077.596896124072;10081.14310283634;9222.769430764285;9661.323707340418;9690.660826871026;9753.414795112316;9858.063483969012 10:35:37 INFO - 2015-11-20 10:35:37,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:35:37 INFO - 2015-11-20 10:35:37,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,341 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: __startTimestamp1448044537725__endTimestamp 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5876.10 Median:6131.65 stddev:674.46 (11.0%) stddev-sans-first:646.96 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: Values: 3358.1 3505.4 3556.1 3568.1 3576.6 5939.3 5955.4 5985.7 6003.7 6021.5 5832.1 5939.0 5976.2 5981.3 6047.2 5324.8 5381.1 5392.9 5394.1 5421.6 4598.6 4941.7 5481.9 5502.4 5531.7 4216.5 5248.3 5350.7 5408.9 5463.0 5355.2 5365.7 5366.1 5390.6 5401.9 5315.8 5318.3 5340.3 5382.1 5424.8 5619.7 5689.0 5707.0 5868.6 6018.6 6314.5 6331.9 6340.4 6349.6 6362.0 6421.1 6431.0 6446.8 6471.3 6473.9 5924.4 6038.3 6052.2 6104.9 6130.0 6459.5 6548.9 6559.3 6564.5 6566.9 6131.7 6197.5 6273.5 6278.9 6288.3 6247.8 6248.6 6352.3 6359.4 6425.9 6072.5 6304.4 6316.6 6338.2 6421.1 5413.8 6091.8 6230.0 6312.0 6312.5 5025.1 5060.9 5070.8 5088.0 5109.5 4525.9 4529.2 4581.9 4584.5 4607.8 5378.9 5685.5 5994.9 6025.4 6186.0 5720.2 6236.3 6406.4 6447.0 6471.4 6145.4 6167.3 6194.2 6196.4 6201.4 5430.2 5530.1 5554.1 5622.7 5633.7 6610.6 6616.9 6648.6 6653.9 6684.0 6432.7 6454.3 6465.4 6488.3 6495.2 6430.7 6432.6 6489.8 6550.6 6559.2 6296.1 6361.0 6380.4 6390.9 6428.3 5739.4 6182.9 6283.7 6493.8 6500.2 6106.9 6125.6 6161.4 6181.0 6212.2 6143.7 6234.8 6246.4 6275.6 6283.9 4896.4 5948.2 6106.3 6139.6 6145.6 5158.5 5948.4 6133.4 6180.6 6283.8 5217.0 6218.6 6221.3 6243.8 6286.0 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,741 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67665.59 Median:40647.70 stddev:141765.71 (348.8%) stddev-sans-first:142073.81 10:35:37 INFO - 2015-11-20 10:35:37,743 DEBUG : BROWSER_OUTPUT: Values: 539.6 557.8 575.3 592.9 593.0 40492.6 41321.0 41389.0 41450.6 41517.6 44318.0 45116.8 45152.0 45212.5 45312.0 9755.8 9892.3 9900.4 9943.8 9957.2 9712.8 9799.5 9800.5 9809.2 9863.8 9726.4 9769.7 9774.0 9774.2 9784.6 9736.3 9767.7 9789.3 9819.6 9845.5 9671.3 9712.0 9820.5 9842.7 9856.0 40802.8 40895.0 41066.0 41258.8 41274.0 3266.4 3425.3 3462.4 3464.4 3514.1 28764.9 29641.4 29780.4 30223.2 30391.8 2820.0 2824.2 2846.1 2858.3 2930.1 428636.0 515742.0 516984.4 517702.0 517905.0 59623.1 61021.4 65024.3 69525.7 69753.7 50346.0 61486.7 64753.0 68222.3 69279.0 16383.2 16480.8 16532.0 16565.4 16578.4 12272.6 12464.0 12512.2 12565.6 12630.5 20511.9 20539.9 20645.0 20704.7 20736.5 7251.4 8602.5 8769.6 8820.2 8831.0 1020.0 1034.1 1041.0 1077.2 1140.5 30101.2 30161.8 30588.8 30936.8 31000.2 1093.8 1095.6 1144.5 1151.0 1230.9 13993.3 14415.4 14562.6 14716.6 14737.8 555600.0 557976.0 560911.2 563726.0 565262.0 57355.4 57650.0 57823.0 58223.4 58424.7 1428.6 1452.8 1455.3 1455.5 1460.9 28882.9 28968.1 29134.7 29171.0 29400.9 50838.0 50914.2 51191.2 51393.5 51580.9 531701.0 533036.0 534841.0 536481.0 536923.0 31386.1 35236.0 35865.0 36015.5 36171.6 45114.0 45538.5 45781.9 46604.0 47384.5 37752.0 38205.8 38207.0 38640.2 38868.8 36734.1 38195.3 38195.4 39884.4 39984.0 37399.6 37754.8 37770.4 38008.0 38131.0 31812.7 34126.6 34325.3 34516.5 34623.0 25715.7 25726.5 25883.7 25995.0 26171.2 10:35:37 INFO - 2015-11-20 10:35:37,743 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,743 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39527.45 Median:365.44 stddev:130647.18 (35750.9%) stddev-sans-first:130980.57 10:35:37 INFO - 2015-11-20 10:35:37,743 DEBUG : BROWSER_OUTPUT: Values: 354.5 361.0 362.2 362.5 368.4 16735.9 20335.4 21547.7 21584.0 22151.7 9627.5 9728.3 9787.2 11868.8 12059.0 4855.5 5296.7 5303.1 5391.1 6021.3 5894.9 5935.8 5965.1 5967.4 5971.7 3305.4 5735.4 5890.8 5962.4 5971.7 5823.1 5830.2 5869.2 5880.5 5895.2 4773.9 5503.0 5648.2 5688.9 5695.5 13400.1 13407.2 18093.8 24925.9 25946.2 1864.8 2116.1 2171.3 2334.0 2346.9 9412.6 9931.2 10014.6 13165.5 13846.7 1778.0 1785.6 1798.0 1819.6 1822.3 100962.0 107752.0 108302.0 109989.0 111650.3 8908.7 8981.2 11397.5 11433.3 11510.7 13360.3 13426.7 13530.9 13541.3 13591.2 8511.4 8567.0 8602.6 8621.0 8700.5 8744.6 8768.5 8774.6 8834.3 8862.4 4369.9 4402.5 4414.4 4432.6 4461.2 1549.8 1861.9 1878.3 1903.6 1916.4 369.0 370.0 372.4 374.9 1009.3 11076.7 11503.7 11656.4 11849.1 11887.3 405.7 430.5 431.8 439.0 460.8 5609.2 5722.2 6066.3 6134.7 6155.8 783147.0 785517.0 793061.0 796019.0 804681.0 122396.0 126028.0 126802.4 128186.7 128746.0 465.7 468.4 473.6 476.1 478.5 11132.7 11197.4 11274.7 11291.3 11327.8 51508.2 52313.2 52346.2 52501.0 52508.7 72290.0 72648.5 73015.0 74906.0 75329.9 9542.7 9642.7 9691.6 9889.4 9955.0 11581.7 11844.5 12543.7 17344.2 17496.7 15562.5 15808.8 15868.6 16037.0 16173.8 15828.8 15839.5 15921.6 15999.7 16098.7 16313.0 16359.8 16999.1 17021.0 17123.8 9871.3 9947.3 9978.6 10055.3 10220.4 15715.4 16132.3 16208.7 16771.6 16885.2 10:35:37 INFO - 2015-11-20 10:35:37,743 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,744 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5878.74 Median:5303.54 stddev:3064.73 (57.8%) stddev-sans-first:3055.68 10:35:37 INFO - 2015-11-20 10:35:37,745 DEBUG : BROWSER_OUTPUT: Values: 1503.4 1529.3 1792.9 1888.0 1896.5 6877.7 7570.0 7664.7 8692.9 8732.9 8283.6 8434.6 8520.7 8521.5 8554.1 2395.6 2404.2 2416.3 2418.9 2419.7 2430.1 2435.6 2461.8 2462.0 2482.4 2322.2 2333.2 2337.3 2350.8 2368.4 2391.3 2394.7 2400.6 2423.1 2431.6 2410.7 2438.7 2454.9 2465.8 2467.2 8457.9 8464.9 8514.4 8530.2 8587.0 5231.8 5264.9 5272.4 5311.4 5352.1 3536.1 3611.2 3645.0 3706.5 3711.0 1053.2 1075.6 1086.9 1098.2 1101.4 11240.4 11301.2 11336.8 11336.8 11339.4 4723.1 4758.8 4774.0 4774.4 4781.6 9590.5 9658.9 9729.9 9738.2 9755.9 5257.6 5267.8 5298.0 5299.8 5307.2 3649.6 4473.9 4694.8 4742.2 4869.6 3871.0 3892.3 3939.6 3949.0 3970.7 1308.9 1318.7 1322.6 1322.8 1325.8 1346.6 1368.5 1373.1 1378.7 1385.4 7984.6 8070.8 8078.6 8079.1 8079.4 509.4 511.1 516.7 516.9 516.9 6128.6 6170.5 6201.7 6214.3 6224.7 10211.3 10235.5 10300.4 10358.5 10393.1 9906.7 10152.5 10182.5 10231.6 10248.0 6812.3 7984.6 8052.6 8057.4 8086.8 7895.3 7941.4 7955.2 7958.6 7988.2 9119.2 9179.2 9300.0 9321.3 9389.2 8220.5 9496.7 9623.9 9676.3 9682.5 5739.9 6929.4 6988.2 7471.5 7474.4 6707.8 8008.0 8013.5 8031.7 8065.4 6489.7 7463.4 7623.7 7681.9 7693.8 7430.4 7477.8 7540.6 7545.2 7581.7 7638.2 7651.7 7656.9 7657.7 7662.1 6844.7 6922.3 6974.3 6998.7 7021.8 7008.0 7048.2 7050.5 7055.2 7094.6 10:35:37 INFO - 2015-11-20 10:35:37,745 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,745 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6015.05 Median:6869.09 stddev:1955.07 (28.5%) stddev-sans-first:1912.26 10:35:37 INFO - 2015-11-20 10:35:37,746 DEBUG : BROWSER_OUTPUT: Values: 261.3 321.4 321.4 329.2 333.3 6005.9 6441.7 6808.2 6984.2 7032.0 5328.5 6657.5 6790.6 6867.4 6890.1 5043.0 5053.3 5069.0 5084.7 5093.1 5004.5 5071.9 5076.0 5090.7 5095.8 4967.4 4993.8 4998.5 5015.5 5016.9 3994.1 4644.5 4984.8 5012.4 5034.2 3536.3 4205.6 4280.9 4294.5 4313.9 6386.6 6569.3 6589.3 6590.1 6627.4 4526.9 5940.4 5966.3 5988.3 6002.0 7360.0 7365.4 7365.5 7378.3 7400.0 4755.0 4812.0 4813.6 4817.3 4826.0 6581.0 7574.4 7656.4 7804.2 7887.9 4900.3 4910.5 4917.7 4925.0 4930.2 4969.1 4997.7 5016.1 5027.9 5029.8 5833.7 5931.0 5971.2 5975.3 5980.5 7414.9 7417.5 7420.4 7427.3 7451.4 1629.6 1679.2 1701.1 1735.6 1740.7 942.3 1118.4 1119.6 1127.6 1129.2 5564.2 6840.8 6904.9 6905.7 6919.5 7617.1 7619.9 7624.4 7668.2 7691.5 6870.8 6909.7 6917.9 6934.0 7014.8 4087.2 4122.2 4124.6 4127.8 4130.5 8059.4 8064.6 8065.0 8100.0 8124.2 7772.0 8040.0 8043.5 8048.6 8057.8 8038.0 8060.3 8083.0 8084.6 8119.0 7609.4 7771.7 7777.7 7797.1 7813.6 7626.4 7626.5 7637.4 7639.8 7647.7 6896.0 7662.6 8053.5 8081.4 8085.3 4697.2 4700.9 4741.0 4746.2 4834.5 7325.0 7482.1 7610.0 7749.1 7763.3 5981.3 7263.4 7356.8 7416.6 7471.9 6046.5 7408.4 7430.5 7447.1 7498.6 7071.3 7221.8 7232.4 7238.2 7289.6 7400.2 7409.1 7410.3 7430.9 7455.7 7058.0 7258.5 7258.8 7308.7 7312.3 10:35:37 INFO - 2015-11-20 10:35:37,746 DEBUG : BROWSER_OUTPUT: 10:35:37 INFO - 2015-11-20 10:35:37,746 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19947.05 Median:55260.36 stddev:28867.50 (52.2%) stddev-sans-first:28912.40 10:35:37 INFO - 2015-11-20 10:35:37,748 DEBUG : BROWSER_OUTPUT: Values: 725.2 743.0 783.4 808.0 814.6 15050.5 15313.2 15433.9 15470.9 15494.8 16723.5 16944.0 16951.9 16970.9 16999.2 765.8 884.1 914.3 941.4 955.8 762.7 939.8 954.3 963.9 966.0 995.5 998.7 999.2 1013.6 1014.2 824.6 979.4 997.3 1005.2 1010.3 734.8 743.6 745.2 745.9 747.8 15556.6 15624.5 15639.7 15673.5 15854.0 12436.7 12548.6 12682.9 12699.9 13237.0 9653.3 9890.5 10346.1 10964.2 11373.9 3497.6 3546.6 3562.9 3602.5 3607.4 78651.2 79161.2 79644.0 80569.8 86721.0 9487.7 9658.5 9680.5 9773.1 10338.4 21723.3 21946.2 22009.4 22060.0 22107.4 7416.8 7552.1 7802.8 7896.2 7979.2 3771.1 4155.9 4157.6 4215.9 4276.1 3522.7 3525.5 3541.2 3552.0 3563.0 645.3 647.0 649.5 651.9 658.5 508.1 510.8 545.2 550.9 570.7 8959.6 9451.9 9462.3 9523.3 9694.2 414.8 486.6 500.8 517.4 545.9 3811.5 4077.6 4167.7 4258.7 4306.3 102253.0 104292.5 104871.0 105666.5 106252.0 89583.0 90010.6 90169.5 91332.0 92402.5 78986.8 80182.6 80690.2 81244.6 82109.0 9019.1 9069.5 9213.6 9328.3 9367.3 55018.7 55502.0 55626.6 55782.2 56327.0 75730.2 77034.0 78109.3 78657.0 79515.6 9442.6 11249.9 11575.9 11643.4 11959.0 10273.9 12287.3 12297.5 12409.7 12605.8 11807.9 11837.2 11912.2 12060.6 12130.0 9500.3 10267.7 11456.4 11925.5 11927.6 8323.8 9604.6 11229.6 11748.8 11770.5 9600.7 9715.4 9808.8 10077.6 10081.1 9222.8 9661.3 9690.7 9753.4 9858.1 10:35:37 INFO - 2015-11-20 10:35:37,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:35:37 INFO - 2015-11-20 10:35:37,748 DEBUG : BROWSER_OUTPUT: 10:35:38 INFO - 2015-11-20 10:35:38,148 INFO : Browser exited with error code: 0 10:35:38 INFO - 2015-11-20 10:35:38,172 INFO : Completed test dromaeo_css (00:18:30) 10:35:38 INFO - 2015-11-20 10:35:38,173 INFO : Starting test kraken 10:35:38 INFO - 2015-11-20 10:35:38,173 DEBUG : operating with platform_type : mac_ 10:35:38 INFO - 2015-11-20 10:35:38,173 INFO : Initialising browser for kraken test... 10:35:38 INFO - 2015-11-20 10:35:38,184 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpZVq5ta/profile http://localhost:49269/getInfo.html 10:35:40 INFO - 2015-11-20 10:35:40,973 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:35:40 INFO - 2015-11-20 10:35:40,973 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:35:40 INFO - 2015-11-20 10:35:40,973 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:35:40 INFO - 2015-11-20 10:35:40,973 DEBUG : BROWSER_OUTPUT: __metrics 10:35:41 INFO - 2015-11-20 10:35:41,567 INFO : Browser initialized. 10:35:41 INFO - 2015-11-20 10:35:41,568 INFO : Running cycle 1/1 for kraken test... 10:35:41 INFO - 2015-11-20 10:35:41,568 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpZVq5ta/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:35:53 INFO - 2015-11-20 10:35:53,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 236392448 10:35:53 INFO - 2015-11-20 10:35:53,511 DEBUG : BROWSER_OUTPUT: 10:35:56 INFO - 2015-11-20 10:35:56,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:56 INFO - 2015-11-20 10:35:56,654 DEBUG : BROWSER_OUTPUT: RSS: Main: 248918016 10:35:56 INFO - 2015-11-20 10:35:56,654 DEBUG : BROWSER_OUTPUT: 10:35:59 INFO - 2015-11-20 10:35:59,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 10:35:59 INFO - 2015-11-20 10:35:59,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 258289664 10:35:59 INFO - 2015-11-20 10:35:59,895 DEBUG : BROWSER_OUTPUT: 10:36:03 INFO - 2015-11-20 10:36:03,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 10:36:03 INFO - 2015-11-20 10:36:03,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 259772416 10:36:03 INFO - 2015-11-20 10:36:03,893 DEBUG : BROWSER_OUTPUT: 10:36:05 INFO - 2015-11-20 10:36:05,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 10:36:06 INFO - 2015-11-20 10:36:06,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 264183808 10:36:06 INFO - 2015-11-20 10:36:06,545 DEBUG : BROWSER_OUTPUT: 10:36:08 INFO - 2015-11-20 10:36:08,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:36:09 INFO - 2015-11-20 10:36:09,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 263884800 10:36:09 INFO - 2015-11-20 10:36:09,030 DEBUG : BROWSER_OUTPUT: 10:36:11 INFO - 2015-11-20 10:36:11,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:12 INFO - 2015-11-20 10:36:12,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 265383936 10:36:12 INFO - 2015-11-20 10:36:12,362 DEBUG : BROWSER_OUTPUT: 10:36:15 INFO - 2015-11-20 10:36:15,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:15 INFO - 2015-11-20 10:36:15,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 265412608 10:36:15 INFO - 2015-11-20 10:36:15,667 DEBUG : BROWSER_OUTPUT: 10:36:18 INFO - 2015-11-20 10:36:18,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 10:36:19 INFO - 2015-11-20 10:36:19,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 263663616 10:36:19 INFO - 2015-11-20 10:36:19,016 DEBUG : BROWSER_OUTPUT: 10:36:20 INFO - 2015-11-20 10:36:20,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:36:21 INFO - 2015-11-20 10:36:21,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 263577600 10:36:21 INFO - 2015-11-20 10:36:21,122 DEBUG : BROWSER_OUTPUT: 10:36:22 INFO - 2015-11-20 10:36:22,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:36:23 INFO - 2015-11-20 10:36:23,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 264536064 10:36:23 INFO - 2015-11-20 10:36:23,509 DEBUG : BROWSER_OUTPUT: 10:36:25 INFO - 2015-11-20 10:36:25,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:36:26 INFO - 2015-11-20 10:36:26,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 264785920 10:36:26 INFO - 2015-11-20 10:36:26,099 DEBUG : BROWSER_OUTPUT: 10:36:28 INFO - 2015-11-20 10:36:28,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:36:29 INFO - 2015-11-20 10:36:29,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 264384512 10:36:29 INFO - 2015-11-20 10:36:29,230 DEBUG : BROWSER_OUTPUT: 10:36:31 INFO - 2015-11-20 10:36:31,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:36:32 INFO - 2015-11-20 10:36:32,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 264523776 10:36:32 INFO - 2015-11-20 10:36:32,248 DEBUG : BROWSER_OUTPUT: 10:36:33 INFO - 2015-11-20 10:36:33,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 10:36:34 INFO - 2015-11-20 10:36:34,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 265437184 10:36:34 INFO - 2015-11-20 10:36:34,100 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,101 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;106;112;113;114;128;115;113;116;115 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;123;144;157;118;130;164;156;189;144 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;189;191;193;240;276;194;222;281;211 10:36:34 INFO - 2015-11-20 10:36:34,102 DEBUG : BROWSER_OUTPUT: |3;audio-fft;55;67;77;94;95;82;84;84;87;122 10:36:34 INFO - 2015-11-20 10:36:34,103 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;75;78;104;74;79;75;108;76;76;105 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;95;134;89;88;89;90;89;92;90;79 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;97;96;96;95;96;95;96;95;97;96 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;91;93;91;95;92;92;92;91;135;90 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;59;60;58;60;62;69;59;58 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;67;68;68;68;70;70 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;81;84;84;82;84;83;82;82 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;124;126;130;132;129;134;128;118;146 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;139;136;138;142;139;138;135;140 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;65;69;67;66;64;66;67;65 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,822 10:36:34 INFO - 2015-11-20 10:36:34,104 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:36:34 INFO - 2015-11-20 10:36:34,105 DEBUG : BROWSER_OUTPUT: __startTimestamp1448044594101__endTimestamp 10:36:34 INFO - 2015-11-20 10:36:34,105 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,106 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:5.46 (4.7%) stddev-sans-first:5.79 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: Values: 115.0 106.0 112.0 113.0 114.0 128.0 115.0 113.0 116.0 115.0 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:150.00 stddev:20.99 (14.0%) stddev-sans-first:22.24 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: Values: 144.0 123.0 144.0 157.0 118.0 130.0 164.0 156.0 189.0 144.0 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:218.70 Median:216.50 stddev:35.64 (16.5%) stddev-sans-first:36.26 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: Values: 190.0 189.0 191.0 193.0 240.0 276.0 194.0 222.0 281.0 211.0 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,107 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.70 Median:84.00 stddev:17.80 (21.2%) stddev-sans-first:15.30 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: Values: 55.0 67.0 77.0 94.0 95.0 82.0 84.0 84.0 87.0 122.0 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:85.00 Median:75.50 stddev:14.37 (19.0%) stddev-sans-first:14.78 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: Values: 75.0 78.0 104.0 74.0 79.0 75.0 108.0 76.0 76.0 105.0 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:89.50 stddev:14.80 (16.5%) stddev-sans-first:15.68 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: Values: 95.0 134.0 89.0 88.0 89.0 90.0 89.0 92.0 90.0 79.0 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 97.0 96.0 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:92.00 stddev:13.70 (14.9%) stddev-sans-first:14.40 10:36:34 INFO - 2015-11-20 10:36:34,108 DEBUG : BROWSER_OUTPUT: Values: 91.0 93.0 91.0 95.0 92.0 92.0 92.0 91.0 135.0 90.0 10:36:34 INFO - 2015-11-20 10:36:34,109 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,109 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.50 stddev:3.41 (5.7%) stddev-sans-first:3.60 10:36:34 INFO - 2015-11-20 10:36:34,109 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 59.0 60.0 58.0 60.0 62.0 69.0 59.0 58.0 10:36:34 INFO - 2015-11-20 10:36:34,109 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,109 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 67.0 68.0 68.0 68.0 70.0 70.0 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.70 (2.0%) stddev-sans-first:1.79 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 81.0 84.0 84.0 82.0 84.0 83.0 82.0 82.0 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,110 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:131.00 stddev:7.35 (5.6%) stddev-sans-first:7.71 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: Values: 133.0 124.0 126.0 130.0 132.0 129.0 134.0 128.0 118.0 146.0 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:139.00 stddev:2.00 (1.4%) stddev-sans-first:2.07 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 139.0 136.0 138.0 142.0 139.0 138.0 135.0 140.0 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.52 (2.3%) stddev-sans-first:1.45 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 65.0 69.0 67.0 66.0 64.0 66.0 67.0 65.0 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:36:34 INFO - 2015-11-20 10:36:34,111 DEBUG : BROWSER_OUTPUT: 10:36:34 INFO - 2015-11-20 10:36:34,716 INFO : Browser exited with error code: 0 10:36:34 INFO - 2015-11-20 10:36:34,760 INFO : Completed test kraken (00:00:56) 10:36:34 INFO - 2015-11-20 10:36:34,760 INFO : Starting test v8_7 10:36:34 INFO - 2015-11-20 10:36:34,761 DEBUG : operating with platform_type : mac_ 10:36:34 INFO - 2015-11-20 10:36:34,761 INFO : Initialising browser for v8_7 test... 10:36:34 INFO - 2015-11-20 10:36:34,772 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpUA914C/profile http://localhost:49269/getInfo.html 10:36:37 INFO - 2015-11-20 10:36:37,609 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:36:37 INFO - 2015-11-20 10:36:37,609 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:36:37 INFO - 2015-11-20 10:36:37,609 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:36:37 INFO - 2015-11-20 10:36:37,609 DEBUG : BROWSER_OUTPUT: __metrics 10:36:38 INFO - 2015-11-20 10:36:38,211 INFO : Browser initialized. 10:36:38 INFO - 2015-11-20 10:36:38,211 INFO : Running cycle 1/1 for v8_7 test... 10:36:38 INFO - 2015-11-20 10:36:38,212 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpUA914C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:36:50 INFO - 2015-11-20 10:36:50,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 236838912 10:36:50 INFO - 2015-11-20 10:36:50,198 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 247414784 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: |0;Richards;147.88524105294292 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;156.86274509803923 10:37:11 INFO - 2015-11-20 10:37:11,825 DEBUG : BROWSER_OUTPUT: |2;Encrypt;302.11480362537765 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4799.043062200957 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |4;RayTrace;958.7727708533077 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |5;Earley;736.9196757553427 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |6;Boyer;12670.886075949367 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |8;Splay;603.9783001808319 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1448044631819__endTimestamp 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:37:11 INFO - 2015-11-20 10:37:11,826 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.89 Median:147.89 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: Values: 147.9 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:156.86 Median:156.86 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: Values: 156.9 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:302.11 Median:302.11 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: Values: 302.1 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4799.04 Median:4799.04 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: Values: 4799.0 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,827 DEBUG : BROWSER_OUTPUT: Values: 958.8 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.92 Median:736.92 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: Values: 736.9 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12670.89 Median:12670.89 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: Values: 12670.9 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: Values: 26368.4 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.98 Median:603.98 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: Values: 604.0 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 10:37:11 INFO - 2015-11-20 10:37:11,828 DEBUG : BROWSER_OUTPUT: Values: 4533.9 10:37:11 INFO - 2015-11-20 10:37:11,829 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:37:11 INFO - 2015-11-20 10:37:11,829 DEBUG : BROWSER_OUTPUT: 10:37:12 INFO - 2015-11-20 10:37:12,456 INFO : Browser exited with error code: 0 10:37:12 INFO - 2015-11-20 10:37:12,473 INFO : Completed test v8_7 (00:00:37) 10:37:12 INFO - 2015-11-20 10:37:12,931 INFO : Completed test suite (00:20:05) 10:37:12 INFO - 2015-11-20 10:37:12,931 DEBUG : Working with test: dromaeo_css 10:37:12 INFO - 2015-11-20 10:37:12,932 DEBUG : Generating results file: dromaeo_css 10:37:12 INFO - 2015-11-20 10:37:12,932 DEBUG : Working with test: kraken 10:37:12 INFO - 2015-11-20 10:37:12,932 DEBUG : Generating results file: kraken 10:37:12 INFO - 2015-11-20 10:37:12,933 INFO : javascript benchmark 10:37:12 INFO - 2015-11-20 10:37:12,933 DEBUG : Working with test: v8_7 10:37:12 INFO - 2015-11-20 10:37:12,933 DEBUG : Generating results file: v8_7 10:37:12 INFO - 2015-11-20 10:37:12,933 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:37:13 INFO - 2015-11-20 10:37:13,311 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 10:37:13 INFO - 2015-11-20 10:37:13,311 DEBUG : process_Request line: dromaeo_css 7587.25 graph.html#tests=[[72,64,61]] 10:37:13 INFO - 2015-11-20 10:37:13,311 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:37:13 INFO - 2015-11-20 10:37:13,338 DEBUG : process_Request line: kraken 1481.20 graph.html#tests=[[232,64,61]] 10:37:13 INFO - 2015-11-20 10:37:13,338 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:37:13 INFO - 2015-11-20 10:37:13,365 DEBUG : process_Request line: v8_7 22170.26 graph.html#tests=[[230,64,61]] 10:37:13 INFO - 2015-11-20 10:37:13,365 INFO : javascript benchmark 10:37:13 INFO - 2015-11-20 10:37:13,367 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3358.143673363292, 3505.3515099706574, 3556.075420390701, 3568.072301201687, 3576.57081150262, 5939.316978547463, 5955.404459554043, 5985.730642121104, 6003.729832157553, 6021.548383871216, 5832.125181222808, 5939.049752039675, 5976.2230909981645, 5981.342052374235, 6047.213862197919, 5324.76038578264, 5381.112116500773, 5392.875539881922, 5394.05604019297, 5421.620486565942, 4598.609118224938, 4941.703497790126, 5481.862953426156, 5502.394736578993, 5531.695756733378, 4216.47294088239, 5248.343957005374, 5350.732463376816, 5408.945910540883, 5462.972685136589, 5355.169948657965, 5365.731713414314, 5366.114591092504, 5390.595705322116, 5401.918971215435, 5315.760790764425, 5318.25544423781, 5340.25236466895, 5382.0581398255545, 5424.783008679648, 5619.690916999563, 5688.971555142198, 5706.971465142689, 5868.559858010623, 6018.638881667114, 6314.463270622003, 6331.873362532723, 6340.3659634036685, 6349.619022858597, 6362.045693146065, 6421.101045853584, 6431.0, 6446.806595802086, 6471.288158302583, 6473.870522589569, 5924.437178468082, 6038.335783063815, 6052.21321228242, 6104.913929256131, 6130.031268545464, 6459.515536334794, 6548.934510654833, 6559.344065593403, 6564.540482166202, 6566.901496477557, 6131.651934473265, 6197.4732147767945, 6273.466755325849, 6278.905816412757, 6288.308286088527, 6247.750089996349, 6248.625082495065, 6352.301246862841, 6359.3640635936035, 6425.903611445832, 6072.544559157993, 6304.369563043659, 6316.589421687576, 6338.207724034496, 6421.133147025185, 5413.808962028347, 6091.7563297467605, 6230.034344676583, 6312.0, 6312.495000399957, 5025.070361983045, 5060.924086138711, 5070.847874563769, 5088.0, 5109.540141387219, 4525.886852828706, 4529.207388706963, 4581.862544123682, 4584.541545845389, 4607.838725644587, 5378.924215156984, 5685.516731077904, 5994.910076348859, 6025.367336429612, 6185.969070154621, 5720.170575266563, 6236.282827474898, 6406.391392817675, 6446.967765161145, 6471.385218404244, 6145.446909778141, 6167.321594624587, 6194.194754681863, 6196.442320191114, 6201.441870231611, 5430.212619170277, 5530.142827861688, 5554.055810512223, 5622.718864056863, 5633.6619802811965, 6610.570312929644, 6616.86766264672, 6648.634325112165, 6653.866922661617, 6684.0, 6432.742690292336, 6454.322296158835, 6465.3857883501, 6488.253850807028, 6495.1556297681, 6430.742770289323, 6432.58188217783, 6489.805305840832, 6550.574212676161, 6559.180102487189, 6296.118543403835, 6361.0, 6380.425761681471, 6390.936090639034, 6428.260750013621, 5739.426057394227, 6182.938170618416, 6283.680427110358, 6493.837654058686, 6500.237399105456, 6106.946079819618, 6125.571219981412, 6161.4146656067605, 6181.0, 6212.223472065992, 6143.662098584621, 6234.844128896814, 6246.437820596168, 6275.623462592076, 6283.937160628335, 4896.387951506062, 5948.196993405835, 6106.267247930276, 6139.6009259398, 6145.600535965148, 5158.4583618721, 5948.434898684618, 6133.395871483965, 6180.567360284737, 6283.842903927439, 5216.9739151304, 6218.595791273553, 6221.3156552778255, 6243.8126856194385, 6285.96857015712], "unit": "ms", "name": "dojo.html", "value": 5834.924321590347}, {"lowerIsBetter": false, "replicates": [539.5764325004872, 557.8242853501147, 575.312501560635, 592.9415992453471, 592.9889538337136, 40492.59507404925, 41321.0, 41389.0, 41450.58549414505, 41517.58482415175, 44318.0, 45116.774416127955, 45152.0, 45212.547874521246, 45312.0, 9755.804883902318, 9892.258080643944, 9900.405975641448, 9943.75140621483, 9957.153641940407, 9712.805743885117, 9799.461029643368, 9800.460974646392, 9809.166220871235, 9863.753406164831, 9726.36778609388, 9769.658061967833, 9774.0, 9774.16919561838, 9784.608615655365, 9736.26977976651, 9767.706968790912, 9789.314747967645, 9819.558119884623, 9845.45849978251, 9671.323007389485, 9712.0, 9820.459874706889, 9842.704718858375, 9855.950720246425, 40802.79598601988, 40895.0, 41066.0, 41258.762237132934, 41274.0, 3266.411727214775, 3425.3491836550975, 3462.3767721810063, 3464.393731097073, 3514.068771775456, 28764.856175719196, 29641.40717185666, 29780.40439191204, 30223.244418889484, 30391.848040759654, 2820.0411859967503, 2824.1859538105127, 2846.08925143954, 2858.3282928511785, 2930.106317573139, 428636.0, 515742.0, 516984.4150779222, 517702.0, 517904.9999999962, 59623.10565341523, 61021.38978610246, 65024.34975650278, 69525.65237173781, 69753.65123174453, 50346.0, 61486.69256653688, 64753.0, 68222.31777682259, 69278.96081558781, 16383.180840957904, 16480.752788708178, 16532.0, 16565.42021029258, 16578.419755308507, 12272.631821045205, 12464.002879769596, 12512.186707863959, 12565.560205392767, 12630.494780208688, 20511.897440513, 20539.870307133253, 20645.0, 20704.689429658567, 20736.48158796042, 7251.440940197883, 8602.52686102258, 8769.649214031495, 8820.162084601952, 8830.955845220862, 1019.97450063749, 1034.1416624201895, 1041.0, 1077.1813421799332, 1140.5266814271984, 30101.247468813453, 30161.849190753906, 30588.847055765025, 30936.845315773277, 31000.22499437487, 1093.8359246113146, 1095.5891540672249, 1144.5193018932068, 1150.9654710358702, 1230.8642959655551, 13993.30033498321, 14415.351309191112, 14562.563123106323, 14716.632084197981, 14737.778933316009, 555600.0, 557976.0, 560911.1954440284, 563726.0, 565262.0, 57355.42644573501, 57650.0, 57823.0, 58223.417765821796, 58424.70787646034, 1428.6499807547218, 1452.782082687584, 1455.3087283540444, 1455.4833034272892, 1460.890433217513, 28882.855585721936, 28968.130956071353, 29134.708652914047, 29171.0, 29400.85299573574, 50838.0, 50914.23628645647, 51191.2321315188, 51393.48606513887, 51580.936762529076, 531701.0, 533036.0, 534841.0, 536481.0, 536923.0, 31386.05841824749, 35236.0, 35865.0, 36015.459768104025, 36171.63828361683, 45114.0, 45538.544614554754, 45781.855453612596, 46604.0, 47384.526154738014, 37752.0, 38205.80897095497, 38207.0, 38640.22719545649, 38868.80565597154, 36734.081647959014, 38195.29049911105, 38195.42706859344, 39884.401733973435, 39984.0, 37399.626003740705, 37754.8112259437, 37770.43344349892, 38008.0, 38131.04672383213, 31812.681873181897, 34126.63493460333, 34325.31349372949, 34516.48225276673, 34623.0, 25715.70329942942, 25726.485470290863, 25883.741162588132, 25995.0, 26171.214863554123], "unit": "ms", "name": "ext.html", "value": 20378.61517717938}, {"lowerIsBetter": false, "replicates": [354.5390991710775, 361.0054300402391, 362.1832767110166, 362.5142309305531, 368.36089384917165, 16735.91632041841, 20335.389938301836, 21547.67678484822, 21584.028718707657, 22151.667724984138, 9627.518624068804, 9728.270379721514, 9787.21702263819, 11868.821967670492, 12058.974987126105, 4855.5387238212315, 5296.708681022552, 5303.124984377573, 5391.137418013119, 6021.307549631804, 5894.852628684296, 5935.762569497215, 5965.075413310922, 5967.433093856099, 5971.671558064305, 3305.3719793239206, 5735.369109397963, 5890.823275301748, 5962.403759624046, 5971.716081042575, 5823.097419899901, 5830.242068531106, 5869.207656966298, 5880.500157486619, 5895.174675545427, 4773.856784296477, 5502.98194833957, 5648.152777083429, 5688.943110568883, 5695.45893140151, 13400.128991615515, 13407.195568265935, 18093.819061809478, 24925.875370623213, 25946.22161335163, 1864.794872564017, 2116.0689296709397, 2171.3051823416513, 2334.043042352644, 2346.894389752465, 9412.62349506019, 9931.15585175261, 10014.59941602335, 13165.473381064747, 13846.65383365424, 1777.9644407111784, 1785.6250187460648, 1798.0021088295991, 1819.5814962558554, 1822.3166312632763, 100962.0, 107752.0, 108302.0, 109989.0, 111650.32524512139, 8908.688195913242, 8981.236594889508, 11397.544098235978, 11433.314001159957, 11510.712232194262, 13360.2651854147, 13426.664333391547, 13530.864691352961, 13541.322933853267, 13591.184528928097, 8511.361647876434, 8567.0, 8602.623580227133, 8620.956895215484, 8700.52147131901, 8744.606492707844, 8768.473891566398, 8774.561271936378, 8834.29325653959, 8862.42394244372, 4369.868903932887, 4402.515723270438, 4414.426124603781, 4432.578905004019, 4461.174682683649, 1549.7520396736468, 1861.86036047297, 1878.2768634075705, 1903.6192761447767, 1916.377177417345, 368.9501917241192, 370.0397468569059, 372.4208855230143, 374.8650485825101, 1009.3086235928266, 11076.723081923017, 11503.654890353302, 11656.358900260397, 11849.052075833913, 11887.346195959133, 405.65120972765675, 430.4877196136587, 431.84885290148196, 438.9956100439019, 460.8479201863444, 5609.242752228479, 5722.170285308607, 6066.332703402622, 6134.723937422737, 6155.753769849156, 783147.0, 785517.0, 793061.0, 796018.9582907598, 804681.0, 122396.0, 126028.0, 126802.36598816946, 128186.71813281934, 128746.0, 465.74616833825644, 468.3910915809434, 473.5643208248351, 476.1358134984991, 478.533429905846, 11132.666020019413, 11197.384143872165, 11274.661760147208, 11291.322520648788, 11327.773444530898, 51508.227376590134, 52313.21530177126, 52346.21480677869, 52501.0, 52508.737456312476, 72290.0, 72648.54702905807, 73015.0, 74906.0, 75329.87005194816, 9542.713718588453, 9642.71071867845, 9691.612335506501, 9889.406635601887, 9955.0, 11581.710457238636, 11844.46699898524, 12543.745625437383, 17344.219510121824, 17496.73754893703, 15562.455314063953, 15808.841911580737, 15868.60328491797, 16037.0, 16173.75739363934, 15828.841711582736, 15839.52481425559, 15921.601959951095, 15999.68000640004, 16098.678026439171, 16313.0, 16359.836401635832, 16999.06505142229, 17021.0, 17123.828761712222, 9871.309008369346, 9947.253955953187, 9978.60085596568, 10055.29612927088, 10220.386776793417, 15715.371385144923, 16132.274047667648, 16208.67582648364, 16771.58071048185, 16885.24016419289], "unit": "ms", "name": "jquery.html", "value": 8797.489940943013}, {"lowerIsBetter": false, "replicates": [1503.4061545689453, 1529.3423827754061, 1792.9282828686837, 1887.9993603390199, 1896.506908203867, 6877.656117194139, 7570.0, 7664.693412263517, 8692.869606955894, 8732.912670873282, 8283.585820708955, 8434.578271086437, 8520.701775437861, 8521.531315777629, 8554.101819308977, 2395.580773364663, 2404.2426635609813, 2416.299273210767, 2418.9395265118424, 2419.7459266777, 2430.0765709030543, 2435.561598912195, 2461.7661322174363, 2462.0274991378396, 2482.379405148713, 2322.1640209524558, 2333.18338581496, 2337.322176568793, 2350.788429041386, 2368.384220102777, 2391.294568102414, 2394.724606670238, 2400.579898517761, 2423.09134074722, 2431.5623187826186, 2410.7348191698898, 2438.6951631046118, 2454.877256137204, 2465.790407815338, 2467.235157101304, 8457.873131903027, 8464.915350846475, 8514.446560973578, 8530.189631984951, 8586.957065214634, 5231.8168864089575, 5264.947350526522, 5272.446393128743, 5311.415744268127, 5352.116900711378, 3536.098294934801, 3611.223586928823, 3644.97940576639, 3706.499622550948, 3710.9814450927843, 1053.2463547183268, 1075.5643964194514, 1086.9347839129678, 1098.1873413673904, 1101.3612104979093, 11240.437978101063, 11301.208915375926, 11336.773264534746, 11336.829947550794, 11339.376334301693, 4723.149833030087, 4758.833440829554, 4773.952260477351, 4774.3793306870575, 4781.569658730661, 9590.520473976274, 9658.9034109658, 9729.854052189223, 9738.172255358233, 9755.853662195073, 5257.6056795739705, 5267.762950667229, 5298.0, 5299.8410047698635, 5307.230451584499, 3649.5802982656805, 4473.888152796141, 4694.765261736899, 4742.241241401359, 4869.610431165569, 3870.9806450967567, 3892.3188442023097, 3939.6454319111417, 3948.993006783252, 3970.662493688069, 1308.9476420943056, 1318.7164759576738, 1322.5701646964776, 1322.8280323557876, 1325.787873940165, 1346.5690978886857, 1368.4594585139014, 1373.1212024304452, 1378.710470801123, 1385.3835043405788, 7984.560849153352, 8070.83858322842, 8078.636461359253, 8079.111297757242, 8079.394045446615, 509.4447052712487, 511.12342332898515, 516.7209706758383, 516.875949772052, 516.9353830771154, 6128.601640893327, 6170.50635949123, 6201.720922558406, 6214.285357183981, 6224.692814509004, 10211.336263142872, 10235.488225588691, 10300.433476158883, 10358.53386597605, 10393.116585090353, 9906.653267135616, 10152.49237538135, 10182.490875456198, 10231.590736370461, 10248.026437488426, 6812.250652428229, 7984.600769961595, 8052.557109358924, 8057.43597948138, 8086.797830054295, 7895.289423951872, 7941.364690824605, 7955.164707705608, 7958.602069896598, 7988.161243069627, 9119.179273865118, 9179.219766319937, 9299.977002529851, 9321.254299655875, 9389.154976052188, 8220.547869867214, 9496.715098547054, 9623.855642165234, 9676.322657413913, 9682.46746428925, 5739.942600573941, 6929.44564434834, 6988.196357418962, 7471.476996610402, 7474.439417043634, 6707.765228216989, 8008.0, 8013.4791238569305, 8031.718889838828, 8065.435419520577, 6489.707963141575, 7463.402927765657, 7623.733169339046, 7681.923180768121, 7693.769186924401, 7430.368418684472, 7477.813054673677, 7540.622968851426, 7545.207753185837, 7581.734639287599, 7638.236176382317, 7651.732189373345, 7656.885146722915, 7657.731979380695, 7662.080550333995, 6844.691988860413, 6922.342377474132, 6974.337437943387, 6998.685059172248, 7021.789346319619, 7008.018877357072, 7048.224695283412, 7050.471214658818, 7055.223925368103, 7094.6097964612445], "unit": "ms", "name": "mootools.html", "value": 4754.210851773727}, {"lowerIsBetter": false, "replicates": [261.2619350335302, 321.3653035255371, 321.3781333120412, 329.2000438933391, 333.2634876922002, 6005.939940600592, 6441.710123044462, 6808.217055038672, 6984.196817366004, 7031.964840175799, 5328.5470734987575, 6657.500687448449, 6790.592564446137, 6867.381935625793, 6890.069840571521, 5042.974785126078, 5053.267276244942, 5068.974655126719, 5084.694918304895, 5093.134167191586, 5004.499550045003, 5071.873203169914, 5075.9746201268945, 5090.720010399426, 5095.802486415708, 4967.428745694256, 4993.775280112403, 4998.450170481262, 5015.5486006259425, 5016.924746128811, 3994.141259629194, 4644.535546445362, 4984.75076246188, 5012.423571289312, 5034.194528875399, 3536.328097661462, 4205.591126972437, 4280.892977675552, 4294.463192100988, 4313.870583882489, 6386.64873431961, 6569.277379488252, 6589.308122647149, 6590.143281373391, 6627.436667883236, 4526.8868278292975, 5940.435658612425, 5966.254218222723, 5988.251468566429, 6001.969990150022, 7360.043194384749, 7365.3739432147795, 7365.484416090876, 7378.262173782632, 7399.963000185018, 4754.976225118887, 4812.0, 4813.614910807127, 4817.349657796188, 4826.0, 6580.967095164541, 7574.356179724675, 7656.3874890008665, 7804.219578042207, 7887.881681774778, 4900.313956046157, 4910.48439913811, 4917.704937703749, 4925.0, 4930.1865192243595, 4969.055879382978, 4997.700137991732, 5016.147254966664, 5027.874303142377, 5029.823956161516, 5833.7083145842535, 5931.0, 5971.19388882504, 5975.282966044103, 5980.521558275327, 7414.851702965911, 7417.480776345604, 7420.443466740016, 7427.25727427253, 7451.3666338361845, 1629.6414788746695, 1679.1688114383458, 1701.0814160353518, 1735.5834599696234, 1740.6779745747078, 942.2791564453199, 1118.4463690473267, 1119.5689659480995, 1127.6278827986744, 1129.2490493821517, 5564.221009058735, 6840.828979275459, 6904.896426553606, 6905.723771049203, 6919.515633905578, 7617.124030736425, 7619.885701714478, 7624.42816788743, 7668.194839541768, 7691.50005249657, 6870.793876183722, 6909.689063992132, 6917.9308206918295, 6933.965330173317, 7014.754483593049, 4087.202995415865, 4122.237386083584, 4124.566920473307, 4127.834886604563, 4130.463039804806, 8059.355251579859, 8064.596770161468, 8064.959675201587, 8100.0, 8124.22819832115, 7772.0, 8040.035195776544, 8043.477173983672, 8048.637811298506, 8057.758267251992, 8037.959810200911, 8060.31487323584, 8082.959585202037, 8084.555349455719, 8118.959405202936, 7609.429292803173, 7771.72798952034, 7777.650005749641, 7797.064352277763, 7813.609319534115, 7626.351760100453, 7626.54240745557, 7637.389008879388, 7639.770806875803, 7647.655855486405, 6895.9656051592665, 7662.578558179131, 8053.516788992679, 8081.393895457747, 8085.312748416451, 4697.154512187839, 4700.858974230779, 4740.952590474051, 4746.2168742157155, 4834.516548345137, 7325.0, 7482.139553951365, 7609.961950190435, 7749.147593764568, 7763.301302882767, 5981.312149102909, 7263.382612477999, 7356.816079598053, 7416.6291685414435, 7471.8879216812875, 6046.516278697605, 7408.407327413686, 7430.479866409516, 7447.069116360455, 7498.58757768328, 7071.292870712888, 7221.819454513469, 7232.42140628759, 7238.203797582157, 7289.562626242442, 7400.222976587381, 7409.110906691231, 7410.333070023508, 7430.851382972419, 7455.65798156337, 7058.0, 7258.45561582894, 7258.782236532912, 7308.707651693872, 7312.268773122645], "unit": "ms", "name": "prototype.html", "value": 5350.081047767643}, {"lowerIsBetter": false, "replicates": [725.1986554856886, 742.9665665045072, 783.3615603283324, 807.9798005049875, 814.5723495165038, 15050.548483545497, 15313.234338283097, 15433.922830385847, 15470.922645386758, 15494.767578486331, 16723.498295051137, 16943.983360998318, 16951.89812662176, 16970.915145424286, 16999.150042497888, 765.8123759678887, 884.1114679746845, 914.2594498456255, 941.3739862991102, 955.7801705607715, 762.6834863531627, 939.7650587353162, 954.3367359685021, 963.8939716631165, 965.9857149992515, 995.4574756757548, 998.7203582996773, 999.2355847776457, 1013.5540362240628, 1014.2139841622765, 824.575343697996, 979.3780949097339, 997.3367710472527, 1005.2058873489934, 1010.3028910052041, 734.7612026091488, 743.5835931878112, 745.2361329637112, 745.8843879198732, 747.8018325143842, 15556.61108472286, 15624.531264062096, 15639.68720625581, 15673.451429200037, 15853.9694919831, 12436.689082772913, 12548.623541293775, 12682.873171268353, 12699.873001270054, 13237.0, 9653.324267301292, 9890.505474726308, 10346.12057975073, 10964.232503724743, 11373.943130284295, 3497.615262321143, 3546.556680414948, 3562.8752993645357, 3602.5496812898386, 3607.4228123500116, 78651.21348786553, 79161.20838791596, 79644.0, 80569.79145312824, 86721.0, 9487.715368538955, 9658.468784216795, 9680.46757428334, 9773.07155820196, 10338.431386273827, 21723.34829955104, 21946.231881884058, 22009.449763755714, 22060.0, 22107.447313816963, 7416.814579635552, 7552.093748750185, 7802.843943121105, 7896.249856263646, 7979.16218797018, 3771.076086358805, 4155.8753237402925, 4157.605027522381, 4215.936760948588, 4276.123394704078, 3522.682958533744, 3525.453554699026, 3541.220931395089, 3552.0, 3563.002359339389, 645.3127419298432, 647.0326861342323, 649.5096202367276, 651.8728847874713, 658.4666420199558, 508.09812582666063, 510.81099993002084, 545.1876703711521, 550.8815604645021, 570.6519023395725, 8959.552022398853, 9451.858222126673, 9462.337636365388, 9523.333366664405, 9694.175995040501, 414.8465067924887, 486.6301610775836, 500.7821597604981, 517.3868965276159, 545.9372172200168, 3811.515833403537, 4077.55146933843, 4167.708260421741, 4258.701890867672, 4306.2894622387585, 102252.97747022583, 104292.47853760835, 104871.0, 105666.4716676427, 106252.0, 89583.0, 90010.64984025244, 90169.54915225382, 91332.0, 92402.53798730964, 78986.81519777208, 80182.59908700536, 80690.19309806945, 81244.59377703191, 82109.0, 9019.143181397756, 9069.546522673973, 9213.631454741735, 9328.347015708836, 9367.297452690938, 55018.72490637521, 55502.0, 55626.60933476695, 55782.163267550204, 56327.0, 75730.24269757452, 77034.0, 78109.26617568357, 78657.0, 79515.60242198753, 9442.575084121094, 11249.887501124884, 11575.942120289681, 11643.41782910834, 11959.0, 10273.897261027592, 12287.344886129982, 12297.508099675913, 12409.689757755767, 12605.810912836498, 11807.881921180679, 11837.171398002058, 11912.166148369532, 12060.577879774166, 12130.0, 9500.287478439006, 10267.7433064174, 11456.427178641201, 11925.463354148911, 11927.582534611247, 8323.791905202175, 9604.567794449127, 11229.550817967516, 11748.823767643322, 11770.52917883275, 9600.66397676078, 9715.417074975525, 9808.754781130528, 10077.596896124072, 10081.14310283634, 9222.769430764285, 9661.323707340418, 9690.660826871026, 9753.414795112316, 9858.063483969012], "unit": "ms", "name": "yui.html", "value": 7169.0751513685855}], "name": "dromaeo_css", "value": 7587.247100424527}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 112.0, 113.0, 114.0, 128.0, 115.0, 113.0, 116.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [144.0, 123.0, 144.0, 157.0, 118.0, 130.0, 164.0, 156.0, 189.0, 144.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [190.0, 189.0, 191.0, 193.0, 240.0, 276.0, 194.0, 222.0, 281.0, 211.0], "unit": "ms", "name": "audio-dft", "value": 218.7}, {"lowerIsBetter": true, "replicates": [55.0, 67.0, 77.0, 94.0, 95.0, 82.0, 84.0, 84.0, 87.0, 122.0], "unit": "ms", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 104.0, 74.0, 79.0, 75.0, 108.0, 76.0, 76.0, 105.0], "unit": "ms", "name": "audio-oscillator", "value": 85.0}, {"lowerIsBetter": true, "replicates": [95.0, 134.0, 89.0, 88.0, 89.0, 90.0, 89.0, 92.0, 90.0, 79.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 93.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 95.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 91.0, 95.0, 92.0, 92.0, 92.0, 91.0, 135.0, 90.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 59.0, 60.0, 58.0, 60.0, 62.0, 69.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 81.0, 84.0, 84.0, 82.0, 84.0, 83.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [133.0, 124.0, 126.0, 130.0, 132.0, 129.0, 134.0, 128.0, 118.0, 146.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 139.0, 136.0, 138.0, 142.0, 139.0, 138.0, 135.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 69.0, 67.0, 66.0, 64.0, 66.0, 67.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1481.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.88524105294292], "unit": "score", "name": "Richards", "value": 238.7121240000001}, {"lowerIsBetter": false, "replicates": [156.86274509803923], "unit": "score", "name": "DeltaBlue", "value": 421.50225000000006}, {"lowerIsBetter": false, "replicates": [302.11480362537765], "unit": "score", "name": "Encrypt", "value": 881.0591099999997}, {"lowerIsBetter": false, "replicates": [4799.043062200957], "unit": "score", "name": "Decrypt", "value": 55.4654327018943}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [736.9196757553427], "unit": "score", "name": "Earley", "value": 904.3902909999999}, {"lowerIsBetter": false, "replicates": [12670.886075949367], "unit": "score", "name": "Boyer", "value": 52.597979020979054}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [603.9783001808319], "unit": "score", "name": "Splay", "value": 134.9237215568862}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 22170.26230265777}]} 10:37:13 INFO - RETURN: dromaeo_css: 7587.25 10:37:13 INFO - RETURN: kraken: 1481.20 10:37:13 INFO - RETURN: v8_7: 22170.26 10:37:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "22170.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1481.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7587.25"}}} 10:37:13 INFO - Return code: 0 10:37:13 INFO - # TBPL SUCCESS # 10:37:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:13 INFO - 2015-11-20 10:37:13.474 screenresolution[1832:11294] starting screenresolution argv=screenresolution get 10:37:13 INFO - 2015-11-20 10:37:13.477 screenresolution[1832:11294] Display 0: 1600x1200x32@60 10:37:13 INFO - 2015-11-20 10:37:13.483 screenresolution[1833:11297] starting screenresolution argv=screenresolution list 10:37:13 INFO - Available Modes on Display 0 10:37:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:13 INFO - Intel Iris: 10:37:13 INFO - Chipset Model: Intel Iris 10:37:13 INFO - Type: GPU 10:37:13 INFO - Bus: Built-In 10:37:13 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:13 INFO - Vendor: Intel (0x8086) 10:37:13 INFO - Device ID: 0x0a2e 10:37:13 INFO - Revision ID: 0x0009 10:37:13 INFO - Displays: 10:37:13 INFO - Display: 10:37:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:13 INFO - Display Serial Number: 1600x1200 60 10:37:13 INFO - Main Display: Yes 10:37:13 INFO - Mirror: Off 10:37:13 INFO - Online: Yes 10:37:13 INFO - Rotation: Supported 10:37:13 INFO - Return code: 0 10:37:13 INFO - Running post-action listener: _resource_record_post_action 10:37:13 INFO - Running post-run listener: _resource_record_post_run 10:37:14 INFO - Total resource usage - Wall time: 1236s; CPU: 54.0%; Read bytes: 33721856; Write bytes: 697052672; Read time: 353; Write time: 2114 10:37:14 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 337216000; Write bytes: 335308288; Read time: 25891; Write time: 570 10:37:14 INFO - run-tests - Wall time: 1207s; CPU: 54.0%; Read bytes: 31948288; Write bytes: 350541824; Read time: 335; Write time: 1510 10:37:14 INFO - Running post-run listener: _upload_blobber_files 10:37:14 INFO - Blob upload gear active. 10:37:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:37:14 INFO - Copying logs to upload dir... 10:37:14 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.545673 ========= master_lag: 4.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-11-20 10:37:19.042940) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:37:19.046776) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009375 build_url: 'https://queue.taskcluster.net/v1/task/vE1-4m81QbaUwYCvBpXoyg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.31 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 10:37:19.367796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:37:19.368133) ========= 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.OjZtTXSFvu/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.5e5JMYc6rn/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004944 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 10:37:19.506686) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 10:37:19.506993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 10:37:19.511962) ========= ========= Total master_lag: 9.55 =========