builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0059 starttime: 1447615557.39 results: success (0) buildid: 20151115092632 builduid: 743ffbfad5cf440597a3b71c3118312f revision: 3f0651985bf0e3403b5fd4984a907813689ee3a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.389399) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.390045) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.390637) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007475 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.423038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.424150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.443899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.444212) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.006387 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.494363) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.494718) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.495133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.495466) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-15 11:25:57-- 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.60M=0.001s 2015-11-15 11:25:57 (8.60 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.637471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.638376) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.024481 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.693460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:57.693857) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3f0651985bf0e3403b5fd4984a907813689ee3a9 --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 3f0651985bf0e3403b5fd4984a907813689ee3a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-15 11:25:57,783 truncating revision to first 12 chars 2015-11-15 11:25:57,784 Setting DEBUG logging. 2015-11-15 11:25:57,784 attempt 1/10 2015-11-15 11:25:57,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3f0651985bf0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 11:25:58,134 unpacking tar archive at: fx-team-3f0651985bf0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:58.352921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:58.353356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:58.369188) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:58.369631) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 11:25:58.370177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-15 11:25:58.370570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 11:25:58 INFO - MultiFileLogger online at 20151115 11:25:58 in /builds/slave/test 11:25:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 11:25:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:58 INFO - {'append_to_log': False, 11:25:58 INFO - 'base_work_dir': '/builds/slave/test', 11:25:58 INFO - 'blob_upload_branch': 'Fx-Team', 11:25:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:58 INFO - 'branch': 'Fx-Team', 11:25:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:58 INFO - 'config_files': ('talos/mac_config.py',), 11:25:58 INFO - 'default_actions': ('clobber', 11:25:58 INFO - 'read-buildbot-config', 11:25:58 INFO - 'download-and-extract', 11:25:58 INFO - 'populate-webroot', 11:25:58 INFO - 'create-virtualenv', 11:25:58 INFO - 'install', 11:25:58 INFO - 'run-tests'), 11:25:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:58 INFO - 'download_minidump_stackwalk': True, 11:25:58 INFO - 'download_symbols': 'ondemand', 11:25:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:25:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:25:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:25:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:25:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:58 INFO - 'installer_path': 'installer.exe', 11:25:58 INFO - 'log_level': 'info', 11:25:58 INFO - 'log_name': 'talos', 11:25:58 INFO - 'log_to_console': True, 11:25:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:25:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:25:58 INFO - 'opt_config_files': (), 11:25:58 INFO - 'pip_index': False, 11:25:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:58 INFO - 'cmd': ('bash', 11:25:58 INFO - '-c', 11:25:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:58 INFO - 'enabled': True, 11:25:58 INFO - 'halt_on_failure': False, 11:25:58 INFO - 'name': 'check_screen_resolution'},), 11:25:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:25:58 INFO - 'cmd': ('bash', 11:25:58 INFO - '-c', 11:25:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:25:58 INFO - 'enabled': True, 11:25:58 INFO - 'halt_on_failure': False, 11:25:58 INFO - 'name': 'check_screen_resolution'},), 11:25:58 INFO - 'run_cmd_checks_enabled': True, 11:25:58 INFO - 'sps_profile': False, 11:25:58 INFO - 'sps_profile_interval': 0, 11:25:58 INFO - 'suite': 'dromaeojs', 11:25:58 INFO - 'system_bits': '64', 11:25:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:58 INFO - 'title': 't-yosemite-r5-0059', 11:25:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:58 INFO - 'use_talos_json': True, 11:25:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:58 INFO - 'work_dir': 'build'} 11:25:58 INFO - ##### 11:25:58 INFO - ##### Running clobber step. 11:25:58 INFO - ##### 11:25:58 INFO - Running pre-action listener: _resource_record_pre_action 11:25:58 INFO - Running main action method: clobber 11:25:58 INFO - rmtree: /builds/slave/test/build 11:25:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:00 INFO - Running post-action listener: _resource_record_post_action 11:26:00 INFO - ##### 11:26:00 INFO - ##### Running read-buildbot-config step. 11:26:00 INFO - ##### 11:26:00 INFO - Running pre-action listener: _resource_record_pre_action 11:26:00 INFO - Running main action method: read_buildbot_config 11:26:00 INFO - Using buildbot properties: 11:26:00 INFO - { 11:26:00 INFO - "properties": { 11:26:00 INFO - "buildnumber": 1346, 11:26:00 INFO - "product": "firefox", 11:26:00 INFO - "script_repo_revision": "production", 11:26:00 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 11:26:00 INFO - "repository": "", 11:26:00 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 11:26:00 INFO - "buildid": "20151115092632", 11:26:00 INFO - "slavename": "t-yosemite-r5-0059", 11:26:00 INFO - "pgo_build": "False", 11:26:00 INFO - "basedir": "/builds/slave/test", 11:26:00 INFO - "project": "", 11:26:00 INFO - "platform": "yosemite", 11:26:00 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:26:00 INFO - "slavebuilddir": "test", 11:26:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:26:00 INFO - "branch": "fx-team", 11:26:00 INFO - "repo_path": "integration/fx-team", 11:26:00 INFO - "stage_platform": "macosx64", 11:26:00 INFO - "builduid": "743ffbfad5cf440597a3b71c3118312f", 11:26:00 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:26:00 INFO - }, 11:26:00 INFO - "sourcestamp": { 11:26:00 INFO - "repository": "", 11:26:00 INFO - "hasPatch": false, 11:26:00 INFO - "project": "", 11:26:00 INFO - "branch": "fx-team-macosx64-talos", 11:26:00 INFO - "changes": [ 11:26:00 INFO - { 11:26:00 INFO - "category": null, 11:26:00 INFO - "files": [ 11:26:00 INFO - { 11:26:00 INFO - "url": null, 11:26:00 INFO - "name": "https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:26:00 INFO - } 11:26:00 INFO - ], 11:26:00 INFO - "repository": "", 11:26:00 INFO - "rev": "3f0651985bf0e3403b5fd4984a907813689ee3a9", 11:26:00 INFO - "who": "philringnalda@gmail.com", 11:26:00 INFO - "when": 1447614904, 11:26:00 INFO - "number": 6663849, 11:26:00 INFO - "comments": "Merge m-c to f-t", 11:26:00 INFO - "project": "", 11:26:00 INFO - "at": "Sun 15 Nov 2015 11:15:04", 11:26:00 INFO - "branch": "fx-team-macosx64-talos", 11:26:00 INFO - "revlink": "", 11:26:00 INFO - "properties": [ 11:26:00 INFO - [ 11:26:00 INFO - "buildid", 11:26:00 INFO - "20151115092632", 11:26:00 INFO - "Change" 11:26:00 INFO - ], 11:26:00 INFO - [ 11:26:00 INFO - "builduid", 11:26:00 INFO - "743ffbfad5cf440597a3b71c3118312f", 11:26:00 INFO - "Change" 11:26:00 INFO - ], 11:26:00 INFO - [ 11:26:00 INFO - "pgo_build", 11:26:00 INFO - "False", 11:26:00 INFO - "Change" 11:26:00 INFO - ] 11:26:00 INFO - ], 11:26:00 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:26:00 INFO - } 11:26:00 INFO - ], 11:26:00 INFO - "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9" 11:26:00 INFO - } 11:26:00 INFO - } 11:26:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:26:00 INFO - Running post-action listener: _resource_record_post_action 11:26:00 INFO - ##### 11:26:00 INFO - ##### Running download-and-extract step. 11:26:00 INFO - ##### 11:26:00 INFO - Running pre-action listener: _resource_record_pre_action 11:26:00 INFO - Running main action method: download_and_extract 11:26:00 INFO - mkdir: /builds/slave/test/build/tests 11:26:00 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')]} 11:26:00 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json 11:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json 11:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:26:00 INFO - Downloaded 1149 bytes. 11:26:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:26:00 INFO - Using the following test package requirements: 11:26:00 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:26:00 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:26:00 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'jsshell-mac.zip'], 11:26:00 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:26:00 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:26:00 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:26:00 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:26:00 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:26:00 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:26:00 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:26:00 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:26:00 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:26:00 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')]} 11:26:00 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:26:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:01 INFO - Downloaded 17464154 bytes. 11:26:01 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 11:26:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:26:07 INFO - Return code: 0 11:26:07 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 11:26: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')]} 11:26:07 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:26:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:08 INFO - Downloaded 17464154 bytes. 11:26:08 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 11:26:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:26:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:26:15 INFO - Return code: 0 11:26: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')]} 11:26:15 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:16 INFO - Downloaded 11131693 bytes. 11:26:16 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 11:26:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:26:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:26:16 INFO - Return code: 0 11:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:16 INFO - https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:26:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:26:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:26:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:26:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/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 11:26:20 INFO - Downloaded 108681180 bytes. 11:26:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:26:20 INFO - mkdir: /builds/slave/test/properties 11:26:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:20 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:20 INFO - Contents: 11:26:20 INFO - build_url:https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:26:20 INFO - Running post-action listener: _resource_record_post_action 11:26:20 INFO - Running post-action listener: set_extra_try_arguments 11:26:20 INFO - ##### 11:26:20 INFO - ##### Running populate-webroot step. 11:26:20 INFO - ##### 11:26:20 INFO - Running pre-action listener: _resource_record_pre_action 11:26:20 INFO - Running main action method: populate_webroot 11:26:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:20 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:26:20 INFO - '../fennec_ids.txt'], 11:26:20 INFO - 'tests': ['tcheck2']}, 11:26:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:20 INFO - '--tppagecycles', 11:26:20 INFO - '7'], 11:26:20 INFO - 'tests': ['tsvgm']}}, 11:26:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:26:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:26:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:26:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'tests': ['damp', 'tps']}, 11:26:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['damp', 'tps']}, 11:26:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:26:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:20 INFO - 'other': {'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'other_l64': {'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'other_nol64': {'tests': ['a11yr', 11:26:20 INFO - 'ts_paint', 11:26:20 INFO - 'tpaint', 11:26:20 INFO - 'sessionrestore', 11:26:20 INFO - 'sessionrestore_no_auto_restore']}, 11:26:20 INFO - 'svgr': {'tests': ['tsvgx', 11:26:20 INFO - 'tsvgr_opacity', 11:26:20 INFO - 'tart', 11:26:20 INFO - 'tscrollx', 11:26:20 INFO - 'cart']}, 11:26:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['tsvgx', 11:26:20 INFO - 'tsvgr_opacity', 11:26:20 INFO - 'tart', 11:26:20 INFO - 'tscrollx', 11:26:20 INFO - 'cart']}, 11:26:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'tests': ['tp5o']}, 11:26:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'talos_options': ['--e10s'], 11:26:20 INFO - 'tests': ['tp5o']}, 11:26:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'talos_options': ['--xperf_path', 11:26:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:20 INFO - 'tests': ['tp5n']}, 11:26:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:20 INFO - 'talos_options': ['--e10s', 11:26:20 INFO - '--xperf_path', 11:26:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:20 INFO - 'tests': ['tp5n']}}, 11:26:20 INFO - 'talos.zip': {'path': '', 11:26:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:20 INFO - Running post-action listener: _resource_record_post_action 11:26:20 INFO - ##### 11:26:20 INFO - ##### Running create-virtualenv step. 11:26:20 INFO - ##### 11:26:20 INFO - Running pre-action listener: _resource_record_pre_action 11:26:20 INFO - Running main action method: create_virtualenv 11:26:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:20 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 11:26:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:20 INFO - Using real prefix '/tools/python27' 11:26:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:25 INFO - Installing pip.................done. 11:26:25 INFO - Return code: 0 11:26:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:25 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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:25 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 11:26:25 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 11:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:25 INFO - 'HOME': '/Users/cltbld', 11:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:25 INFO - 'LOGNAME': 'cltbld', 11:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:25 INFO - 'MOZ_NO_REMOTE': '1', 11:26:25 INFO - 'NO_EM_RESTART': '1', 11:26:25 INFO - 'PAGER': '/bin/cat', 11:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:25 INFO - 'PWD': '/builds/slave/test', 11:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:25 INFO - 'SHELL': '/bin/bash', 11:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:25 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:25 INFO - 'USER': 'cltbld', 11:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:25 INFO - 'XPC_FLAGS': '0x0', 11:26:25 INFO - 'XPC_SERVICE_NAME': '0', 11:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:26 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 11:26:26 INFO - Cleaning up... 11:26:26 INFO - Return code: 0 11:26:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:26 INFO - 'HOME': '/Users/cltbld', 11:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:26 INFO - 'LOGNAME': 'cltbld', 11:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:26 INFO - 'MOZ_NO_REMOTE': '1', 11:26:26 INFO - 'NO_EM_RESTART': '1', 11:26:26 INFO - 'PAGER': '/bin/cat', 11:26:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:26 INFO - 'PWD': '/builds/slave/test', 11:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:26 INFO - 'SHELL': '/bin/bash', 11:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:26 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:26 INFO - 'USER': 'cltbld', 11:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:26 INFO - 'XPC_FLAGS': '0x0', 11:26:26 INFO - 'XPC_SERVICE_NAME': '0', 11:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:26 INFO - Downloading/unpacking psutil>=0.7.1 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:29 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:26:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:29 INFO - Installing collected packages: psutil 11:26:29 INFO - Running setup.py install for psutil 11:26:30 INFO - building 'psutil._psutil_osx' extension 11:26:30 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 11:26:30 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 11:26:30 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 11:26:30 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 11:26:30 INFO - building 'psutil._psutil_posix' extension 11:26:30 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 11:26:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:26:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:26:30 INFO - ^ 11:26:30 INFO - 1 warning generated. 11:26:30 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 11:26:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:31 INFO - Successfully installed psutil 11:26:31 INFO - Cleaning up... 11:26:31 INFO - Return code: 0 11:26:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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', '--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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:31 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 11:26:31 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 11:26:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:31 INFO - 'HOME': '/Users/cltbld', 11:26:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:31 INFO - 'LOGNAME': 'cltbld', 11:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:31 INFO - 'MOZ_NO_REMOTE': '1', 11:26:31 INFO - 'NO_EM_RESTART': '1', 11:26:31 INFO - 'PAGER': '/bin/cat', 11:26:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:31 INFO - 'PWD': '/builds/slave/test', 11:26:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:31 INFO - 'SHELL': '/bin/bash', 11:26:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:31 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:31 INFO - 'USER': 'cltbld', 11:26:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:31 INFO - 'XPC_FLAGS': '0x0', 11:26:31 INFO - 'XPC_SERVICE_NAME': '0', 11:26:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:26:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:26:34 INFO - Installing collected packages: mozsystemmonitor 11:26:34 INFO - Running setup.py install for mozsystemmonitor 11:26:34 INFO - Successfully installed mozsystemmonitor 11:26:34 INFO - Cleaning up... 11:26:34 INFO - Return code: 0 11:26:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:34 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 11:26:34 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 11:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:34 INFO - 'HOME': '/Users/cltbld', 11:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:34 INFO - 'LOGNAME': 'cltbld', 11:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:34 INFO - 'MOZ_NO_REMOTE': '1', 11:26:34 INFO - 'NO_EM_RESTART': '1', 11:26:34 INFO - 'PAGER': '/bin/cat', 11:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:34 INFO - 'PWD': '/builds/slave/test', 11:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:34 INFO - 'SHELL': '/bin/bash', 11:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:34 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:34 INFO - 'USER': 'cltbld', 11:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:34 INFO - 'XPC_FLAGS': '0x0', 11:26:34 INFO - 'XPC_SERVICE_NAME': '0', 11:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:35 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 11:26:35 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 11:26:35 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 11:26:35 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 11:26:35 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 11:26:35 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 11:26:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:38 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 11:26:39 INFO - Downloading docopt-0.6.1.tar.gz 11:26:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:39 INFO - Running setup.py install for blobuploader 11:26:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:39 INFO - Running setup.py install for requests 11:26:40 INFO - Running setup.py install for docopt 11:26:40 INFO - Successfully installed blobuploader requests docopt 11:26:40 INFO - Cleaning up... 11:26:40 INFO - Return code: 0 11:26:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:40 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')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 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')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:40 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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:40 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 11:26:40 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 11:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:40 INFO - 'HOME': '/Users/cltbld', 11:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PAGER': '/bin/cat', 11:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test', 11:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:40 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:40 INFO - 'XPC_FLAGS': '0x0', 11:26:40 INFO - 'XPC_SERVICE_NAME': '0', 11:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:40 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Gfjnpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Tp6cDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-4QjJ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-6vmXE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-qUZkrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-J3_iAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-FSPRJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:41 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-1DaE1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-xb1soF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-E9YzKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Qsj7WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Vknjq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-IbwCjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:42 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-SfQR4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:43 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Fktv1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:43 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-M622Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:43 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-4MYUcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:43 INFO - Running setup.py install for manifestparser 11:26:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:43 INFO - Running setup.py install for mozcrash 11:26:43 INFO - Running setup.py install for mozdebug 11:26:44 INFO - Running setup.py install for mozdevice 11:26:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:26:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:44 INFO - Running setup.py install for mozfile 11:26:44 INFO - Running setup.py install for mozhttpd 11:26:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:44 INFO - Running setup.py install for mozinfo 11:26:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:44 INFO - Running setup.py install for mozInstall 11:26:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Running setup.py install for mozleak 11:26:45 INFO - Running setup.py install for mozlog 11:26:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Running setup.py install for moznetwork 11:26:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:45 INFO - Running setup.py install for mozprocess 11:26:45 INFO - Running setup.py install for mozprofile 11:26:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:46 INFO - Running setup.py install for mozrunner 11:26:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:46 INFO - Running setup.py install for mozscreenshot 11:26:46 INFO - Running setup.py install for moztest 11:26:46 INFO - Running setup.py install for mozversion 11:26:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:46 INFO - Cleaning up... 11:26:46 INFO - Return code: 0 11:26:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:46 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')]} 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:46 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')]} 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:46 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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:46 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 11:26:46 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 11:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:46 INFO - 'HOME': '/Users/cltbld', 11:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:46 INFO - 'LOGNAME': 'cltbld', 11:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:46 INFO - 'MOZ_NO_REMOTE': '1', 11:26:46 INFO - 'NO_EM_RESTART': '1', 11:26:46 INFO - 'PAGER': '/bin/cat', 11:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:46 INFO - 'PWD': '/builds/slave/test', 11:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:46 INFO - 'SHELL': '/bin/bash', 11:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:46 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:46 INFO - 'USER': 'cltbld', 11:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:46 INFO - 'XPC_FLAGS': '0x0', 11:26:46 INFO - 'XPC_SERVICE_NAME': '0', 11:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:47 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-z5SGA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:47 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-sqquoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:47 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-6DXf6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:47 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-kMTKVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:47 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)) 11:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:47 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-yZqUNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-L7rYZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-cenGQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-ByDanq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-AmJ21r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-OrqHsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:48 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-ductxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:48 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)) 11:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-17Ohlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:49 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)) 11:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-9x5QpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:49 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)) 11:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-860h7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:49 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)) 11:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-IuWrQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:49 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)) 11:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-k3pYOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:49 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)) 11:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:49 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-K0FqAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:49 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)) 11:26:49 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)) 11:26:49 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)) 11:26:49 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)) 11:26:49 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)) 11:26:49 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)) 11:26:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:49 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 11:26:49 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 11:26:49 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 11:26:49 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 11:26:49 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 11:26:49 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 11:26:52 INFO - Downloading blessings-1.5.1.tar.gz 11:26:52 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 11:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:52 INFO - Installing collected packages: blessings 11:26:52 INFO - Running setup.py install for blessings 11:26:53 INFO - Successfully installed blessings 11:26:53 INFO - Cleaning up... 11:26:53 INFO - Return code: 0 11:26:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:53 INFO - Reading from file tmpfile_stdout 11:26:53 INFO - Current package versions: 11:26:53 INFO - blessings == 1.5.1 11:26:53 INFO - blobuploader == 1.2.4 11:26:53 INFO - docopt == 0.6.1 11:26:53 INFO - manifestparser == 1.1 11:26:53 INFO - mozInstall == 1.12 11:26:53 INFO - mozcrash == 0.16 11:26:53 INFO - mozdebug == 0.1 11:26:53 INFO - mozdevice == 0.47 11:26:53 INFO - mozfile == 1.2 11:26:53 INFO - mozhttpd == 0.7 11:26:53 INFO - mozinfo == 0.9 11:26:53 INFO - mozleak == 0.1 11:26:53 INFO - mozlog == 3.0 11:26:53 INFO - moznetwork == 0.27 11:26:53 INFO - mozprocess == 0.22 11:26:53 INFO - mozprofile == 0.27 11:26:53 INFO - mozrunner == 6.11 11:26:53 INFO - mozscreenshot == 0.1 11:26:53 INFO - mozsystemmonitor == 0.0 11:26:53 INFO - moztest == 0.7 11:26:53 INFO - mozversion == 1.4 11:26:53 INFO - psutil == 3.1.1 11:26:53 INFO - requests == 1.2.3 11:26:53 INFO - wsgiref == 0.1.2 11:26:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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')]} 11:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:53 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 0x10f815490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7f2228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdffb613c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/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.aQEMudkvI6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:26:53 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 11:26:53 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 11:26:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:26:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:26:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:26:53 INFO - 'HOME': '/Users/cltbld', 11:26:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:26:53 INFO - 'LOGNAME': 'cltbld', 11:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:53 INFO - 'MOZ_NO_REMOTE': '1', 11:26:53 INFO - 'NO_EM_RESTART': '1', 11:26:53 INFO - 'PAGER': '/bin/cat', 11:26:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:53 INFO - 'PWD': '/builds/slave/test', 11:26:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:26:53 INFO - 'SHELL': '/bin/bash', 11:26:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:26:53 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:26:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:26:53 INFO - 'USER': 'cltbld', 11:26:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:26:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:53 INFO - 'XPC_FLAGS': '0x0', 11:26:53 INFO - 'XPC_SERVICE_NAME': '0', 11:26:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 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)) 11:26:53 INFO - Cleaning up... 11:26:53 INFO - Return code: 0 11:26:53 INFO - Running post-action listener: _resource_record_post_action 11:26:53 INFO - Running post-action listener: _start_resource_monitoring 11:26:53 INFO - Starting resource monitoring. 11:26:53 INFO - ##### 11:26:53 INFO - ##### Running install step. 11:26:53 INFO - ##### 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: install 11:26:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:54 INFO - Reading from file tmpfile_stdout 11:26:54 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:54 INFO - Reading from file tmpfile_stdout 11:26:54 INFO - Output received: 11:26:54 INFO - Usage: mozinstall [options] installer 11:26:54 INFO - Options: 11:26:54 INFO - -h, --help show this help message and exit 11:26:54 INFO - -d DEST, --destination=DEST 11:26:54 INFO - Directory to install application into. [default: 11:26:54 INFO - "/builds/slave/test"] 11:26:54 INFO - --app=APP Application being installed. [default: firefox] 11:26:54 INFO - mkdir: /builds/slave/test/build/application 11:26:54 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'] 11:26:54 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 11:27:38 INFO - Reading from file tmpfile_stdout 11:27:38 INFO - Output received: 11:27:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:27:38 INFO - Running post-action listener: _resource_record_post_action 11:27:38 INFO - ##### 11:27:38 INFO - ##### Running run-tests step. 11:27:38 INFO - ##### 11:27:38 INFO - Running pre-action listener: _resource_record_pre_action 11:27:38 INFO - Running main action method: run_tests 11:27:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:27:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:27:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:27:38 INFO - 2015-11-15 11:27:38.596 screenresolution[2285:26133] starting screenresolution argv=screenresolution get 11:27:38 INFO - 2015-11-15 11:27:38.600 screenresolution[2285:26133] Display 0: 1600x1200x32@60 11:27:38 INFO - 2015-11-15 11:27:38.608 screenresolution[2286:26135] starting screenresolution argv=screenresolution list 11:27:38 INFO - Available Modes on Display 0 11:27:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:27:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:27:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:27:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:27:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:27:38 INFO - Intel HD Graphics 3000: 11:27:38 INFO - Chipset Model: Intel HD Graphics 3000 11:27:38 INFO - Type: GPU 11:27:38 INFO - Bus: Built-In 11:27:38 INFO - VRAM (Total): 512 MB 11:27:38 INFO - VRAM (Dynamic, Max): 10 11:27:38 INFO - Vendor: Intel (0x8086) 11:27:38 INFO - Device ID: 0x0116 11:27:38 INFO - Revision ID: 0x0009 11:27:38 INFO - Displays: 11:27:38 INFO - Display: 11:27:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:27:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:27:38 INFO - Display Serial Number: 1600x1200 60 11:27:38 INFO - Main Display: Yes 11:27:38 INFO - Mirror: Off 11:27:38 INFO - Online: Yes 11:27:38 INFO - Rotation: Supported 11:27:38 INFO - Return code: 0 11:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:38 INFO - Python 2.7.3 11:27:38 INFO - Return code: 0 11:27:38 INFO - grabbing minidump binary from tooltool 11:27:38 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')]} 11:27:38 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 0x10f7389f0>, '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 0x10f498db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f72c8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:38 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 11:27:38 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 11:27:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:39 INFO - Return code: 0 11:27:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:27:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:27:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:39 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] in /builds/slave/test/build 11:27:39 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0059 --webServer localhost 11:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nphoS5PXYC/Render', 11:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:39 INFO - 'HOME': '/Users/cltbld', 11:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:39 INFO - 'LOGNAME': 'cltbld', 11:27:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:39 INFO - 'MOZ_NO_REMOTE': '1', 11:27:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:39 INFO - 'NO_EM_RESTART': '1', 11:27:39 INFO - 'PAGER': '/bin/cat', 11:27:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:39 INFO - 'PWD': '/builds/slave/test', 11:27:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:39 INFO - 'SHELL': '/bin/bash', 11:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aQEMudkvI6/Listeners', 11:27:39 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 11:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:39 INFO - 'USER': 'cltbld', 11:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:39 INFO - 'XPC_FLAGS': '0x0', 11:27:39 INFO - 'XPC_SERVICE_NAME': '0', 11:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:27:39 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] with output_timeout 3600 11:27:39 INFO - mozversion INFO | application_buildid: 20151115092632 11:27:39 INFO - mozversion INFO | application_changeset: 3f0651985bf0e3403b5fd4984a907813689ee3a9 11:27:39 INFO - mozversion INFO | application_display_name: Nightly 11:27:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:39 INFO - mozversion INFO | application_name: Firefox 11:27:39 INFO - mozversion INFO | application_remotingname: firefox 11:27:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:27:39 INFO - mozversion INFO | application_vendor: Mozilla 11:27:39 INFO - mozversion INFO | application_version: 45.0a1 11:27:39 INFO - mozversion INFO | platform_buildid: 20151115092632 11:27:39 INFO - mozversion INFO | platform_changeset: 3f0651985bf0e3403b5fd4984a907813689ee3a9 11:27:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:27:39 INFO - mozversion INFO | platform_version: 45.0a1 11:27:39 INFO - 2015-11-15 11:27:39,314 DEBUG : using testdate: 1447615659 11:27:39 INFO - 2015-11-15 11:27:39,314 DEBUG : actual date: 1447615659 11:27:39 INFO - 2015-11-15 11:27:39,325 INFO : starting webserver on 'localhost:58359' 11:27:39 INFO - 2015-11-15 11:27:39,326 INFO : Starting test suite t-yosemite-r5-0059 11:27:39 INFO - 2015-11-15 11:27:39,326 INFO : Starting test dromaeo_css 11:27:39 INFO - 2015-11-15 11:27:39,327 DEBUG : operating with platform_type : mac_ 11:27:39 INFO - 2015-11-15 11:27:39,327 INFO : Initialising browser for dromaeo_css test... 11:27:39 INFO - 2015-11-15 11:27:39,343 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpxp0BDH/profile http://localhost:58359/getInfo.html 11:27:42 INFO - 2015-11-15 11:27:42,036 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:27:42 INFO - 2015-11-15 11:27:42,036 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:27:42 INFO - 2015-11-15 11:27:42,036 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:27:42 INFO - 2015-11-15 11:27:42,036 DEBUG : BROWSER_OUTPUT: __metrics 11:27:42 INFO - 2015-11-15 11:27:42,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:42 INFO - 2015-11-15 11:27:42,898 INFO : Browser initialized. 11:27:42 INFO - 2015-11-15 11:27:42,898 INFO : Running cycle 1/1 for dromaeo_css test... 11:27:42 INFO - 2015-11-15 11:27:42,898 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpxp0BDH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:27:55 INFO - 2015-11-15 11:27:55,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 229089280 11:27:55 INFO - 2015-11-15 11:27:55,174 DEBUG : BROWSER_OUTPUT: 11:28:46 INFO - 2015-11-15 11:28:46,961 DEBUG : BROWSER_OUTPUT: 1447615726957 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] 11:30:56 INFO - 2015-11-15 11:30:56,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58359/tests/dromaeo/cssquery-ext.html) 11:30:58 INFO - 2015-11-15 11:30:58,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 372011008 11:30:58 INFO - 2015-11-15 11:30:58,313 DEBUG : BROWSER_OUTPUT: 11:34:01 INFO - 2015-11-15 11:34:01,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-ext.html (next: http://localhost:58359/tests/dromaeo/cssquery-jquery.html) 11:34:02 INFO - 2015-11-15 11:34:02,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 360505344 11:34:02 INFO - 2015-11-15 11:34:02,065 DEBUG : BROWSER_OUTPUT: 11:37:04 INFO - 2015-11-15 11:37:04,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58359/tests/dromaeo/cssquery-mootools.html) 11:37:05 INFO - 2015-11-15 11:37:05,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 327249920 11:37:05 INFO - 2015-11-15 11:37:05,135 DEBUG : BROWSER_OUTPUT: 11:40:07 INFO - 2015-11-15 11:40:07,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58359/tests/dromaeo/cssquery-prototype.html) 11:40:07 INFO - 2015-11-15 11:40:07,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 319311872 11:40:07 INFO - 2015-11-15 11:40:07,913 DEBUG : BROWSER_OUTPUT: 11:43:11 INFO - 2015-11-15 11:43:11,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58359/tests/dromaeo/cssquery-yui.html) 11:43:11 INFO - 2015-11-15 11:43:11,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 319098880 11:43:11 INFO - 2015-11-15 11:43:11,973 DEBUG : BROWSER_OUTPUT: 11:46:14 INFO - 2015-11-15 11:46:14,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/dromaeo/cssquery-yui.html (next: http://localhost:58359/tests/dromaeo/cssquery-dojo.html) 11:46:15 INFO - 2015-11-15 11:46:15,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 369037312 11:46:15 INFO - 2015-11-15 11:46:15,094 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,094 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:46:15 INFO - 2015-11-15 11:46:15,094 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:46:15 INFO - 2015-11-15 11:46:15,095 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:46:15 INFO - 2015-11-15 11:46:15,095 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:46:15 INFO - 2015-11-15 11:46:15,096 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2497.750224977502;2533.050106210171;2551.425929165937;2565.884535195916;2569.267758688773;4084.7753373564515;4202.621764041236;4227.704060715751;4242.363645453183;4299.505556860962;4167.6249137577615;4232.2805123129065;4271.42335784669;4431;4453.109378124372;3865.7100717446165;3982.3628219484744;3994.4607477990535;3999.840006399755;4026.758394496325;3704.8935633899637;3908.1988192420627;4032.6572241359518;4089.284375234337;4089.7137200395982;3867.651911327994;3920.3923391874305;3938.3107956107565;3943.6450719435247;3972.6424621784176;3856;3863.092173339263;3897.8440862365755;3906.7069969752383;3908.0620651043546;3851.5955824638568;3879.165979314461;3882.417637354391;3909.081365879016;3921.2353591049755;4062;4111.8560850370095;4113.588641135892;4148.23257697327;4227.619514243733;4435.356873253392;4518.27707566791;4523.547645235483;4561.657875659305;4562.064776720765;4475.530069342704;4496.325551167319;4531.705439146445;4549.340345649895;4575.775074172167;4114;4160.729552579072;4167.083241686824;4205.852795152155;4206.074663574009;4517.435320584927;4547.477040140427;4674.579287864109;4698.271767875985;4742.810287588527;4429.667774916894;4449.199144154083;4473.060657261946;4508.45898492183;4511.751853648081;4263.552327005682;4578.519255478127;4579.427571553556;4643.791029403685;4680.391549098664;4253.106847561985;4255.340422234559;4288;4453.688241823106;4577.862664120082;4492.640588752892;4493.348464472633;4508.842190523316;4529;4572.634189264851;3414.129397003748;3503.2993401319836;3533.611302756695;3567.3222087803233;3570.8036058016537;3147.3075923296838;3167.2715275486767;3181.7772755907326;3227.3383956288903;3292.0617623977532;4245.235857545671;4299.1831552005015;4319.308910574293;4347.5652434756275;4386.495553011381;4499.0776890737325;4542.863714088583;4570.748608826547;4604.355390245369;4605.6085232755595;4278.315469524861;4282.614564689193;4297.39836422901;4330.805113769888;4344.152890186383;4038.6163314485075;4051.858184963512;4066.0038290618986;4093.1404405074672;4158.6673066154635;4627.953720462887;4711.74085425298;4729.716217026989;4805.351277577623;4842.58837998767;4529.184746745617;4581.450225972904;4612.930806037845;4620.838270660511;4642.210824159968;4660.580547750718;4679.812807487799;4709.5290470954005;4713.7643117844655;4756.667033307635;4394.143142087262;4405.559444055569;4432.335149727567;4479.910401792011;4555.954440455553;4463.888402789957;4497.685162038626;4541.3415054816205;4592.357070010268;4619.792109355019;4436.268015777489;4455.465344158722;4468.687191896536;4518.525554816697;4590.770461476846;4269.423627810206;4380.8685739427865;4440.933385999278;4499.595036446735;4552.135094332067;4309.052008558112;4322.113966636769;4330.891727706832;4415.205263052681;4454.042380888124;4441.400410944481;4459.063596644741;4467.620252278462;4515.277555591089;4515.412996310459;4211.663066954698;4358.302671572533;4378.321360189176;4388.626966707738;4440.111977604557 11:46:15 INFO - 2015-11-15 11:46:15,100 DEBUG : BROWSER_OUTPUT: |1;ext.html;444.3224083273008;450.3897219267892;453.4694407543174;464.1112270002943;472.7116458960036;25515.74484255157;26022.86988565057;26056.348591285227;26379.868100659492;31903.36193276133;35044.47433288502;35289.47065794009;35573;35980;36006;7376.077990251232;7446.739364122257;7464.216257292987;7533.849323013536;7621.923780762205;6837.726490940357;6927.3419025192525;6969.58182509051;7278.563286202819;7380.2250763669845;8936.597853096626;9131.13254240846;9150.816983660323;9323.813523729521;9342.252619790435;8893.377463577584;8916.019237883827;8996.145366190201;9018.233450156744;9069.909300906973;6638.5684930479365;6760.729570817161;6847.17833859935;8708.869366959501;8755;32334.838325808454;32376.676233237602;32387.51418728721;32627.51058734097;32968.83515582431;2227.3095340444515;2266.2974477911735;2308.4459729664927;2327.301809457173;2386.737458879522;22274.65644199382;22326.55346893069;22490.55018899629;22514.887425562767;22810.54378912429;1941.2041063164036;1960.2649006622516;1986.414007867668;2011.3161525081543;2084.135083940163;208539;212089;212930;212997;213069;48758.75620621945;48814;48873.755631222324;49469.33225350077;49879.25181122286;45721.5427845724;46131.76934115375;46563.068738625036;52391.476085239425;54268;11137.498812553455;11182.21724479295;11412.771744565061;11420.486078126503;11508.136889733136;8678.220964702221;8747.343949203836;8772.210501054935;8816.074312197126;8877.156670116457;15537.766933496006;16039.358425663077;16118.838811611968;16212.37876212393;16236.350545978265;7099.112610923635;7163.391111755559;7231.385332246818;7311.524750891175;7312.23221561739;740.4853626729372;752.3561019173125;772.5441989226383;773.5165521549031;778.5212094561804;22405.88797056004;22515.211967581057;22682.319530414115;22780.772192277866;22786.202482913017;848.6647774129308;849.7705619482829;905.9637614495479;923.1783712495884;928.2481190235931;11849.940750296366;11925.463354149084;11929.761404771856;11937.761244775229;12009.399530023464;253371;262987;263783;265933;266640;44697;45028;45073.32390014153;45431;45534.772326138154;1098.5441041967495;1106.1151079136819;1111.4609414433994;1116.4529380603608;1125.2573301620891;22412.32763017112;22652;22673.433164171027;22775.430614234778;22990.631779962423;35776;36592.45111323279;43285.56714432815;44100.33849492324;46100.30849537327;202330;204621;205021;206495;207076;22310.330690079325;22328.66507002364;26016.219513414628;26041.348966275993;26167.345816354744;28850.422991540472;29273.414531708822;31128;34587.4811877817;37611.247775044896;27836.582451263654;28495.43009139764;28968;29007.7099229005;29272.121836344944;27699;27779;28195.859020704764;28258.85870570634;28786.136415907557;27416.588751169147;27467.175984720492;27496.312592184557;27637.861810691622;27716;21857.56284874262;22767.283156957637;23359.299221022717;23494.177703780286;24073.75926240715;18161.727574086133;18251.178696958403;18269.634607308046;18288.81711182871;18652.44239218574 11:46:15 INFO - 2015-11-15 11:46:15,101 DEBUG : BROWSER_OUTPUT: |2;jquery.html;265.02866992472576;267.06127960219817;268.84675734831154;271.8464067801693;273.1968014038726;10743.247972641899;11327.150463715234;13527.391267392966;14076.155430674167;14304.141751494904;11649.475773590188;13747.862521374784;13913.095648782823;14040.71918561628;15073.472428464978;4130.2978493656;4289.656827453812;4357;4370.409994650713;4370.8907277318;3091.5671805947186;3231.3451459945095;4253.766042867641;4400.691951563392;4586.587207151356;4663.440387153546;4695.1548721230165;4724.17326967781;4766.142094423002;4784.497627749089;4419.690621656486;4519.728816271001;4685.62514998801;4755.381800365947;4772.403449568804;4085.9387109193385;4104.363823607346;4109.527404348508;4140.4617399738145;4193.601607847249;16351.672966540722;16575.751363729552;16596.17019149038;16614;17207.82792172075;1621.3757703284202;1652.2234549761592;1699.1843914920785;1720.2688857235626;1805.5125116218549;10352.171826253882;10541.262111652188;10688.732781680443;11052;11222.607208747655;1295.8768916952874;1328.3491089366141;1328.701042265492;1332.120800271816;1340.8189894364332;43771.34342984858;45014.09971800578;45067.54932450666;45191.322130168075;45485.31772023422;7405.814854628569;7517.624118794039;7653.349465295512;7841.137474877759;7885.5662938538935;9390.765230869147;9405.341626086245;9426.858597120912;9464.763380915394;9608.183304419063;5795.681237531976;5805.477507024388;5811.651300921873;5862.443067908627;5970.641761494324;5568.832935011957;5614.578906582023;5630.971845140748;5636.915446268309;5703.9429605704245;4513.638908887281;4553.430821147356;4560.657950653715;4585.656075794262;4615;1223.5044806853239;1301.8958483321312;1329.195836518892;1335.7729186038396;1338.2706424998398;330.6412542391532;333.7866853985779;658.1082633032172;750.9662065207078;762.9433234969496;9256.72229833106;9393.5303234838;9518.904810951803;9597.760055998517;9663.565139568736;330.5075437597962;341.532101021602;352.6191712950059;362.13449854846937;365.6727229129967;4873.780679869415;4894.2658601210105;4936;5041.6470847040355;5057.317262169634;451384;455633;464893;466376;481161;51244.231336529985;53613.46386536163;53884.191737123976;54427.45572544224;54680.45319546833;397.3304981106844;398.67308806778743;400.7335122143742;401.25967589797364;409.0387589165497;8469.57652117404;8507.064222935596;8537.487750734976;8639.95680021596;8705.782355441164;26206.475870482864;26503.469930601666;26516.071937482095;26540.734592653826;27317.590236146872;36107.81946090253;36832.26335473222;36982.26035479329;37528.43707344447;37586.2482750338;4903.215485522299;4906.730129842893;4948.158813001726;5079.3904731430985;5120.436751957207;9153.542322883695;9217.354785165242;9285.953570232106;9368.25053995665;9372.250219982521;7927.960360198162;7969.681212751425;8119.228673276029;8121.715739949073;8295.004599447864;7872.921270787218;7967.28294453502;8027.157148499324;8028.839423211386;8212.17878212174;6976.860462790817;7671.693132274647;7831.608419579112;8241.876371854547;8315.210055044761;4492.618127459072;4620;4726.692764970266;5026.74866256693;5113.897722045613;8047.637856296597;8054.194580541899;8198;8336.83326333482;8395.538245396318 11:46:15 INFO - 2015-11-15 11:46:15,105 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1072.2762135558505;1381.92399418032;1439.1868594244252;1480.1711041816584;1484.5249520153548;5773.855653608662;5999.550033747465;6369.07648390983;6390.96804515978;6526.80419587412;6241.375862413756;6268.561200715952;6394.168758061457;6517.0224466329955;6534.411902928736;1798.163853807979;1815.537038055294;1833.2117189608464;1838.1268897273756;1843.5575461889116;1833.1933949062436;1850.3431281894934;1859.9677179165626;1884.3028079610563;1902.258119333461;1823.9421135741238;1824.8631352648604;1838.4944140361374;1844.9815501844944;1857.4799056264267;1796.470041337802;1814.0748218408708;1814.6098588803338;1855.9257629694796;1860.0327829528705;1801.711726123827;1806.6206096719573;1826.6255417639486;1833.0468156558647;1867.2064372641573;5412;6399.616023038632;6438.935610643881;6466.321036291216;6540.640264785482;3593.1735700788704;3725.1990821973136;3931.8230679619487;4044.2315959967514;4149.315362965107;2232.073689418889;2251.718535183102;2284.4060544258446;2311.6994790677104;2314.409825494505;728.0753443127252;738.1658725640046;746.2947514598707;771.3944553525512;771.5139462138873;8521.14788521149;8546.957265213634;8589.484630922103;8613.267872230868;8792.076831932683;3616.0959760059986;3705.0366904605;3768.6231376862092;3769.0012146781123;3851.8459261629223;7548.698052077855;7549.962250188714;7609.429292803062;7647.464677472523;7719.073711154585;4104.548499665035;4118.320477121301;4125.1749650070105;4134.069834287261;4200.6219440250525;3700.2414505026404;3703.777773333609;3740.3080430120513;3752.587215406303;3804.087019115392;2887.9133625991253;2911.4468251032235;2935.324875278698;2940.1179646106084;2997.310618557744;952.6189524190379;957.0716405087054;960.5437417226761;960.865478832964;961.7451375385529;814.1776805426562;838.2497664590157;841.4194205997842;853.3301358433599;984.8424252119627;6062.514998800086;6063.363346848606;6109.541784366191;6158.384161583896;6163.260408750979;371.27786455344636;389.33423845224985;393.2920742663195;398.6213097557274;398.63126607887585;4493.1013797240685;4507.5943165115295;4531.546845315442;4582.312653102062;4598.655100867449;7063.540869843547;7170.964145179345;7201.171865235565;7373.594452305175;7629;7387.8153046174275;7638.770836874903;7640;7662.003939487942;7674.386049116169;5920;5946.07835785454;6003.939960600425;6049.546284028627;6051.213342265477;6054.8183554493435;6104.053871649901;6116.17431646722;6134.110553969738;6142.539309551712;6674.499412543982;6776.864462710817;6816.216135144324;6837.213720422215;6944.444444444332;6929.099217101744;6939.028536004862;6968.547044442095;7038.542494737826;7236.167840698176;5961.314448838439;6038.245219347582;6103.938960610337;6117.694115294306;6168.352323006199;6011.939880601138;6099.207103076572;6132.969335153474;6155;6262.68686565679;5621.831345059655;5726.942730572641;5795.768169273182;5796.101604251347;5844.415558444121;5515.09001014828;5557.44425557441;5557.833265002057;5583.972080139573;5615.943840561542;5715.742791574472;5786.884262314814;5788.507976822018;5824.126381042877;5861.238039054895;5176.1200595899545;5186.870328241674;5227.477252274742;5258;5347.732613369239;5199.428062913152;5308.495692909322;5363.249145119765;5365.919511207257;5397.487238712473 11:46:15 INFO - 2015-11-15 11:46:15,106 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.56353726284905;252.59962958710443;255.18086940919648;259.40725442364203;262.8225947485448;4891.926621100682;5026.849194524161;5026.924596131061;5063.772130254139;5112.8977420451565;4576.954230457694;4888.266759986004;4936.753162341877;4952.479989601094;4970.353853998975;3809.257194847006;3825.8087095645246;3850.4609354690365;3900.1029763154493;3924.666403355718;3843.903902402434;3846.4807251021175;3877.689784817222;3889.3776995680696;3903.1022864741126;3792.184680293736;3819.560750513685;3843.154506008688;3865;3868.78721670308;3810.2760475509563;3850.537935447764;3857.40210267409;3882.4758657581287;3885.04816320002;3243.8702451901895;3284.786488878215;3303.9008829734908;3327.317899830529;3354.76516643835;4839.467658557556;4882.194437917739;4899.951000489985;4916.508349165055;4917.483664215241;4279.1869544786705;4283.850065247701;4299.785010749481;4311.33174357975;4344.1311737652595;5209.088409528317;5210.557102646279;5286.735663216824;5297.735113244361;5299.814506492255;3447;3554.9111272218142;3592.6946209572216;3627.5102861113673;3627.673509384168;5178.482151784829;5414.29614150158;5451.155070964007;5551.306086739158;5567.081431563827;3541.220931395089;3572.1962558424666;3655.9817200913826;3690.2250527389547;3719.3305205062807;3588.120910376922;3638.6725194732603;3747.8500859965843;3775.9244815103543;3777.0557360659836;4182.435371224846;4257.57424257578;4276.807543660543;4351.4995775485595;4371.978140109279;5209.192575150858;5220.216967454912;5309.33633295838;5312.176612624972;5327.147656375039;1284.2808027504627;1306.817045613615;1319.1359659423092;1327.0246368918838;1334.3995202159067;836.4981011393115;857.4512312120248;869.0483920107472;869.7347309070668;881.9725020351348;5077.923831142536;5078.5937125029905;5087;5149.922751158736;5175.327207463081;5432.158015507603;5447.155690867922;5540.972295138498;5554.1113421853115;5556.277683901148;5071.644984851099;5074.4671809460215;5153.304303918998;5166.044281807877;5182.507661772125;2812.2406950123354;2951.3211961249035;2955.12823717004;2996.1460983619563;2998.835064071497;5636.351819540805;5664.688442135722;5751.884962300731;5760.3951585083805;5767.106098554731;5558;5569.220309156722;5646.971765141148;5651.858703532363;5680.914786278209;5654.134135735279;5658.26442562456;5749.942500574941;5755.568332375088;5761.769529218785;5289;5401.783928642811;5424.294841670558;5450.138677194504;5514.696691681836;5313.973430132979;5354.11657076578;5355.839324820262;5360.62475626718;5403.351597808131;5640.520555752807;5728.79949201776;5740.684262365443;5741.16753070794;5757.0788673811985;3694.9815250923575;3717.5353080864893;3728.6457786510236;3755.868544600926;3760.172761992357;5250.369955605352;5358.142697168434;5502.202180683858;5513.200585914939;5515.889682206253;5183.0670479314085;5262.0528304903955;5380.623356365017;5409.6213265071065;5434.782608695607;5273.44628813969;5307.442718514655;5415.972920135374;5429.782808687766;5435.891282174413;5210.218467229945;5249.527542521038;5276.366835979707;5278.313819203479;5294.8941021180135;5155.53600175986;5325.920111198413;5401.918971215514;5409.486098820606;5428.348598168245;5185.403678577012;5247.239150323258;5290.81482148123;5297.020051290524;5306.893862122659 11:46:15 INFO - 2015-11-15 11:46:15,109 DEBUG : BROWSER_OUTPUT: |5;yui.html;503.9697618142912;554.9972250138749;585.7891159182693;608.0848323273475;615.0988801405941;11306.265092768965;11330.376829274397;11520.135989800767;11536.307821530703;11557.248778829371;10521.263511554194;11683.06535477162;11791.705207369798;12008.279503229813;12024.218425802317;556.2074044486591;574.8419184724193;703.6341102626631;707.0596107177441;717.4188906985332;559.1612581128308;684.9657017902978;687.4088284075691;691.1360799001249;707.1443553300512;684.329357229915;718.4683334332583;720.722521829097;724.1852915470096;736.808429808251;570.3213176320165;573.9799107031234;575.8330084275597;723.7864829875199;725.354434553248;516.1483552138964;517.1544524702101;517.5781737883613;525.9211118332281;526.7761201489352;10714.517846696917;11129.220954533186;11172.944135279353;11197.552097916074;11345.319280843176;7655.272749088827;7832.804179895491;8004.51972881629;8068.556229407381;8110.972256935766;7186.425085993108;7304.953284005466;7350.7427240046345;7402.666879990414;7407.370646445235;2276.920307789236;2387.2957477544164;2388.080588973258;2422.2369953464604;2427.684401027855;37839.810800945816;37915.62084379148;37993.620063799564;38152.427713584315;38600.22799544022;5504.256925315031;5542.944570554243;5564.888702225933;5588.944110558924;5676.654200873076;9689.12797848197;9727.513624318755;9735.269854760922;9888.258380621483;9930.05664461875;4797.4482934462285;4815.638827087912;4925.679830811057;4940.925886111711;5029.346184996;2987.118799954019;3054.618172728409;3055.679153688875;3110.315730539278;3155.4793459079456;2173.0873033326043;2175.5866385386726;2191.5178660694623;2219.3674802681157;2236.865788052722;331.2645926044178;331.98008119512906;336.3088852408324;339.1927213232491;342.83543898928156;444.17605342090604;452.79397873967264;482.8020511590231;483.45369732202386;485.47811103064345;6250.781222657185;6475.902861457082;6543.869122617521;6613;6638.17022872141;378.0850342171951;421.66898984297177;472.52275202046184;482.2091769498026;508.5988102776826;3026.1678038539576;3051.9389612207633;3083.182956516525;3141.5758872551914;3154.4006638738565;46823.29765053527;47773.5222647776;48030.27954580684;48400;48491;38791.41812872809;40033.79983100066;40654.79672601677;40848.59151408448;40854.79572602118;36898.8155059223;37326.44010339847;37370.626293736714;38069.80965095212;38531.80734096312;6433.356664333529;6756.527043106936;6816.420604248694;6818.318168183142;6819.283975182534;27101.457970840867;27673.72326276792;27730.306742331602;27978.58032129479;28040;34337;35862.64137358593;37399;37582.8120859394;38332.616673832905;5851.356350801493;6213.130161777264;6296;6404.583702059351;6451.677416129269;8712.91287087121;8823.823523529622;8830.558472076498;8953.418027828171;9014.81970360576;8129.187081291823;8172;8196.983318349767;8389.161083891562;8399.874001889855;8410.074891762024;8575.356848236283;8700.695475658322;8717.956410218161;8731.781705457415;8301.418900677136;8622.223999840044;8628.89359830448;8639.740807775777;8650.30797536183;7283.162436319891;7314.817129571803;7424.740134095497;7725.111612164673;7727.956725842164;7094.574325540484;7404.148522919933;7467.813304667427;7604.80987975305;7672.501287416523 11:46:15 INFO - 2015-11-15 11:46:15,110 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:46:15 INFO - 2015-11-15 11:46:15,110 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:46:15 INFO - 2015-11-15 11:46:15,110 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1451 11:46:15 INFO - 2015-11-15 11:46:15,110 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:46:15 INFO - 2015-11-15 11:46:15,110 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616775092__endTimestamp 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4235.18 Median:4378.32 stddev:454.07 (10.4%) stddev-sans-first:434.52 11:46:15 INFO - 2015-11-15 11:46:15,111 DEBUG : BROWSER_OUTPUT: Values: 2497.8 2533.1 2551.4 2565.9 2569.3 4084.8 4202.6 4227.7 4242.4 4299.5 4167.6 4232.3 4271.4 4431.0 4453.1 3865.7 3982.4 3994.5 3999.8 4026.8 3704.9 3908.2 4032.7 4089.3 4089.7 3867.7 3920.4 3938.3 3943.6 3972.6 3856.0 3863.1 3897.8 3906.7 3908.1 3851.6 3879.2 3882.4 3909.1 3921.2 4062.0 4111.9 4113.6 4148.2 4227.6 4435.4 4518.3 4523.5 4561.7 4562.1 4475.5 4496.3 4531.7 4549.3 4575.8 4114.0 4160.7 4167.1 4205.9 4206.1 4517.4 4547.5 4674.6 4698.3 4742.8 4429.7 4449.2 4473.1 4508.5 4511.8 4263.6 4578.5 4579.4 4643.8 4680.4 4253.1 4255.3 4288.0 4453.7 4577.9 4492.6 4493.3 4508.8 4529.0 4572.6 3414.1 3503.3 3533.6 3567.3 3570.8 3147.3 3167.3 3181.8 3227.3 3292.1 4245.2 4299.2 4319.3 4347.6 4386.5 4499.1 4542.9 4570.7 4604.4 4605.6 4278.3 4282.6 4297.4 4330.8 4344.2 4038.6 4051.9 4066.0 4093.1 4158.7 4628.0 4711.7 4729.7 4805.4 4842.6 4529.2 4581.5 4612.9 4620.8 4642.2 4660.6 4679.8 4709.5 4713.8 4756.7 4394.1 4405.6 4432.3 4479.9 4556.0 4463.9 4497.7 4541.3 4592.4 4619.8 4436.3 4455.5 4468.7 4518.5 4590.8 4269.4 4380.9 4440.9 4499.6 4552.1 4309.1 4322.1 4330.9 4415.2 4454.0 4441.4 4459.1 4467.6 4515.3 4515.4 4211.7 4358.3 4378.3 4388.6 4440.1 11:46:15 INFO - 2015-11-15 11:46:15,112 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,112 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36471.44 Median:28818.28 stddev:59594.59 (206.8%) stddev-sans-first:59700.38 11:46:15 INFO - 2015-11-15 11:46:15,112 DEBUG : BROWSER_OUTPUT: Values: 444.3 450.4 453.5 464.1 472.7 25515.7 26022.9 26056.3 26379.9 31903.4 35044.5 35289.5 35573.0 35980.0 36006.0 7376.1 7446.7 7464.2 7533.8 7621.9 6837.7 6927.3 6969.6 7278.6 7380.2 8936.6 9131.1 9150.8 9323.8 9342.3 8893.4 8916.0 8996.1 9018.2 9069.9 6638.6 6760.7 6847.2 8708.9 8755.0 32334.8 32376.7 32387.5 32627.5 32968.8 2227.3 2266.3 2308.4 2327.3 2386.7 22274.7 22326.6 22490.6 22514.9 22810.5 1941.2 1960.3 1986.4 2011.3 2084.1 208539.0 212089.0 212930.0 212997.0 213069.0 48758.8 48814.0 48873.8 49469.3 49879.3 45721.5 46131.8 46563.1 52391.5 54268.0 11137.5 11182.2 11412.8 11420.5 11508.1 8678.2 8747.3 8772.2 8816.1 8877.2 15537.8 16039.4 16118.8 16212.4 16236.4 7099.1 7163.4 7231.4 7311.5 7312.2 740.5 752.4 772.5 773.5 778.5 22405.9 22515.2 22682.3 22780.8 22786.2 848.7 849.8 906.0 923.2 928.2 11849.9 11925.5 11929.8 11937.8 12009.4 253371.0 262987.0 263783.0 265933.0 266640.0 44697.0 45028.0 45073.3 45431.0 45534.8 1098.5 1106.1 1111.5 1116.5 1125.3 22412.3 22652.0 22673.4 22775.4 22990.6 35776.0 36592.5 43285.6 44100.3 46100.3 202330.0 204621.0 205021.0 206495.0 207076.0 22310.3 22328.7 26016.2 26041.3 26167.3 28850.4 29273.4 31128.0 34587.5 37611.2 27836.6 28495.4 28968.0 29007.7 29272.1 27699.0 27779.0 28195.9 28258.9 28786.1 27416.6 27467.2 27496.3 27637.9 27716.0 21857.6 22767.3 23359.3 23494.2 24073.8 18161.7 18251.2 18269.6 18288.8 18652.4 11:46:15 INFO - 2015-11-15 11:46:15,112 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,112 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22636.22 Median:4600.79 stddev:75761.63 (1646.7%) stddev-sans-first:75955.54 11:46:15 INFO - 2015-11-15 11:46:15,114 DEBUG : BROWSER_OUTPUT: Values: 265.0 267.1 268.8 271.8 273.2 10743.2 11327.2 13527.4 14076.2 14304.1 11649.5 13747.9 13913.1 14040.7 15073.5 4130.3 4289.7 4357.0 4370.4 4370.9 3091.6 3231.3 4253.8 4400.7 4586.6 4663.4 4695.2 4724.2 4766.1 4784.5 4419.7 4519.7 4685.6 4755.4 4772.4 4085.9 4104.4 4109.5 4140.5 4193.6 16351.7 16575.8 16596.2 16614.0 17207.8 1621.4 1652.2 1699.2 1720.3 1805.5 10352.2 10541.3 10688.7 11052.0 11222.6 1295.9 1328.3 1328.7 1332.1 1340.8 43771.3 45014.1 45067.5 45191.3 45485.3 7405.8 7517.6 7653.3 7841.1 7885.6 9390.8 9405.3 9426.9 9464.8 9608.2 5795.7 5805.5 5811.7 5862.4 5970.6 5568.8 5614.6 5631.0 5636.9 5703.9 4513.6 4553.4 4560.7 4585.7 4615.0 1223.5 1301.9 1329.2 1335.8 1338.3 330.6 333.8 658.1 751.0 762.9 9256.7 9393.5 9518.9 9597.8 9663.6 330.5 341.5 352.6 362.1 365.7 4873.8 4894.3 4936.0 5041.6 5057.3 451384.0 455633.0 464893.0 466376.0 481161.0 51244.2 53613.5 53884.2 54427.5 54680.5 397.3 398.7 400.7 401.3 409.0 8469.6 8507.1 8537.5 8640.0 8705.8 26206.5 26503.5 26516.1 26540.7 27317.6 36107.8 36832.3 36982.3 37528.4 37586.2 4903.2 4906.7 4948.2 5079.4 5120.4 9153.5 9217.4 9286.0 9368.3 9372.3 7928.0 7969.7 8119.2 8121.7 8295.0 7872.9 7967.3 8027.2 8028.8 8212.2 6976.9 7671.7 7831.6 8241.9 8315.2 4492.6 4620.0 4726.7 5026.7 5113.9 8047.6 8054.2 8198.0 8336.8 8395.5 11:46:15 INFO - 2015-11-15 11:46:15,114 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,114 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4463.88 Median:5787.70 stddev:2333.16 (40.3%) stddev-sans-first:2325.78 11:46:15 INFO - 2015-11-15 11:46:15,116 DEBUG : BROWSER_OUTPUT: Values: 1072.3 1381.9 1439.2 1480.2 1484.5 5773.9 5999.6 6369.1 6391.0 6526.8 6241.4 6268.6 6394.2 6517.0 6534.4 1798.2 1815.5 1833.2 1838.1 1843.6 1833.2 1850.3 1860.0 1884.3 1902.3 1823.9 1824.9 1838.5 1845.0 1857.5 1796.5 1814.1 1814.6 1855.9 1860.0 1801.7 1806.6 1826.6 1833.0 1867.2 5412.0 6399.6 6438.9 6466.3 6540.6 3593.2 3725.2 3931.8 4044.2 4149.3 2232.1 2251.7 2284.4 2311.7 2314.4 728.1 738.2 746.3 771.4 771.5 8521.1 8547.0 8589.5 8613.3 8792.1 3616.1 3705.0 3768.6 3769.0 3851.8 7548.7 7550.0 7609.4 7647.5 7719.1 4104.5 4118.3 4125.2 4134.1 4200.6 3700.2 3703.8 3740.3 3752.6 3804.1 2887.9 2911.4 2935.3 2940.1 2997.3 952.6 957.1 960.5 960.9 961.7 814.2 838.2 841.4 853.3 984.8 6062.5 6063.4 6109.5 6158.4 6163.3 371.3 389.3 393.3 398.6 398.6 4493.1 4507.6 4531.5 4582.3 4598.7 7063.5 7171.0 7201.2 7373.6 7629.0 7387.8 7638.8 7640.0 7662.0 7674.4 5920.0 5946.1 6003.9 6049.5 6051.2 6054.8 6104.1 6116.2 6134.1 6142.5 6674.5 6776.9 6816.2 6837.2 6944.4 6929.1 6939.0 6968.5 7038.5 7236.2 5961.3 6038.2 6103.9 6117.7 6168.4 6011.9 6099.2 6133.0 6155.0 6262.7 5621.8 5726.9 5795.8 5796.1 5844.4 5515.1 5557.4 5557.8 5584.0 5615.9 5715.7 5786.9 5788.5 5824.1 5861.2 5176.1 5186.9 5227.5 5258.0 5347.7 5199.4 5308.5 5363.2 5365.9 5397.5 11:46:15 INFO - 2015-11-15 11:46:15,116 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,116 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4427.68 Median:5151.61 stddev:1354.13 (26.3%) stddev-sans-first:1321.15 11:46:15 INFO - 2015-11-15 11:46:15,117 DEBUG : BROWSER_OUTPUT: Values: 251.6 252.6 255.2 259.4 262.8 4891.9 5026.8 5026.9 5063.8 5112.9 4577.0 4888.3 4936.8 4952.5 4970.4 3809.3 3825.8 3850.5 3900.1 3924.7 3843.9 3846.5 3877.7 3889.4 3903.1 3792.2 3819.6 3843.2 3865.0 3868.8 3810.3 3850.5 3857.4 3882.5 3885.0 3243.9 3284.8 3303.9 3327.3 3354.8 4839.5 4882.2 4900.0 4916.5 4917.5 4279.2 4283.9 4299.8 4311.3 4344.1 5209.1 5210.6 5286.7 5297.7 5299.8 3447.0 3554.9 3592.7 3627.5 3627.7 5178.5 5414.3 5451.2 5551.3 5567.1 3541.2 3572.2 3656.0 3690.2 3719.3 3588.1 3638.7 3747.9 3775.9 3777.1 4182.4 4257.6 4276.8 4351.5 4372.0 5209.2 5220.2 5309.3 5312.2 5327.1 1284.3 1306.8 1319.1 1327.0 1334.4 836.5 857.5 869.0 869.7 882.0 5077.9 5078.6 5087.0 5149.9 5175.3 5432.2 5447.2 5541.0 5554.1 5556.3 5071.6 5074.5 5153.3 5166.0 5182.5 2812.2 2951.3 2955.1 2996.1 2998.8 5636.4 5664.7 5751.9 5760.4 5767.1 5558.0 5569.2 5647.0 5651.9 5680.9 5654.1 5658.3 5749.9 5755.6 5761.8 5289.0 5401.8 5424.3 5450.1 5514.7 5314.0 5354.1 5355.8 5360.6 5403.4 5640.5 5728.8 5740.7 5741.2 5757.1 3695.0 3717.5 3728.6 3755.9 3760.2 5250.4 5358.1 5502.2 5513.2 5515.9 5183.1 5262.1 5380.6 5409.6 5434.8 5273.4 5307.4 5416.0 5429.8 5435.9 5210.2 5249.5 5276.4 5278.3 5294.9 5155.5 5325.9 5401.9 5409.5 5428.3 5185.4 5247.2 5290.8 5297.0 5306.9 11:46:15 INFO - 2015-11-15 11:46:15,118 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,118 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10624.94 Median:3015.52 stddev:13009.74 (431.4%) stddev-sans-first:13024.04 11:46:15 INFO - 2015-11-15 11:46:15,119 DEBUG : BROWSER_OUTPUT: Values: 504.0 555.0 585.8 608.1 615.1 11306.3 11330.4 11520.1 11536.3 11557.2 10521.3 11683.1 11791.7 12008.3 12024.2 556.2 574.8 703.6 707.1 717.4 559.2 685.0 687.4 691.1 707.1 684.3 718.5 720.7 724.2 736.8 570.3 574.0 575.8 723.8 725.4 516.1 517.2 517.6 525.9 526.8 10714.5 11129.2 11172.9 11197.6 11345.3 7655.3 7832.8 8004.5 8068.6 8111.0 7186.4 7305.0 7350.7 7402.7 7407.4 2276.9 2387.3 2388.1 2422.2 2427.7 37839.8 37915.6 37993.6 38152.4 38600.2 5504.3 5542.9 5564.9 5588.9 5676.7 9689.1 9727.5 9735.3 9888.3 9930.1 4797.4 4815.6 4925.7 4940.9 5029.3 2987.1 3054.6 3055.7 3110.3 3155.5 2173.1 2175.6 2191.5 2219.4 2236.9 331.3 332.0 336.3 339.2 342.8 444.2 452.8 482.8 483.5 485.5 6250.8 6475.9 6543.9 6613.0 6638.2 378.1 421.7 472.5 482.2 508.6 3026.2 3051.9 3083.2 3141.6 3154.4 46823.3 47773.5 48030.3 48400.0 48491.0 38791.4 40033.8 40654.8 40848.6 40854.8 36898.8 37326.4 37370.6 38069.8 38531.8 6433.4 6756.5 6816.4 6818.3 6819.3 27101.5 27673.7 27730.3 27978.6 28040.0 34337.0 35862.6 37399.0 37582.8 38332.6 5851.4 6213.1 6296.0 6404.6 6451.7 8712.9 8823.8 8830.6 8953.4 9014.8 8129.2 8172.0 8197.0 8389.2 8399.9 8410.1 8575.4 8700.7 8718.0 8731.8 8301.4 8622.2 8628.9 8639.7 8650.3 7283.2 7314.8 7424.7 7725.1 7728.0 7094.6 7404.1 7467.8 7604.8 7672.5 11:46:15 INFO - 2015-11-15 11:46:15,119 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:46:15 INFO - 2015-11-15 11:46:15,119 DEBUG : BROWSER_OUTPUT: 11:46:15 INFO - 2015-11-15 11:46:15,647 INFO : Browser exited with error code: 0 11:46:15 INFO - 2015-11-15 11:46:15,682 INFO : Completed test dromaeo_css (00:18:36) 11:46:15 INFO - 2015-11-15 11:46:15,682 INFO : Starting test kraken 11:46:15 INFO - 2015-11-15 11:46:15,682 DEBUG : operating with platform_type : mac_ 11:46:15 INFO - 2015-11-15 11:46:15,683 INFO : Initialising browser for kraken test... 11:46:15 INFO - 2015-11-15 11:46:15,699 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmp4iZLYe/profile http://localhost:58359/getInfo.html 11:46:18 INFO - 2015-11-15 11:46:18,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:46:18 INFO - 2015-11-15 11:46:18,362 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:46:18 INFO - 2015-11-15 11:46:18,362 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:46:18 INFO - 2015-11-15 11:46:18,362 DEBUG : BROWSER_OUTPUT: __metrics 11:46:18 INFO - 2015-11-15 11:46:18,378 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:46:19 INFO - 2015-11-15 11:46:19,204 INFO : Browser initialized. 11:46:19 INFO - 2015-11-15 11:46:19,204 INFO : Running cycle 1/1 for kraken test... 11:46:19 INFO - 2015-11-15 11:46:19,205 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmp4iZLYe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:46:31 INFO - 2015-11-15 11:46:31,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 228614144 11:46:31 INFO - 2015-11-15 11:46:31,438 DEBUG : BROWSER_OUTPUT: 11:46:34 INFO - 2015-11-15 11:46:34,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58359/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:35 INFO - 2015-11-15 11:46:35,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 286167040 11:46:35 INFO - 2015-11-15 11:46:35,049 DEBUG : BROWSER_OUTPUT: 11:46:38 INFO - 2015-11-15 11:46:38,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58359/tests/kraken/driver.html?testName=audio-dft) 11:46:38 INFO - 2015-11-15 11:46:38,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 299737088 11:46:38 INFO - 2015-11-15 11:46:38,853 DEBUG : BROWSER_OUTPUT: 11:46:42 INFO - 2015-11-15 11:46:42,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58359/tests/kraken/driver.html?testName=audio-fft) 11:46:42 INFO - 2015-11-15 11:46:42,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 284164096 11:46:42 INFO - 2015-11-15 11:46:42,984 DEBUG : BROWSER_OUTPUT: 11:46:45 INFO - 2015-11-15 11:46:45,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58359/tests/kraken/driver.html?testName=audio-oscillator) 11:46:45 INFO - 2015-11-15 11:46:45,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 284413952 11:46:45 INFO - 2015-11-15 11:46:45,936 DEBUG : BROWSER_OUTPUT: 11:46:48 INFO - 2015-11-15 11:46:48,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:49 INFO - 2015-11-15 11:46:49,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 285962240 11:46:49 INFO - 2015-11-15 11:46:49,100 DEBUG : BROWSER_OUTPUT: 11:46:52 INFO - 2015-11-15 11:46:52,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58359/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:53 INFO - 2015-11-15 11:46:53,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 280264704 11:46:53 INFO - 2015-11-15 11:46:53,342 DEBUG : BROWSER_OUTPUT: 11:46:57 INFO - 2015-11-15 11:46:57,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58359/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:57 INFO - 2015-11-15 11:46:57,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 282382336 11:46:57 INFO - 2015-11-15 11:46:57,758 DEBUG : BROWSER_OUTPUT: 11:47:01 INFO - 2015-11-15 11:47:01,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58359/tests/kraken/driver.html?testName=json-parse-financial) 11:47:01 INFO - 2015-11-15 11:47:01,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 281530368 11:47:01 INFO - 2015-11-15 11:47:01,722 DEBUG : BROWSER_OUTPUT: 11:47:03 INFO - 2015-11-15 11:47:03,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:04 INFO - 2015-11-15 11:47:04,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 320749568 11:47:04 INFO - 2015-11-15 11:47:04,083 DEBUG : BROWSER_OUTPUT: 11:47:06 INFO - 2015-11-15 11:47:06,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:06 INFO - 2015-11-15 11:47:06,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 320012288 11:47:06 INFO - 2015-11-15 11:47:06,853 DEBUG : BROWSER_OUTPUT: 11:47:09 INFO - 2015-11-15 11:47:09,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:09 INFO - 2015-11-15 11:47:09,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 323772416 11:47:09 INFO - 2015-11-15 11:47:09,963 DEBUG : BROWSER_OUTPUT: 11:47:13 INFO - 2015-11-15 11:47:13,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:13 INFO - 2015-11-15 11:47:13,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 325390336 11:47:13 INFO - 2015-11-15 11:47:13,672 DEBUG : BROWSER_OUTPUT: 11:47:16 INFO - 2015-11-15 11:47:16,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:17 INFO - 2015-11-15 11:47:17,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 318730240 11:47:17 INFO - 2015-11-15 11:47:17,385 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58359/tests/kraken/driver.html?testName=ai-astar) 11:47:19 INFO - 2015-11-15 11:47:19,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 379940864 11:47:19 INFO - 2015-11-15 11:47:19,659 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,660 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;137;137;139;140;139;135;132;134;152 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;199;170;196;207;163;191;187;163;208;164 11:47:19 INFO - 2015-11-15 11:47:19,661 DEBUG : BROWSER_OUTPUT: |2;audio-dft;200;206;204;206;208;207;207;198;202;205 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |3;audio-fft;94;93;108;156;86;89;90;89;150;86 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;120;120;175;114;115;117;160;113;115;156 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;155;148;149;153;141;148;155;148;145;142 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;170;162;159;155;163;163;163;158;154 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;120;120;130;120;131;120;120;129;121;119 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;70;73;72;75;77;76;78;77;76 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;81;84;85;84;91;91;90;91;90;88 11:47:19 INFO - 2015-11-15 11:47:19,662 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;102;102;107;111;108;109;110;109;122;113 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;171;176;165;157;171;156;157;157;162;161 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;188;182;197;195;185;179;193;196;198;176 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;86;89;91;91;89;89;91;91;88 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1036 11:47:19 INFO - 2015-11-15 11:47:19,663 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:47:19 INFO - 2015-11-15 11:47:19,664 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616839659__endTimestamp 11:47:19 INFO - 2015-11-15 11:47:19,664 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,665 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:47:19 INFO - 2015-11-15 11:47:19,665 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:47:19 INFO - 2015-11-15 11:47:19,665 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,665 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:137.50 Median:138.00 stddev:6.02 (4.4%) stddev-sans-first:5.74 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: Values: 130.0 137.0 137.0 139.0 140.0 139.0 135.0 132.0 134.0 152.0 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:184.80 Median:193.50 stddev:18.27 (9.4%) stddev-sans-first:18.64 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: Values: 199.0 170.0 196.0 207.0 163.0 191.0 187.0 163.0 208.0 164.0 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.30 Median:206.00 stddev:3.30 (1.6%) stddev-sans-first:3.11 11:47:19 INFO - 2015-11-15 11:47:19,666 DEBUG : BROWSER_OUTPUT: Values: 200.0 206.0 204.0 206.0 208.0 207.0 207.0 198.0 202.0 205.0 11:47:19 INFO - 2015-11-15 11:47:19,667 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,667 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:104.10 Median:89.00 stddev:26.56 (29.8%) stddev-sans-first:27.92 11:47:19 INFO - 2015-11-15 11:47:19,667 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 108.0 156.0 86.0 89.0 90.0 89.0 150.0 86.0 11:47:19 INFO - 2015-11-15 11:47:19,667 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,667 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:130.50 Median:120.00 stddev:23.48 (19.6%) stddev-sans-first:24.60 11:47:19 INFO - 2015-11-15 11:47:19,668 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 175.0 114.0 115.0 117.0 160.0 113.0 115.0 156.0 11:47:19 INFO - 2015-11-15 11:47:19,668 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,668 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:148.40 Median:148.50 stddev:4.90 (3.3%) stddev-sans-first:4.58 11:47:19 INFO - 2015-11-15 11:47:19,668 DEBUG : BROWSER_OUTPUT: Values: 155.0 148.0 149.0 153.0 141.0 148.0 155.0 148.0 145.0 142.0 11:47:19 INFO - 2015-11-15 11:47:19,668 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,669 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:161.00 Median:163.00 stddev:4.67 (2.9%) stddev-sans-first:4.89 11:47:19 INFO - 2015-11-15 11:47:19,670 DEBUG : BROWSER_OUTPUT: Values: 163.0 170.0 162.0 159.0 155.0 163.0 163.0 163.0 158.0 154.0 11:47:19 INFO - 2015-11-15 11:47:19,670 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,670 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.00 Median:120.50 stddev:4.88 (4.0%) stddev-sans-first:5.05 11:47:19 INFO - 2015-11-15 11:47:19,670 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 130.0 120.0 131.0 120.0 120.0 129.0 121.0 119.0 11:47:19 INFO - 2015-11-15 11:47:19,670 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,671 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:76.00 stddev:3.54 (4.7%) stddev-sans-first:2.67 11:47:19 INFO - 2015-11-15 11:47:19,671 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 73.0 72.0 75.0 77.0 76.0 78.0 77.0 76.0 11:47:19 INFO - 2015-11-15 11:47:19,671 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,671 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:87.50 Median:90.00 stddev:3.69 (4.1%) stddev-sans-first:3.07 11:47:19 INFO - 2015-11-15 11:47:19,672 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 85.0 84.0 91.0 91.0 90.0 91.0 90.0 88.0 11:47:19 INFO - 2015-11-15 11:47:19,672 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,672 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:109.30 Median:109.50 stddev:5.70 (5.2%) stddev-sans-first:5.40 11:47:19 INFO - 2015-11-15 11:47:19,672 DEBUG : BROWSER_OUTPUT: Values: 102.0 102.0 107.0 111.0 108.0 109.0 110.0 109.0 122.0 113.0 11:47:19 INFO - 2015-11-15 11:47:19,672 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,673 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:163.50 stddev:7.17 (4.4%) stddev-sans-first:7.04 11:47:19 INFO - 2015-11-15 11:47:19,673 DEBUG : BROWSER_OUTPUT: Values: 171.0 176.0 165.0 157.0 171.0 156.0 157.0 157.0 162.0 161.0 11:47:19 INFO - 2015-11-15 11:47:19,673 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,673 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.90 Median:194.00 stddev:8.03 (4.1%) stddev-sans-first:8.51 11:47:19 INFO - 2015-11-15 11:47:19,673 DEBUG : BROWSER_OUTPUT: Values: 188.0 182.0 197.0 195.0 185.0 179.0 193.0 196.0 198.0 176.0 11:47:19 INFO - 2015-11-15 11:47:19,674 DEBUG : BROWSER_OUTPUT: 11:47:19 INFO - 2015-11-15 11:47:19,674 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.80 Median:90.00 stddev:2.62 (2.9%) stddev-sans-first:1.74 11:47:19 INFO - 2015-11-15 11:47:19,674 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 89.0 91.0 91.0 89.0 89.0 91.0 91.0 88.0 11:47:19 INFO - 2015-11-15 11:47:19,674 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:47:19 INFO - 2015-11-15 11:47:19,674 DEBUG : BROWSER_OUTPUT: 11:47:20 INFO - 2015-11-15 11:47:20,378 INFO : Browser exited with error code: 0 11:47:20 INFO - 2015-11-15 11:47:20,438 INFO : Completed test kraken (00:01:04) 11:47:20 INFO - 2015-11-15 11:47:20,438 INFO : Starting test v8_7 11:47:20 INFO - 2015-11-15 11:47:20,438 DEBUG : operating with platform_type : mac_ 11:47:20 INFO - 2015-11-15 11:47:20,439 INFO : Initialising browser for v8_7 test... 11:47:20 INFO - 2015-11-15 11:47:20,457 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpDbuaGA/profile http://localhost:58359/getInfo.html 11:47:23 INFO - 2015-11-15 11:47:23,054 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:47:23 INFO - 2015-11-15 11:47:23,056 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:47:23 INFO - 2015-11-15 11:47:23,056 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:47:23 INFO - 2015-11-15 11:47:23,056 DEBUG : BROWSER_OUTPUT: __metrics 11:47:23 INFO - 2015-11-15 11:47:23,077 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:47:23 INFO - 2015-11-15 11:47:23,928 INFO : Browser initialized. 11:47:23 INFO - 2015-11-15 11:47:23,928 INFO : Running cycle 1/1 for v8_7 test... 11:47:23 INFO - 2015-11-15 11:47:23,928 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpDbuaGA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:47:36 INFO - 2015-11-15 11:47:36,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 229699584 11:47:36 INFO - 2015-11-15 11:47:36,108 DEBUG : BROWSER_OUTPUT: 11:47:58 INFO - 2015-11-15 11:47:58,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58359/tests/v8_7/run.html (next: http://localhost:58359/tests/v8_7/run.html) 11:47:59 INFO - 2015-11-15 11:47:59,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 305160192 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: |0;Richards;205.2545155993432 11:47:59 INFO - 2015-11-15 11:47:59,240 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;246.6091245376079 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |2;Encrypt;397.77247414478916 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7077.4647887323945 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2465.5172413793102 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |5;Earley;1022.4719101123595 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |6;Boyer;16095.238095238095 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |7;RegExp;37537.03703703704 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |8;Splay;801.924619085806 11:47:59 INFO - 2015-11-15 11:47:59,241 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7142.857142857143 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: __startTimestamp1447616879232__endTimestamp 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:205.25 Median:205.25 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: Values: 205.3 11:47:59 INFO - 2015-11-15 11:47:59,242 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:246.61 Median:246.61 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: Values: 246.6 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:397.77 Median:397.77 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: Values: 397.8 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7077.46 Median:7077.46 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,243 DEBUG : BROWSER_OUTPUT: Values: 7077.5 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2465.52 Median:2465.52 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: Values: 2465.5 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1022.47 Median:1022.47 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,244 DEBUG : BROWSER_OUTPUT: Values: 1022.5 11:47:59 INFO - 2015-11-15 11:47:59,245 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,245 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16095.24 Median:16095.24 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,245 DEBUG : BROWSER_OUTPUT: Values: 16095.2 11:47:59 INFO - 2015-11-15 11:47:59,245 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,245 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:37537.04 Median:37537.04 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,246 DEBUG : BROWSER_OUTPUT: Values: 37537.0 11:47:59 INFO - 2015-11-15 11:47:59,246 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,246 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,246 DEBUG : BROWSER_OUTPUT: Values: 801.9 11:47:59 INFO - 2015-11-15 11:47:59,246 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,247 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7142.86 Median:7142.86 stddev:0.00 (0.0%) 11:47:59 INFO - 2015-11-15 11:47:59,247 DEBUG : BROWSER_OUTPUT: Values: 7142.9 11:47:59 INFO - 2015-11-15 11:47:59,247 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:47:59 INFO - 2015-11-15 11:47:59,247 DEBUG : BROWSER_OUTPUT: 11:47:59 INFO - 2015-11-15 11:47:59,961 INFO : Browser exited with error code: 0 11:47:59 INFO - 2015-11-15 11:47:59,987 INFO : Completed test v8_7 (00:00:39) 11:48:00 INFO - 2015-11-15 11:48:00,492 INFO : Completed test suite (00:20:21) 11:48:00 INFO - 2015-11-15 11:48:00,492 DEBUG : Working with test: dromaeo_css 11:48:00 INFO - 2015-11-15 11:48:00,492 DEBUG : Generating results file: dromaeo_css 11:48:00 INFO - 2015-11-15 11:48:00,493 DEBUG : Working with test: kraken 11:48:00 INFO - 2015-11-15 11:48:00,493 DEBUG : Generating results file: kraken 11:48:00 INFO - 2015-11-15 11:48:00,493 INFO : javascript benchmark 11:48:00 INFO - 2015-11-15 11:48:00,493 DEBUG : Working with test: v8_7 11:48:00 INFO - 2015-11-15 11:48:00,493 DEBUG : Generating results file: v8_7 11:48:00 INFO - 2015-11-15 11:48:00,494 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:48:00 INFO - 2015-11-15 11:48:00,550 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 11:48:00 INFO - 2015-11-15 11:48:00,550 DEBUG : process_Request line: dromaeo_css 5399.42 graph.html#tests=[[72,64,55]] 11:48:00 INFO - 2015-11-15 11:48:00,551 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:48:00 INFO - 2015-11-15 11:48:00,581 DEBUG : process_Request line: kraken 1905.50 graph.html#tests=[[232,64,55]] 11:48:00 INFO - 2015-11-15 11:48:00,581 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:48:00 INFO - 2015-11-15 11:48:00,608 DEBUG : process_Request line: v8_7 14811.79 graph.html#tests=[[230,64,55]] 11:48:00 INFO - 2015-11-15 11:48:00,609 INFO : javascript benchmark 11:48:00 INFO - 2015-11-15 11:48:00,611 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [265.02866992472576, 267.06127960219817, 268.84675734831154, 271.8464067801693, 273.1968014038726, 10743.247972641899, 11327.150463715234, 13527.391267392966, 14076.155430674167, 14304.141751494904, 11649.475773590188, 13747.862521374784, 13913.095648782823, 14040.71918561628, 15073.472428464978, 4130.2978493656, 4289.656827453812, 4357.0, 4370.409994650713, 4370.8907277318, 3091.5671805947186, 3231.3451459945095, 4253.766042867641, 4400.691951563392, 4586.587207151356, 4663.440387153546, 4695.1548721230165, 4724.17326967781, 4766.142094423002, 4784.497627749089, 4419.690621656486, 4519.728816271001, 4685.62514998801, 4755.381800365947, 4772.403449568804, 4085.9387109193385, 4104.363823607346, 4109.527404348508, 4140.4617399738145, 4193.601607847249, 16351.672966540722, 16575.751363729552, 16596.17019149038, 16614.0, 17207.82792172075, 1621.3757703284202, 1652.2234549761592, 1699.1843914920785, 1720.2688857235626, 1805.5125116218549, 10352.171826253882, 10541.262111652188, 10688.732781680443, 11052.0, 11222.607208747655, 1295.8768916952874, 1328.3491089366141, 1328.701042265492, 1332.120800271816, 1340.8189894364332, 43771.34342984858, 45014.09971800578, 45067.54932450666, 45191.322130168075, 45485.31772023422, 7405.814854628569, 7517.624118794039, 7653.349465295512, 7841.137474877759, 7885.5662938538935, 9390.765230869147, 9405.341626086245, 9426.858597120912, 9464.763380915394, 9608.183304419063, 5795.681237531976, 5805.477507024388, 5811.651300921873, 5862.443067908627, 5970.641761494324, 5568.832935011957, 5614.578906582023, 5630.971845140748, 5636.915446268309, 5703.9429605704245, 4513.638908887281, 4553.430821147356, 4560.657950653715, 4585.656075794262, 4615.0, 1223.5044806853239, 1301.8958483321312, 1329.195836518892, 1335.7729186038396, 1338.2706424998398, 330.6412542391532, 333.7866853985779, 658.1082633032172, 750.9662065207078, 762.9433234969496, 9256.72229833106, 9393.5303234838, 9518.904810951803, 9597.760055998517, 9663.565139568736, 330.5075437597962, 341.532101021602, 352.6191712950059, 362.13449854846937, 365.6727229129967, 4873.780679869415, 4894.2658601210105, 4936.0, 5041.6470847040355, 5057.317262169634, 451384.0, 455633.0, 464893.0, 466376.0, 481161.0, 51244.231336529985, 53613.46386536163, 53884.191737123976, 54427.45572544224, 54680.45319546833, 397.3304981106844, 398.67308806778743, 400.7335122143742, 401.25967589797364, 409.0387589165497, 8469.57652117404, 8507.064222935596, 8537.487750734976, 8639.95680021596, 8705.782355441164, 26206.475870482864, 26503.469930601666, 26516.071937482095, 26540.734592653826, 27317.590236146872, 36107.81946090253, 36832.26335473222, 36982.26035479329, 37528.43707344447, 37586.2482750338, 4903.215485522299, 4906.730129842893, 4948.158813001726, 5079.3904731430985, 5120.436751957207, 9153.542322883695, 9217.354785165242, 9285.953570232106, 9368.25053995665, 9372.250219982521, 7927.960360198162, 7969.681212751425, 8119.228673276029, 8121.715739949073, 8295.004599447864, 7872.921270787218, 7967.28294453502, 8027.157148499324, 8028.839423211386, 8212.17878212174, 6976.860462790817, 7671.693132274647, 7831.608419579112, 8241.876371854547, 8315.210055044761, 4492.618127459072, 4620.0, 4726.692764970266, 5026.74866256693, 5113.897722045613, 8047.637856296597, 8054.194580541899, 8198.0, 8336.83326333482, 8395.538245396318], "dojo.html": [2497.750224977502, 2533.050106210171, 2551.425929165937, 2565.884535195916, 2569.267758688773, 4084.7753373564515, 4202.621764041236, 4227.704060715751, 4242.363645453183, 4299.505556860962, 4167.6249137577615, 4232.2805123129065, 4271.42335784669, 4431.0, 4453.109378124372, 3865.7100717446165, 3982.3628219484744, 3994.4607477990535, 3999.840006399755, 4026.758394496325, 3704.8935633899637, 3908.1988192420627, 4032.6572241359518, 4089.284375234337, 4089.7137200395982, 3867.651911327994, 3920.3923391874305, 3938.3107956107565, 3943.6450719435247, 3972.6424621784176, 3856.0, 3863.092173339263, 3897.8440862365755, 3906.7069969752383, 3908.0620651043546, 3851.5955824638568, 3879.165979314461, 3882.417637354391, 3909.081365879016, 3921.2353591049755, 4062.0, 4111.8560850370095, 4113.588641135892, 4148.23257697327, 4227.619514243733, 4435.356873253392, 4518.27707566791, 4523.547645235483, 4561.657875659305, 4562.064776720765, 4475.530069342704, 4496.325551167319, 4531.705439146445, 4549.340345649895, 4575.775074172167, 4114.0, 4160.729552579072, 4167.083241686824, 4205.852795152155, 4206.074663574009, 4517.435320584927, 4547.477040140427, 4674.579287864109, 4698.271767875985, 4742.810287588527, 4429.667774916894, 4449.199144154083, 4473.060657261946, 4508.45898492183, 4511.751853648081, 4263.552327005682, 4578.519255478127, 4579.427571553556, 4643.791029403685, 4680.391549098664, 4253.106847561985, 4255.340422234559, 4288.0, 4453.688241823106, 4577.862664120082, 4492.640588752892, 4493.348464472633, 4508.842190523316, 4529.0, 4572.634189264851, 3414.129397003748, 3503.2993401319836, 3533.611302756695, 3567.3222087803233, 3570.8036058016537, 3147.3075923296838, 3167.2715275486767, 3181.7772755907326, 3227.3383956288903, 3292.0617623977532, 4245.235857545671, 4299.1831552005015, 4319.308910574293, 4347.5652434756275, 4386.495553011381, 4499.0776890737325, 4542.863714088583, 4570.748608826547, 4604.355390245369, 4605.6085232755595, 4278.315469524861, 4282.614564689193, 4297.39836422901, 4330.805113769888, 4344.152890186383, 4038.6163314485075, 4051.858184963512, 4066.0038290618986, 4093.1404405074672, 4158.6673066154635, 4627.953720462887, 4711.74085425298, 4729.716217026989, 4805.351277577623, 4842.58837998767, 4529.184746745617, 4581.450225972904, 4612.930806037845, 4620.838270660511, 4642.210824159968, 4660.580547750718, 4679.812807487799, 4709.5290470954005, 4713.7643117844655, 4756.667033307635, 4394.143142087262, 4405.559444055569, 4432.335149727567, 4479.910401792011, 4555.954440455553, 4463.888402789957, 4497.685162038626, 4541.3415054816205, 4592.357070010268, 4619.792109355019, 4436.268015777489, 4455.465344158722, 4468.687191896536, 4518.525554816697, 4590.770461476846, 4269.423627810206, 4380.8685739427865, 4440.933385999278, 4499.595036446735, 4552.135094332067, 4309.052008558112, 4322.113966636769, 4330.891727706832, 4415.205263052681, 4454.042380888124, 4441.400410944481, 4459.063596644741, 4467.620252278462, 4515.277555591089, 4515.412996310459, 4211.663066954698, 4358.302671572533, 4378.321360189176, 4388.626966707738, 4440.111977604557], "mootools.html": [1072.2762135558505, 1381.92399418032, 1439.1868594244252, 1480.1711041816584, 1484.5249520153548, 5773.855653608662, 5999.550033747465, 6369.07648390983, 6390.96804515978, 6526.80419587412, 6241.375862413756, 6268.561200715952, 6394.168758061457, 6517.0224466329955, 6534.411902928736, 1798.163853807979, 1815.537038055294, 1833.2117189608464, 1838.1268897273756, 1843.5575461889116, 1833.1933949062436, 1850.3431281894934, 1859.9677179165626, 1884.3028079610563, 1902.258119333461, 1823.9421135741238, 1824.8631352648604, 1838.4944140361374, 1844.9815501844944, 1857.4799056264267, 1796.470041337802, 1814.0748218408708, 1814.6098588803338, 1855.9257629694796, 1860.0327829528705, 1801.711726123827, 1806.6206096719573, 1826.6255417639486, 1833.0468156558647, 1867.2064372641573, 5412.0, 6399.616023038632, 6438.935610643881, 6466.321036291216, 6540.640264785482, 3593.1735700788704, 3725.1990821973136, 3931.8230679619487, 4044.2315959967514, 4149.315362965107, 2232.073689418889, 2251.718535183102, 2284.4060544258446, 2311.6994790677104, 2314.409825494505, 728.0753443127252, 738.1658725640046, 746.2947514598707, 771.3944553525512, 771.5139462138873, 8521.14788521149, 8546.957265213634, 8589.484630922103, 8613.267872230868, 8792.076831932683, 3616.0959760059986, 3705.0366904605, 3768.6231376862092, 3769.0012146781123, 3851.8459261629223, 7548.698052077855, 7549.962250188714, 7609.429292803062, 7647.464677472523, 7719.073711154585, 4104.548499665035, 4118.320477121301, 4125.1749650070105, 4134.069834287261, 4200.6219440250525, 3700.2414505026404, 3703.777773333609, 3740.3080430120513, 3752.587215406303, 3804.087019115392, 2887.9133625991253, 2911.4468251032235, 2935.324875278698, 2940.1179646106084, 2997.310618557744, 952.6189524190379, 957.0716405087054, 960.5437417226761, 960.865478832964, 961.7451375385529, 814.1776805426562, 838.2497664590157, 841.4194205997842, 853.3301358433599, 984.8424252119627, 6062.514998800086, 6063.363346848606, 6109.541784366191, 6158.384161583896, 6163.260408750979, 371.27786455344636, 389.33423845224985, 393.2920742663195, 398.6213097557274, 398.63126607887585, 4493.1013797240685, 4507.5943165115295, 4531.546845315442, 4582.312653102062, 4598.655100867449, 7063.540869843547, 7170.964145179345, 7201.171865235565, 7373.594452305175, 7629.0, 7387.8153046174275, 7638.770836874903, 7640.0, 7662.003939487942, 7674.386049116169, 5920.0, 5946.07835785454, 6003.939960600425, 6049.546284028627, 6051.213342265477, 6054.8183554493435, 6104.053871649901, 6116.17431646722, 6134.110553969738, 6142.539309551712, 6674.499412543982, 6776.864462710817, 6816.216135144324, 6837.213720422215, 6944.444444444332, 6929.099217101744, 6939.028536004862, 6968.547044442095, 7038.542494737826, 7236.167840698176, 5961.314448838439, 6038.245219347582, 6103.938960610337, 6117.694115294306, 6168.352323006199, 6011.939880601138, 6099.207103076572, 6132.969335153474, 6155.0, 6262.68686565679, 5621.831345059655, 5726.942730572641, 5795.768169273182, 5796.101604251347, 5844.415558444121, 5515.09001014828, 5557.44425557441, 5557.833265002057, 5583.972080139573, 5615.943840561542, 5715.742791574472, 5786.884262314814, 5788.507976822018, 5824.126381042877, 5861.238039054895, 5176.1200595899545, 5186.870328241674, 5227.477252274742, 5258.0, 5347.732613369239, 5199.428062913152, 5308.495692909322, 5363.249145119765, 5365.919511207257, 5397.487238712473], "ext.html": [444.3224083273008, 450.3897219267892, 453.4694407543174, 464.1112270002943, 472.7116458960036, 25515.74484255157, 26022.86988565057, 26056.348591285227, 26379.868100659492, 31903.36193276133, 35044.47433288502, 35289.47065794009, 35573.0, 35980.0, 36006.0, 7376.077990251232, 7446.739364122257, 7464.216257292987, 7533.849323013536, 7621.923780762205, 6837.726490940357, 6927.3419025192525, 6969.58182509051, 7278.563286202819, 7380.2250763669845, 8936.597853096626, 9131.13254240846, 9150.816983660323, 9323.813523729521, 9342.252619790435, 8893.377463577584, 8916.019237883827, 8996.145366190201, 9018.233450156744, 9069.909300906973, 6638.5684930479365, 6760.729570817161, 6847.17833859935, 8708.869366959501, 8755.0, 32334.838325808454, 32376.676233237602, 32387.51418728721, 32627.51058734097, 32968.83515582431, 2227.3095340444515, 2266.2974477911735, 2308.4459729664927, 2327.301809457173, 2386.737458879522, 22274.65644199382, 22326.55346893069, 22490.55018899629, 22514.887425562767, 22810.54378912429, 1941.2041063164036, 1960.2649006622516, 1986.414007867668, 2011.3161525081543, 2084.135083940163, 208539.0, 212089.0, 212930.0, 212997.0, 213069.0, 48758.75620621945, 48814.0, 48873.755631222324, 49469.33225350077, 49879.25181122286, 45721.5427845724, 46131.76934115375, 46563.068738625036, 52391.476085239425, 54268.0, 11137.498812553455, 11182.21724479295, 11412.771744565061, 11420.486078126503, 11508.136889733136, 8678.220964702221, 8747.343949203836, 8772.210501054935, 8816.074312197126, 8877.156670116457, 15537.766933496006, 16039.358425663077, 16118.838811611968, 16212.37876212393, 16236.350545978265, 7099.112610923635, 7163.391111755559, 7231.385332246818, 7311.524750891175, 7312.23221561739, 740.4853626729372, 752.3561019173125, 772.5441989226383, 773.5165521549031, 778.5212094561804, 22405.88797056004, 22515.211967581057, 22682.319530414115, 22780.772192277866, 22786.202482913017, 848.6647774129308, 849.7705619482829, 905.9637614495479, 923.1783712495884, 928.2481190235931, 11849.940750296366, 11925.463354149084, 11929.761404771856, 11937.761244775229, 12009.399530023464, 253371.0, 262987.0, 263783.0, 265933.0, 266640.0, 44697.0, 45028.0, 45073.32390014153, 45431.0, 45534.772326138154, 1098.5441041967495, 1106.1151079136819, 1111.4609414433994, 1116.4529380603608, 1125.2573301620891, 22412.32763017112, 22652.0, 22673.433164171027, 22775.430614234778, 22990.631779962423, 35776.0, 36592.45111323279, 43285.56714432815, 44100.33849492324, 46100.30849537327, 202330.0, 204621.0, 205021.0, 206495.0, 207076.0, 22310.330690079325, 22328.66507002364, 26016.219513414628, 26041.348966275993, 26167.345816354744, 28850.422991540472, 29273.414531708822, 31128.0, 34587.4811877817, 37611.247775044896, 27836.582451263654, 28495.43009139764, 28968.0, 29007.7099229005, 29272.121836344944, 27699.0, 27779.0, 28195.859020704764, 28258.85870570634, 28786.136415907557, 27416.588751169147, 27467.175984720492, 27496.312592184557, 27637.861810691622, 27716.0, 21857.56284874262, 22767.283156957637, 23359.299221022717, 23494.177703780286, 24073.75926240715, 18161.727574086133, 18251.178696958403, 18269.634607308046, 18288.81711182871, 18652.44239218574], "prototype.html": [251.56353726284905, 252.59962958710443, 255.18086940919648, 259.40725442364203, 262.8225947485448, 4891.926621100682, 5026.849194524161, 5026.924596131061, 5063.772130254139, 5112.8977420451565, 4576.954230457694, 4888.266759986004, 4936.753162341877, 4952.479989601094, 4970.353853998975, 3809.257194847006, 3825.8087095645246, 3850.4609354690365, 3900.1029763154493, 3924.666403355718, 3843.903902402434, 3846.4807251021175, 3877.689784817222, 3889.3776995680696, 3903.1022864741126, 3792.184680293736, 3819.560750513685, 3843.154506008688, 3865.0, 3868.78721670308, 3810.2760475509563, 3850.537935447764, 3857.40210267409, 3882.4758657581287, 3885.04816320002, 3243.8702451901895, 3284.786488878215, 3303.9008829734908, 3327.317899830529, 3354.76516643835, 4839.467658557556, 4882.194437917739, 4899.951000489985, 4916.508349165055, 4917.483664215241, 4279.1869544786705, 4283.850065247701, 4299.785010749481, 4311.33174357975, 4344.1311737652595, 5209.088409528317, 5210.557102646279, 5286.735663216824, 5297.735113244361, 5299.814506492255, 3447.0, 3554.9111272218142, 3592.6946209572216, 3627.5102861113673, 3627.673509384168, 5178.482151784829, 5414.29614150158, 5451.155070964007, 5551.306086739158, 5567.081431563827, 3541.220931395089, 3572.1962558424666, 3655.9817200913826, 3690.2250527389547, 3719.3305205062807, 3588.120910376922, 3638.6725194732603, 3747.8500859965843, 3775.9244815103543, 3777.0557360659836, 4182.435371224846, 4257.57424257578, 4276.807543660543, 4351.4995775485595, 4371.978140109279, 5209.192575150858, 5220.216967454912, 5309.33633295838, 5312.176612624972, 5327.147656375039, 1284.2808027504627, 1306.817045613615, 1319.1359659423092, 1327.0246368918838, 1334.3995202159067, 836.4981011393115, 857.4512312120248, 869.0483920107472, 869.7347309070668, 881.9725020351348, 5077.923831142536, 5078.5937125029905, 5087.0, 5149.922751158736, 5175.327207463081, 5432.158015507603, 5447.155690867922, 5540.972295138498, 5554.1113421853115, 5556.277683901148, 5071.644984851099, 5074.4671809460215, 5153.304303918998, 5166.044281807877, 5182.507661772125, 2812.2406950123354, 2951.3211961249035, 2955.12823717004, 2996.1460983619563, 2998.835064071497, 5636.351819540805, 5664.688442135722, 5751.884962300731, 5760.3951585083805, 5767.106098554731, 5558.0, 5569.220309156722, 5646.971765141148, 5651.858703532363, 5680.914786278209, 5654.134135735279, 5658.26442562456, 5749.942500574941, 5755.568332375088, 5761.769529218785, 5289.0, 5401.783928642811, 5424.294841670558, 5450.138677194504, 5514.696691681836, 5313.973430132979, 5354.11657076578, 5355.839324820262, 5360.62475626718, 5403.351597808131, 5640.520555752807, 5728.79949201776, 5740.684262365443, 5741.16753070794, 5757.0788673811985, 3694.9815250923575, 3717.5353080864893, 3728.6457786510236, 3755.868544600926, 3760.172761992357, 5250.369955605352, 5358.142697168434, 5502.202180683858, 5513.200585914939, 5515.889682206253, 5183.0670479314085, 5262.0528304903955, 5380.623356365017, 5409.6213265071065, 5434.782608695607, 5273.44628813969, 5307.442718514655, 5415.972920135374, 5429.782808687766, 5435.891282174413, 5210.218467229945, 5249.527542521038, 5276.366835979707, 5278.313819203479, 5294.8941021180135, 5155.53600175986, 5325.920111198413, 5401.918971215514, 5409.486098820606, 5428.348598168245, 5185.403678577012, 5247.239150323258, 5290.81482148123, 5297.020051290524, 5306.893862122659], "yui.html": [503.9697618142912, 554.9972250138749, 585.7891159182693, 608.0848323273475, 615.0988801405941, 11306.265092768965, 11330.376829274397, 11520.135989800767, 11536.307821530703, 11557.248778829371, 10521.263511554194, 11683.06535477162, 11791.705207369798, 12008.279503229813, 12024.218425802317, 556.2074044486591, 574.8419184724193, 703.6341102626631, 707.0596107177441, 717.4188906985332, 559.1612581128308, 684.9657017902978, 687.4088284075691, 691.1360799001249, 707.1443553300512, 684.329357229915, 718.4683334332583, 720.722521829097, 724.1852915470096, 736.808429808251, 570.3213176320165, 573.9799107031234, 575.8330084275597, 723.7864829875199, 725.354434553248, 516.1483552138964, 517.1544524702101, 517.5781737883613, 525.9211118332281, 526.7761201489352, 10714.517846696917, 11129.220954533186, 11172.944135279353, 11197.552097916074, 11345.319280843176, 7655.272749088827, 7832.804179895491, 8004.51972881629, 8068.556229407381, 8110.972256935766, 7186.425085993108, 7304.953284005466, 7350.7427240046345, 7402.666879990414, 7407.370646445235, 2276.920307789236, 2387.2957477544164, 2388.080588973258, 2422.2369953464604, 2427.684401027855, 37839.810800945816, 37915.62084379148, 37993.620063799564, 38152.427713584315, 38600.22799544022, 5504.256925315031, 5542.944570554243, 5564.888702225933, 5588.944110558924, 5676.654200873076, 9689.12797848197, 9727.513624318755, 9735.269854760922, 9888.258380621483, 9930.05664461875, 4797.4482934462285, 4815.638827087912, 4925.679830811057, 4940.925886111711, 5029.346184996, 2987.118799954019, 3054.618172728409, 3055.679153688875, 3110.315730539278, 3155.4793459079456, 2173.0873033326043, 2175.5866385386726, 2191.5178660694623, 2219.3674802681157, 2236.865788052722, 331.2645926044178, 331.98008119512906, 336.3088852408324, 339.1927213232491, 342.83543898928156, 444.17605342090604, 452.79397873967264, 482.8020511590231, 483.45369732202386, 485.47811103064345, 6250.781222657185, 6475.902861457082, 6543.869122617521, 6613.0, 6638.17022872141, 378.0850342171951, 421.66898984297177, 472.52275202046184, 482.2091769498026, 508.5988102776826, 3026.1678038539576, 3051.9389612207633, 3083.182956516525, 3141.5758872551914, 3154.4006638738565, 46823.29765053527, 47773.5222647776, 48030.27954580684, 48400.0, 48491.0, 38791.41812872809, 40033.79983100066, 40654.79672601677, 40848.59151408448, 40854.79572602118, 36898.8155059223, 37326.44010339847, 37370.626293736714, 38069.80965095212, 38531.80734096312, 6433.356664333529, 6756.527043106936, 6816.420604248694, 6818.318168183142, 6819.283975182534, 27101.457970840867, 27673.72326276792, 27730.306742331602, 27978.58032129479, 28040.0, 34337.0, 35862.64137358593, 37399.0, 37582.8120859394, 38332.616673832905, 5851.356350801493, 6213.130161777264, 6296.0, 6404.583702059351, 6451.677416129269, 8712.91287087121, 8823.823523529622, 8830.558472076498, 8953.418027828171, 9014.81970360576, 8129.187081291823, 8172.0, 8196.983318349767, 8389.161083891562, 8399.874001889855, 8410.074891762024, 8575.356848236283, 8700.695475658322, 8717.956410218161, 8731.781705457415, 8301.418900677136, 8622.223999840044, 8628.89359830448, 8639.740807775777, 8650.30797536183, 7283.162436319891, 7314.817129571803, 7424.740134095497, 7725.111612164673, 7727.956725842164, 7094.574325540484, 7404.148522919933, 7467.813304667427, 7604.80987975305, 7672.501287416523]}, "summary": {"lowerIsBetter": false, "suite": 5399.415719013579, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6046.586229469259, "unit": "ms", "value": 6046.586229469259}, "dojo.html": {"lowerIsBetter": false, "filtered": 4206.911840917336, "unit": "ms", "value": 4206.911840917336}, "mootools.html": {"lowerIsBetter": false, "filtered": 3582.695241842735, "unit": "ms", "value": 3582.695241842735}, "ext.html": {"lowerIsBetter": false, "filtered": 14680.323344017426, "unit": "ms", "value": 14680.323344017426}, "prototype.html": {"lowerIsBetter": false, "filtered": 3976.0114105792345, "unit": "ms", "value": 3976.0114105792345}, "yui.html": {"lowerIsBetter": false, "filtered": 4657.6635149218055, "unit": "ms", "value": 4657.6635149218055}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447615659, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}, {"talos_counters": {}, "results": {"audio-dft": [200.0, 206.0, 204.0, 206.0, 208.0, 207.0, 207.0, 198.0, 202.0, 205.0], "ai-astar": [130.0, 137.0, 137.0, 139.0, 140.0, 139.0, 135.0, 132.0, 134.0, 152.0], "imaging-gaussian-blur": [155.0, 148.0, 149.0, 153.0, 141.0, 148.0, 155.0, 148.0, 145.0, 142.0], "audio-beat-detection": [199.0, 170.0, 196.0, 207.0, 163.0, 191.0, 187.0, 163.0, 208.0, 164.0], "json-stringify-tinderbox": [81.0, 84.0, 85.0, 84.0, 91.0, 91.0, 90.0, 91.0, 90.0, 88.0], "stanford-crypto-pbkdf2": [188.0, 182.0, 197.0, 195.0, 185.0, 179.0, 193.0, 196.0, 198.0, 176.0], "json-parse-financial": [67.0, 70.0, 73.0, 72.0, 75.0, 77.0, 76.0, 78.0, 77.0, 76.0], "stanford-crypto-sha256-iterative": [83.0, 86.0, 89.0, 91.0, 91.0, 89.0, 89.0, 91.0, 91.0, 88.0], "audio-fft": [94.0, 93.0, 108.0, 156.0, 86.0, 89.0, 90.0, 89.0, 150.0, 86.0], "imaging-darkroom": [163.0, 170.0, 162.0, 159.0, 155.0, 163.0, 163.0, 163.0, 158.0, 154.0], "stanford-crypto-ccm": [171.0, 176.0, 165.0, 157.0, 171.0, 156.0, 157.0, 157.0, 162.0, 161.0], "audio-oscillator": [120.0, 120.0, 175.0, 114.0, 115.0, 117.0, 160.0, 113.0, 115.0, 156.0], "stanford-crypto-aes": [102.0, 102.0, 107.0, 111.0, 108.0, 109.0, 110.0, 109.0, 122.0, 113.0], "imaging-desaturate": [120.0, 120.0, 130.0, 120.0, 131.0, 120.0, 120.0, 129.0, 121.0, 119.0]}, "summary": {"lowerIsBetter": true, "suite": 1905.4999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 104.1, "unit": "ms", "value": 104.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 188.9, "unit": "ms", "value": 188.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 184.8, "unit": "ms", "value": 184.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 163.3, "unit": "ms", "value": 163.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.1, "unit": "ms", "value": 74.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 130.5, "unit": "ms", "value": 130.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 137.5, "unit": "ms", "value": 137.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 204.3, "unit": "ms", "value": 204.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.8, "unit": "ms", "value": 88.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 87.5, "unit": "ms", "value": 87.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 148.4, "unit": "ms", "value": 148.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 109.3, "unit": "ms", "value": 109.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 123.0, "unit": "ms", "value": 123.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447615659, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}, {"talos_counters": {}, "results": {"DeltaBlue": [246.6091245376079], "Encrypt": [397.77247414478916], "NavierStokes": [7142.857142857143], "Decrypt": [7077.4647887323945], "Splay": [801.924619085806], "Richards": [205.2545155993432], "RegExp": [37537.03703703704], "Earley": [1022.4719101123595], "Boyer": [16095.238095238095], "RayTrace": [2465.5172413793102]}, "summary": {"lowerIsBetter": false, "suite": 14811.786396865966, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 268.10848999999985, "unit": "score", "value": 268.10848999999985}, "Encrypt": {"lowerIsBetter": false, "filtered": 669.1790340000001, "unit": "score", "value": 669.1790340000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 207.76000000000013, "unit": "score", "value": 207.76000000000013}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.6096537313433, "unit": "score", "value": 37.6096537313433}, "Splay": {"lowerIsBetter": false, "filtered": 101.619277, "unit": "score", "value": 101.619277}, "RegExp": {"lowerIsBetter": false, "filtered": 24.268963986186474, "unit": "score", "value": 24.268963986186474}, "Richards": {"lowerIsBetter": false, "filtered": 171.99134400000005, "unit": "score", "value": 171.99134400000005}, "Earley": {"lowerIsBetter": false, "filtered": 651.8154615384614, "unit": "score", "value": 651.8154615384614}, "Boyer": {"lowerIsBetter": false, "filtered": 41.40746449704143, "unit": "score", "value": 41.40746449704143}, "RayTrace": {"lowerIsBetter": false, "filtered": 300.13539860139855, "unit": "score", "value": 300.13539860139855}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447615659, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115092632", "branch": "Fx-Team", "revision": "3f0651985bf0e3403b5fd4984a907813689ee3a9"}}] 11:48:00 INFO - RETURN: dromaeo_css: 5399.42 11:48:00 INFO - RETURN: kraken: 1905.50 11:48:00 INFO - RETURN: v8_7: 14811.79 11:48:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14811.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1905.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5399.42"}}} 11:48:00 INFO - Return code: 0 11:48:00 INFO - # TBPL SUCCESS # 11:48:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:48:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:48:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:48:00 INFO - 2015-11-15 11:48:00.742 screenresolution[2310:28154] starting screenresolution argv=screenresolution get 11:48:00 INFO - 2015-11-15 11:48:00.745 screenresolution[2310:28154] Display 0: 1600x1200x32@60 11:48:00 INFO - 2015-11-15 11:48:00.752 screenresolution[2311:28158] starting screenresolution argv=screenresolution list 11:48:00 INFO - Available Modes on Display 0 11:48:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:48:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:48:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:48:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:48:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:48:01 INFO - Intel HD Graphics 3000: 11:48:01 INFO - Chipset Model: Intel HD Graphics 3000 11:48:01 INFO - Type: GPU 11:48:01 INFO - Bus: Built-In 11:48:01 INFO - VRAM (Total): 512 MB 11:48:01 INFO - VRAM (Dynamic, Max): 10 11:48:01 INFO - Vendor: Intel (0x8086) 11:48:01 INFO - Device ID: 0x0116 11:48:01 INFO - Revision ID: 0x0009 11:48:01 INFO - Displays: 11:48:01 INFO - Display: 11:48:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:48:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:48:01 INFO - Display Serial Number: 1600x1200 60 11:48:01 INFO - Main Display: Yes 11:48:01 INFO - Mirror: Off 11:48:01 INFO - Online: Yes 11:48:01 INFO - Rotation: Supported 11:48:01 INFO - Return code: 0 11:48:01 INFO - Running post-action listener: _resource_record_post_action 11:48:01 INFO - Running post-run listener: _resource_record_post_run 11:48:02 INFO - Total resource usage - Wall time: 1267s; CPU: 30.0%; Read bytes: 389120; Write bytes: 688075776; Read time: 760; Write time: 41713 11:48:02 INFO - install - Wall time: 45s; CPU: 30.0%; Read bytes: 336499200; Write bytes: 334833664; Read time: 38848; Write time: 4120 11:48:02 INFO - run-tests - Wall time: 1222s; CPU: 30.0%; Read bytes: 385024; Write bytes: 342871040; Read time: 750; Write time: 37151 11:48:02 INFO - Running post-run listener: _upload_blobber_files 11:48:02 INFO - Blob upload gear active. 11:48:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:48:02 INFO - Copying logs to upload dir... 11:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.797283 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-15 11:48:02.229928) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:48:02.238005) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010591 build_url: 'https://queue.taskcluster.net/v1/task/GdZOMUk2TSWnX0ZuXBx5Ig/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 11:48:02.269606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:48:02.270063) ========= 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.nphoS5PXYC/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.aQEMudkvI6/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005488 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 11:48:02.324145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:48:02.324580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 11:48:02.325056) ========= ========= Total master_lag: 0.27 =========