builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1464034089.01 results: success (0) buildid: 20160523111242 builduid: 639b9d3aeb644c6896626fcf57d0116a revision: 59dbf171604d52960e6e54cbefdb52d7bbcb989d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:09.007800) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:09.008340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:09.008672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:09.037755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 13:08:09.038180) ========= 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.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-23 13:08:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-05-23 13:08:09 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.476387 ========= master_lag: 0.74 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 13:08:10.257816) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:10.258117) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020600 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:10.440739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-23 13:08:10.441091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59dbf171604d52960e6e54cbefdb52d7bbcb989d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59dbf171604d52960e6e54cbefdb52d7bbcb989d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-23 13:08:10,516 truncating revision to first 12 chars 2016-05-23 13:08:10,516 Setting DEBUG logging. 2016-05-23 13:08:10,517 attempt 1/10 2016-05-23 13:08:10,517 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/59dbf171604d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 13:08:12,286 unpacking tar archive at: mozilla-beta-59dbf171604d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.016498 ========= master_lag: 2.49 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-05-23 13:08:14.946923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:14.947392) ========= script_repo_revision: 59dbf171604d52960e6e54cbefdb52d7bbcb989d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 13:08:14.947751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-05-23 13:08:14.948008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-05-23 13:08:19.223987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-23 13:08:19.224234) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:08:19 INFO - MultiFileLogger online at 20160523 13:08:19 in /builds/slave/test 13:08:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:08:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:19 INFO - {'append_to_log': False, 13:08:19 INFO - 'base_work_dir': '/builds/slave/test', 13:08:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:08:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:19 INFO - 'branch': 'Mozilla-Beta', 13:08:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:19 INFO - 'config_files': ('talos/mac_config.py',), 13:08:19 INFO - 'default_actions': ('clobber', 13:08:19 INFO - 'read-buildbot-config', 13:08:19 INFO - 'download-and-extract', 13:08:19 INFO - 'populate-webroot', 13:08:19 INFO - 'create-virtualenv', 13:08:19 INFO - 'install', 13:08:19 INFO - 'run-tests'), 13:08:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:19 INFO - 'download_minidump_stackwalk': True, 13:08:19 INFO - 'download_symbols': 'ondemand', 13:08:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:19 INFO - 'installer_path': 'installer.exe', 13:08:19 INFO - 'log_level': 'info', 13:08:19 INFO - 'log_name': 'talos', 13:08:19 INFO - 'log_to_console': True, 13:08:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:08:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:08:19 INFO - 'opt_config_files': (), 13:08:19 INFO - 'pip_index': False, 13:08:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:08:19 INFO - 'cmd': ('bash', 13:08:19 INFO - '-c', 13:08:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:08:19 INFO - 'enabled': True, 13:08:19 INFO - 'halt_on_failure': False, 13:08:19 INFO - 'name': 'check_screen_resolution'},), 13:08:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:08:19 INFO - 'cmd': ('bash', 13:08:19 INFO - '-c', 13:08:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:08:19 INFO - 'enabled': True, 13:08:19 INFO - 'halt_on_failure': False, 13:08:19 INFO - 'name': 'check_screen_resolution'},), 13:08:19 INFO - 'run_cmd_checks_enabled': True, 13:08:19 INFO - 'sps_profile': False, 13:08:19 INFO - 'sps_profile_interval': 0, 13:08:19 INFO - 'suite': 'dromaeojs', 13:08:19 INFO - 'system_bits': '32', 13:08:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:19 INFO - 'title': 't-yosemite-r7-0277', 13:08:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:19 INFO - 'use_talos_json': True, 13:08:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:19 INFO - 'work_dir': 'build'} 13:08:19 INFO - ##### 13:08:19 INFO - ##### Running clobber step. 13:08:19 INFO - ##### 13:08:19 INFO - Running pre-action listener: _resource_record_pre_action 13:08:19 INFO - Running main action method: clobber 13:08:19 INFO - rmtree: /builds/slave/test/build 13:08:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:20 INFO - Running post-action listener: _resource_record_post_action 13:08:20 INFO - ##### 13:08:20 INFO - ##### Running read-buildbot-config step. 13:08:20 INFO - ##### 13:08:20 INFO - Running pre-action listener: _resource_record_pre_action 13:08:20 INFO - Running main action method: read_buildbot_config 13:08:20 INFO - Using buildbot properties: 13:08:20 INFO - { 13:08:20 INFO - "project": "", 13:08:20 INFO - "product": "firefox", 13:08:20 INFO - "script_repo_revision": "production", 13:08:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:08:20 INFO - "repository": "", 13:08:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:08:20 INFO - "buildid": "20160523111242", 13:08:20 INFO - "pgo_build": "False", 13:08:20 INFO - "basedir": "/builds/slave/test", 13:08:20 INFO - "buildnumber": 22, 13:08:20 INFO - "slavename": "t-yosemite-r7-0277", 13:08:20 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:08:20 INFO - "platform": "yosemite_r7", 13:08:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:08:20 INFO - "branch": "mozilla-beta", 13:08:20 INFO - "repo_path": "releases/mozilla-beta", 13:08:20 INFO - "revision": "59dbf171604d52960e6e54cbefdb52d7bbcb989d", 13:08:20 INFO - "stage_platform": "macosx64", 13:08:20 INFO - "builduid": "639b9d3aeb644c6896626fcf57d0116a", 13:08:20 INFO - "slavebuilddir": "test" 13:08:20 INFO - } 13:08:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 13:08:20 INFO - Running post-action listener: _resource_record_post_action 13:08:20 INFO - ##### 13:08:20 INFO - ##### Running download-and-extract step. 13:08:20 INFO - ##### 13:08:20 INFO - Running pre-action listener: _resource_record_pre_action 13:08:20 INFO - Running main action method: download_and_extract 13:08:20 INFO - mkdir: /builds/slave/test/build/tests 13:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:20 INFO - https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 13:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 13:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 13:08:21 INFO - Downloaded 1241 bytes. 13:08:21 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 13:08:21 INFO - Using the following test package requirements: 13:08:21 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:08:21 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 13:08:21 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 13:08:21 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:08:21 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 13:08:21 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:08:21 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 13:08:21 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 13:08:21 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 13:08:21 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 13:08:21 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 13:08:21 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 13:08:21 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 13:08:21 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')]} 13:08:21 INFO - https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 13:08:22 INFO - Downloaded 17747759 bytes. 13:08:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:08:25 INFO - Return code: 0 13:08:25 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:08: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')]} 13:08:25 INFO - https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:08:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 13:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 13:08:26 INFO - Downloaded 17747759 bytes. 13:08:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:08:30 INFO - Return code: 0 13:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:30 INFO - https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 13:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 13:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 13:08:31 INFO - Downloaded 10845194 bytes. 13:08:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:08:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:08:31 INFO - Return code: 0 13:08: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')]} 13:08:31 INFO - https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 13:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 13:08:36 INFO - Downloaded 88423695 bytes. 13:08:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:08:36 INFO - mkdir: /builds/slave/test/properties 13:08:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:36 INFO - Contents: 13:08:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg 13:08:37 INFO - Running post-action listener: _resource_record_post_action 13:08:37 INFO - Running post-action listener: set_extra_try_arguments 13:08:37 INFO - ##### 13:08:37 INFO - ##### Running populate-webroot step. 13:08:37 INFO - ##### 13:08:37 INFO - Running pre-action listener: _resource_record_pre_action 13:08:37 INFO - Running main action method: populate_webroot 13:08:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:37 INFO - '--tppagecycles', 13:08:37 INFO - '7'], 13:08:37 INFO - 'tests': ['tsvgm']}}, 13:08:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:08:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:08:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'tests': ['damp', 'tps']}, 13:08:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['damp', 'tps']}, 13:08:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:08:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:37 INFO - 'other': {'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'other_l64': {'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'other_nol64': {'tests': ['a11yr', 13:08:37 INFO - 'ts_paint', 13:08:37 INFO - 'tpaint', 13:08:37 INFO - 'sessionrestore', 13:08:37 INFO - 'sessionrestore_no_auto_restore', 13:08:37 INFO - 'tabpaint']}, 13:08:37 INFO - 'svgr': {'tests': ['tsvgx', 13:08:37 INFO - 'tsvgr_opacity', 13:08:37 INFO - 'tart', 13:08:37 INFO - 'tscrollx', 13:08:37 INFO - 'cart']}, 13:08:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['tsvgx', 13:08:37 INFO - 'tsvgr_opacity', 13:08:37 INFO - 'tart', 13:08:37 INFO - 'tscrollx', 13:08:37 INFO - 'cart']}, 13:08:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'tests': ['tp5o']}, 13:08:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'talos_options': ['--e10s'], 13:08:37 INFO - 'tests': ['tp5o']}, 13:08:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'talos_options': ['--xperf_path', 13:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:37 INFO - 'tests': ['tp5n']}, 13:08:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:37 INFO - 'talos_options': ['--e10s', 13:08:37 INFO - '--xperf_path', 13:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:37 INFO - 'tests': ['tp5n']}}, 13:08:37 INFO - 'talos.zip': {'path': '', 13:08:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:37 INFO - Running post-action listener: _resource_record_post_action 13:08:37 INFO - ##### 13:08:37 INFO - ##### Running create-virtualenv step. 13:08:37 INFO - ##### 13:08:37 INFO - Running pre-action listener: _resource_record_pre_action 13:08:37 INFO - Running main action method: create_virtualenv 13:08:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:37 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 13:08:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:37 INFO - Using real prefix '/tools/python27' 13:08:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:41 INFO - Installing pip.................done. 13:08:41 INFO - Return code: 0 13:08:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:41 INFO - 'HOME': '/Users/cltbld', 13:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:41 INFO - 'LOGNAME': 'cltbld', 13:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:41 INFO - 'MOZ_NO_REMOTE': '1', 13:08:41 INFO - 'NO_EM_RESTART': '1', 13:08:41 INFO - 'PAGER': '/bin/cat', 13:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:41 INFO - 'PWD': '/builds/slave/test', 13:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:41 INFO - 'SHELL': '/bin/bash', 13:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:41 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:41 INFO - 'USER': 'cltbld', 13:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:41 INFO - 'XPC_FLAGS': '0x0', 13:08:41 INFO - 'XPC_SERVICE_NAME': '0', 13:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:41 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 13:08:41 INFO - Cleaning up... 13:08:41 INFO - Return code: 0 13:08:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:08:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:41 INFO - 'HOME': '/Users/cltbld', 13:08:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:41 INFO - 'LOGNAME': 'cltbld', 13:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:41 INFO - 'MOZ_NO_REMOTE': '1', 13:08:41 INFO - 'NO_EM_RESTART': '1', 13:08:41 INFO - 'PAGER': '/bin/cat', 13:08:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:41 INFO - 'PWD': '/builds/slave/test', 13:08:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:41 INFO - 'SHELL': '/bin/bash', 13:08:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:41 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:41 INFO - 'USER': 'cltbld', 13:08:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:41 INFO - 'XPC_FLAGS': '0x0', 13:08:41 INFO - 'XPC_SERVICE_NAME': '0', 13:08:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:41 INFO - Downloading/unpacking psutil>=0.7.1 13:08:41 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 13:08:41 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 13:08:41 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 13:08:41 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 13:08:41 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 13:08:41 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 13:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:44 INFO - Installing collected packages: psutil 13:08:44 INFO - Running setup.py install for psutil 13:08:44 INFO - building 'psutil._psutil_osx' extension 13:08:44 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 INFO - building 'psutil._psutil_posix' extension 13:08:45 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 13:08:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:08:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:08:45 INFO - ^ 13:08:45 INFO - 1 warning generated. 13:08:45 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 13:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:45 INFO - Successfully installed psutil 13:08:45 INFO - Cleaning up... 13:08:45 INFO - Return code: 0 13:08:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:45 INFO - 'HOME': '/Users/cltbld', 13:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:45 INFO - 'LOGNAME': 'cltbld', 13:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:45 INFO - 'MOZ_NO_REMOTE': '1', 13:08:45 INFO - 'NO_EM_RESTART': '1', 13:08:45 INFO - 'PAGER': '/bin/cat', 13:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:45 INFO - 'PWD': '/builds/slave/test', 13:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:45 INFO - 'SHELL': '/bin/bash', 13:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:45 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:45 INFO - 'USER': 'cltbld', 13:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:45 INFO - 'XPC_FLAGS': '0x0', 13:08:45 INFO - 'XPC_SERVICE_NAME': '0', 13:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:45 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 13:08:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:08:48 INFO - Installing collected packages: mozsystemmonitor 13:08:48 INFO - Running setup.py install for mozsystemmonitor 13:08:48 INFO - Successfully installed mozsystemmonitor 13:08:48 INFO - Cleaning up... 13:08:48 INFO - Return code: 0 13:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:08:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:48 INFO - 'HOME': '/Users/cltbld', 13:08:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:48 INFO - 'LOGNAME': 'cltbld', 13:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:48 INFO - 'MOZ_NO_REMOTE': '1', 13:08:48 INFO - 'NO_EM_RESTART': '1', 13:08:48 INFO - 'PAGER': '/bin/cat', 13:08:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:48 INFO - 'PWD': '/builds/slave/test', 13:08:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:48 INFO - 'SHELL': '/bin/bash', 13:08:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:48 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:48 INFO - 'USER': 'cltbld', 13:08:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:48 INFO - 'XPC_FLAGS': '0x0', 13:08:48 INFO - 'XPC_SERVICE_NAME': '0', 13:08:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:48 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 13:08:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:51 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 13:08:51 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 13:08:51 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 13:08:51 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 13:08:51 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 13:08:51 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 13:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:52 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 13:08:52 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 13:08:52 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 13:08:52 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 13:08:52 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 13:08:52 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 13:08:52 INFO - Downloading docopt-0.6.1.tar.gz 13:08:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:52 INFO - Running setup.py install for blobuploader 13:08:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:52 INFO - Running setup.py install for requests 13:08:53 INFO - Running setup.py install for docopt 13:08:53 INFO - Successfully installed blobuploader requests docopt 13:08:53 INFO - Cleaning up... 13:08:53 INFO - Return code: 0 13:08:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 13:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 13:08:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:53 INFO - 'HOME': '/Users/cltbld', 13:08:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:53 INFO - 'LOGNAME': 'cltbld', 13:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:53 INFO - 'MOZ_NO_REMOTE': '1', 13:08:53 INFO - 'NO_EM_RESTART': '1', 13:08:53 INFO - 'PAGER': '/bin/cat', 13:08:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:53 INFO - 'PWD': '/builds/slave/test', 13:08:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:53 INFO - 'SHELL': '/bin/bash', 13:08:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:53 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:53 INFO - 'USER': 'cltbld', 13:08:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:53 INFO - 'XPC_FLAGS': '0x0', 13:08:53 INFO - 'XPC_SERVICE_NAME': '0', 13:08:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-pwrXC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-F97vyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-zj63JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-CB2Xw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ShtWLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-_fSngh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-MsYeP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-6Tz2sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Kqc2Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-71B5Ig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-a2io5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NVM6OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-0Qu07X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AV5Xle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-8mNqrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sqMN6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:55 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-suJ7sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:55 INFO - Running setup.py install for manifestparser 13:08:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:55 INFO - Running setup.py install for mozcrash 13:08:55 INFO - Running setup.py install for mozdebug 13:08:56 INFO - Running setup.py install for mozdevice 13:08:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Running setup.py install for mozfile 13:08:56 INFO - Running setup.py install for mozhttpd 13:08:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Running setup.py install for mozinfo 13:08:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Running setup.py install for mozInstall 13:08:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:56 INFO - Running setup.py install for mozleak 13:08:56 INFO - Running setup.py install for mozlog 13:08:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Running setup.py install for moznetwork 13:08:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Running setup.py install for mozprocess 13:08:57 INFO - Running setup.py install for mozprofile 13:08:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Running setup.py install for mozrunner 13:08:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:57 INFO - Running setup.py install for mozscreenshot 13:08:57 INFO - Running setup.py install for moztest 13:08:58 INFO - Running setup.py install for mozversion 13:08:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:58 INFO - Cleaning up... 13:08:58 INFO - Return code: 0 13:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:08:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:08:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:08:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:08:58 INFO - 'HOME': '/Users/cltbld', 13:08:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:08:58 INFO - 'LOGNAME': 'cltbld', 13:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:58 INFO - 'MOZ_NO_REMOTE': '1', 13:08:58 INFO - 'NO_EM_RESTART': '1', 13:08:58 INFO - 'PAGER': '/bin/cat', 13:08:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:58 INFO - 'PWD': '/builds/slave/test', 13:08:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:08:58 INFO - 'SHELL': '/bin/bash', 13:08:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:08:58 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:08:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:08:58 INFO - 'USER': 'cltbld', 13:08:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:08:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:58 INFO - 'XPC_FLAGS': '0x0', 13:08:58 INFO - 'XPC_SERVICE_NAME': '0', 13:08:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-n_T1vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:58 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)) 13:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VF5hP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Mu4n3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:58 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)) 13:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ZclMiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:08:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-eJseKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-SPIbbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-I78LqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-zK6kVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-GGqPPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VoyJGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QjHk3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-FzdfPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:59 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4O9yfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 13:08:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:59 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-zqwkzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:00 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)) 13:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:00 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-hjV0lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:00 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)) 13:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:00 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-h2PZVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:00 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)) 13:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:00 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-YrKKYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:00 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)) 13:09:00 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:09:00 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:09:00 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)) 13:09:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:09:00 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:09:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:00 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 13:09:02 INFO - Downloading blessings-1.6.tar.gz 13:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:09:02 INFO - Installing collected packages: blessings 13:09:02 INFO - Running setup.py install for blessings 13:09:03 INFO - Successfully installed blessings 13:09:03 INFO - Cleaning up... 13:09:03 INFO - Return code: 0 13:09:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:03 INFO - Reading from file tmpfile_stdout 13:09:03 INFO - Current package versions: 13:09:03 INFO - blessings == 1.6 13:09:03 INFO - blobuploader == 1.2.4 13:09:03 INFO - docopt == 0.6.1 13:09:03 INFO - manifestparser == 1.1 13:09:03 INFO - mozInstall == 1.12 13:09:03 INFO - mozcrash == 0.17 13:09:03 INFO - mozdebug == 0.1 13:09:03 INFO - mozdevice == 0.48 13:09:03 INFO - mozfile == 1.2 13:09:03 INFO - mozhttpd == 0.7 13:09:03 INFO - mozinfo == 0.9 13:09:03 INFO - mozleak == 0.1 13:09:03 INFO - mozlog == 3.1 13:09:03 INFO - moznetwork == 0.27 13:09:03 INFO - mozprocess == 0.22 13:09:03 INFO - mozprofile == 0.28 13:09:03 INFO - mozrunner == 6.11 13:09:03 INFO - mozscreenshot == 0.1 13:09:03 INFO - mozsystemmonitor == 0.0 13:09:03 INFO - moztest == 0.7 13:09:03 INFO - mozversion == 1.4 13:09:03 INFO - psutil == 3.1.1 13:09:03 INFO - requests == 1.2.3 13:09:03 INFO - wsgiref == 0.1.2 13:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:03 INFO - 'HOME': '/Users/cltbld', 13:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:03 INFO - 'LOGNAME': 'cltbld', 13:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:03 INFO - 'MOZ_NO_REMOTE': '1', 13:09:03 INFO - 'NO_EM_RESTART': '1', 13:09:03 INFO - 'PAGER': '/bin/cat', 13:09:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:03 INFO - 'PWD': '/builds/slave/test', 13:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:03 INFO - 'SHELL': '/bin/bash', 13:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:09:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:03 INFO - 'USER': 'cltbld', 13:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:03 INFO - 'XPC_FLAGS': '0x0', 13:09:03 INFO - 'XPC_SERVICE_NAME': '0', 13:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:03 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 2)) 13:09:03 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 3)) 13:09:03 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 4)) 13:09:03 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 5)) 13:09:03 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 6)) 13:09:03 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 7)) 13:09:03 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 8)) 13:09:03 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 9)) 13:09:03 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:09:03 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 4)) 13:09:03 INFO - Cleaning up... 13:09:03 INFO - Return code: 0 13:09:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 13:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 13:09:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:09:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:03 INFO - 'HOME': '/Users/cltbld', 13:09:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:03 INFO - 'LOGNAME': 'cltbld', 13:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:03 INFO - 'MOZ_NO_REMOTE': '1', 13:09:03 INFO - 'NO_EM_RESTART': '1', 13:09:03 INFO - 'PAGER': '/bin/cat', 13:09:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:03 INFO - 'PWD': '/builds/slave/test', 13:09:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:03 INFO - 'SHELL': '/bin/bash', 13:09:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:09:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:09:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:03 INFO - 'USER': 'cltbld', 13:09:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:03 INFO - 'XPC_FLAGS': '0x0', 13:09:03 INFO - 'XPC_SERVICE_NAME': '0', 13:09:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:03 INFO - Downloading/unpacking jsonschema 13:09:03 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 13:09:03 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 13:09:03 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 13:09:03 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 13:09:03 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 13:09:03 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 13:09:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 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 13:09:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:06 INFO - warning: no files found matching '*.txt' 13:09:06 INFO - no previously-included directories found matching 'build' 13:09:06 INFO - no previously-included directories found matching 'dist' 13:09:06 INFO - no previously-included directories found matching '.git*' 13:09:06 INFO - Installing collected packages: jsonschema, functools32 13:09:07 INFO - Running setup.py install for functools32 13:09:07 INFO - warning: no files found matching '*.txt' 13:09:07 INFO - no previously-included directories found matching 'build' 13:09:07 INFO - no previously-included directories found matching 'dist' 13:09:07 INFO - no previously-included directories found matching '.git*' 13:09:07 INFO - Successfully installed jsonschema functools32 13:09:07 INFO - Cleaning up... 13:09:07 INFO - Return code: 0 13:09:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ef89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef904c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff341473020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/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.oQknvpPgrJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 13:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 13:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:07 INFO - 'HOME': '/Users/cltbld', 13:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:07 INFO - 'LOGNAME': 'cltbld', 13:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:07 INFO - 'MOZ_NO_REMOTE': '1', 13:09:07 INFO - 'NO_EM_RESTART': '1', 13:09:07 INFO - 'PAGER': '/bin/cat', 13:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:07 INFO - 'PWD': '/builds/slave/test', 13:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:07 INFO - 'SHELL': '/bin/bash', 13:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:09:07 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:07 INFO - 'USER': 'cltbld', 13:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:07 INFO - 'XPC_FLAGS': '0x0', 13:09:07 INFO - 'XPC_SERVICE_NAME': '0', 13:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:07 INFO - Downloading/unpacking flake8 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:07 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 13:09:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:09:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:09 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 13:09:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:09:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:10 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 13:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:09:11 INFO - no previously-included directories found matching 'docs/_build' 13:09:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:09:11 INFO - Running setup.py install for pep8 13:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:09:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:09:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:09:11 INFO - no previously-included directories found matching 'docs/_build' 13:09:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:09:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:09:11 INFO - Cleaning up... 13:09:11 INFO - Return code: 0 13:09:11 INFO - Running post-action listener: _resource_record_post_action 13:09:11 INFO - Running post-action listener: _start_resource_monitoring 13:09:11 INFO - Starting resource monitoring. 13:09:11 INFO - ##### 13:09:11 INFO - ##### Running install step. 13:09:11 INFO - ##### 13:09:11 INFO - Running pre-action listener: _resource_record_pre_action 13:09:11 INFO - Running main action method: install 13:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:09:12 INFO - Reading from file tmpfile_stdout 13:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:09:12 INFO - Reading from file tmpfile_stdout 13:09:12 INFO - Output received: 13:09:12 INFO - Usage: mozinstall [options] installer 13:09:12 INFO - Options: 13:09:12 INFO - -h, --help show this help message and exit 13:09:12 INFO - -d DEST, --destination=DEST 13:09:12 INFO - Directory to install application into. [default: 13:09:12 INFO - "/builds/slave/test"] 13:09:12 INFO - --app=APP Application being installed. [default: firefox] 13:09:12 INFO - mkdir: /builds/slave/test/build/application 13:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:09:35 INFO - Reading from file tmpfile_stdout 13:09:35 INFO - Output received: 13:09:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:09:35 INFO - Running post-action listener: _resource_record_post_action 13:09:35 INFO - ##### 13:09:35 INFO - ##### Running run-tests step. 13:09:35 INFO - ##### 13:09:35 INFO - Running pre-action listener: _resource_record_pre_action 13:09:35 INFO - Running main action method: run_tests 13:09:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:09:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:09:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:09:35 INFO - 2016-05-23 13:09:35.062 screenresolution[2306:21154] starting screenresolution argv=screenresolution get 13:09:35 INFO - 2016-05-23 13:09:35.065 screenresolution[2306:21154] Display 0: 1600x1200x32@60 13:09:35 INFO - 2016-05-23 13:09:35.071 screenresolution[2307:21156] starting screenresolution argv=screenresolution list 13:09:35 INFO - Available Modes on Display 0 13:09:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:09:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:09:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:09:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:09:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:09:35 INFO - Intel Iris: 13:09:35 INFO - Chipset Model: Intel Iris 13:09:35 INFO - Type: GPU 13:09:35 INFO - Bus: Built-In 13:09:35 INFO - VRAM (Dynamic, Max): 1536 MB 13:09:35 INFO - Vendor: Intel (0x8086) 13:09:35 INFO - Device ID: 0x0a2e 13:09:35 INFO - Revision ID: 0x0009 13:09:35 INFO - Displays: 13:09:35 INFO - Display: 13:09:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:09:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:09:35 INFO - Display Serial Number: 1600x1200 60 13:09:35 INFO - Main Display: Yes 13:09:35 INFO - Mirror: Off 13:09:35 INFO - Online: Yes 13:09:35 INFO - Rotation: Supported 13:09:35 INFO - Return code: 0 13:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:35 INFO - Python 2.7.3 13:09:35 INFO - Return code: 0 13:09:35 INFO - grabbing minidump binary from tooltool 13:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:35 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 0x10ee2dd30>, '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 0x10ec91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee24b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:35 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 13:09:35 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 13:09:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:35 INFO - Return code: 0 13:09:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:09:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:09:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:09:36 INFO - Return code: 0 13:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FylbEF6DZj/Render', 13:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:09:36 INFO - 'HOME': '/Users/cltbld', 13:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:09:36 INFO - 'LOGNAME': 'cltbld', 13:09:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:36 INFO - 'MOZ_NO_REMOTE': '1', 13:09:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:36 INFO - 'NO_EM_RESTART': '1', 13:09:36 INFO - 'PAGER': '/bin/cat', 13:09:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:36 INFO - 'PWD': '/builds/slave/test', 13:09:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:09:36 INFO - 'SHELL': '/bin/bash', 13:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oQknvpPgrJ/Listeners', 13:09:36 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 13:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:09:36 INFO - 'USER': 'cltbld', 13:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:36 INFO - 'XPC_FLAGS': '0x0', 13:09:36 INFO - 'XPC_SERVICE_NAME': '0', 13:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:09:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:09:36 INFO - mozversion application_buildid: 20160523111242 13:09:36 INFO - mozversion application_changeset: 59dbf171604d52960e6e54cbefdb52d7bbcb989d 13:09:36 INFO - mozversion application_display_name: Firefox 13:09:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:36 INFO - mozversion application_name: Firefox 13:09:36 INFO - mozversion application_remotingname: firefox 13:09:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:09:36 INFO - mozversion application_vendor: Mozilla 13:09:36 INFO - mozversion application_version: 47.0 13:09:36 INFO - mozversion platform_buildid: 20160523111242 13:09:36 INFO - mozversion platform_changeset: 59dbf171604d52960e6e54cbefdb52d7bbcb989d 13:09:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:09:36 INFO - mozversion platform_version: 47.0 13:09:36 INFO - using testdate: 1464034176 13:09:36 INFO - actual date: 1464034176 13:09:36 INFO - starting webserver on 'localhost:53536' 13:09:36 INFO - SUITE-START | Running 2 tests 13:09:36 INFO - TEST-START | dromaeo_css 13:09:36 INFO - operating with platform_type : mac_ 13:09:36 INFO - Initialising browser for dromaeo_css test... 13:09:36 INFO - TEST-INFO | started process 2325 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpUzpOmJ/profile http://localhost:53536/getInfo.html) 13:09:38 INFO - PROCESS | 2325 | __metrics Screen width/height:1600/1200 13:09:38 INFO - PROCESS | 2325 | colorDepth:24 13:09:38 INFO - PROCESS | 2325 | Browser inner width/height: 1024/689 13:09:38 INFO - PROCESS | 2325 | __metrics 13:09:38 INFO - PROCESS | 2325 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:09:38 INFO - PROCESS | 2325 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:39 INFO - TEST-INFO | 2325: exit 0 13:09:39 INFO - Browser initialized. 13:09:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:39 INFO - TEST-INFO | started process 2328 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpUzpOmJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:51 INFO - PROCESS | 2328 | RSS: Main: 156991488 13:09:51 INFO - PROCESS | 2328 | 13:10:42 INFO - PROCESS | 2328 | 1464034242263 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] 13:12:51 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53536/tests/dromaeo/cssquery-ext.html) 13:12:53 INFO - PROCESS | 2328 | RSS: Main: 274337792 13:12:53 INFO - PROCESS | 2328 | 13:15:55 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-ext.html (next: http://localhost:53536/tests/dromaeo/cssquery-jquery.html) 13:15:56 INFO - PROCESS | 2328 | RSS: Main: 289517568 13:15:56 INFO - PROCESS | 2328 | 13:18:58 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53536/tests/dromaeo/cssquery-mootools.html) 13:18:58 INFO - PROCESS | 2328 | RSS: Main: 294764544 13:18:58 INFO - PROCESS | 2328 | 13:22:00 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53536/tests/dromaeo/cssquery-prototype.html) 13:22:01 INFO - PROCESS | 2328 | RSS: Main: 255414272 13:22:01 INFO - PROCESS | 2328 | 13:25:04 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53536/tests/dromaeo/cssquery-yui.html) 13:25:04 INFO - PROCESS | 2328 | RSS: Main: 252846080 13:25:04 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | Cycle 1(1): loaded http://localhost:53536/tests/dromaeo/cssquery-yui.html (next: http://localhost:53536/tests/dromaeo/cssquery-dojo.html) 13:28:07 INFO - PROCESS | 2328 | RSS: Main: 301903872 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | __start_tp_report 13:28:07 INFO - PROCESS | 2328 | _x_x_mozilla_page_load 13:28:07 INFO - PROCESS | 2328 | _x_x_mozilla_page_load_details 13:28:07 INFO - PROCESS | 2328 | |i|pagename|runs| 13:28:07 INFO - PROCESS | 2328 | |0;dojo.html;3515.156362473006;3578.6779189872905;3583.0684022154232;3600.5139306193664;3639.636036396361;4836.637252206086;5882.117682347639;5883.911741323878;5902.291724992996;5987.191729116574;5916.349201587822;5951.285845698522;5957.225560677106;5968.79109231177;5971.164037034819;5218.608604354669;5266.683998960075;5274.393444753864;5303.310569625944;5333.786648534054;5373.408925018245;5381.031414345416;5391.245225668409;5399.055165346068;5406.270153529263;5308.203769434577;5354.437784032679;5370.812021579245;5374.516293533581;5380.381256155553;5366.9463305366835;5376.1398176291805;5384.434634363374;5394.083005889008;5419.403865574784;5151.201563757623;5314.5748340132695;5327.094393953037;5327.174287985368;5328.040952628526;4566.972431202986;5748.770049198027;5810.709464526799;5814.563907706896;5822.951868663639;6219.906701399483;6386.265579458375;6391.936080639181;6399.072134540465;6402.007688808242;6271.937280627181;6282.277538083134;6306.1486699295465;6341.1756471658855;6342.778002769927;5941.10883367494;5982.820515384546;5986.102084687332;5989.760409583655;5993.280806303272;6247.187865577446;6279.309275979638;6378.617282962944;6384.265809431882;6400.519961002943;6300.842478938063;6335.841603959938;6353.841153971188;6361.777337793247;6371.33101024395;6353.618782873043;6353.936460635427;6358.968205159037;6380.457661098766;6382.393672601095;6230.7507699691505;6266.749330026839;6312.652804095819;6381.074744162071;6404.199475065617;6334.873302533923;6384.553081284358;6390.488760899117;6393.424591786761;6414.935850641527;4972.627052971042;4976;4976.178930476503;4977.527134922177;5012.774425150877;3815.1797363566966;4373.103513779667;4395.912081758347;4490.079533695584;4530.932036019462;6102.511799056065;6102.664353460602;6108.938910610926;6111.650364618297;6143.754249829957;5536.363318218457;6295.937040629535;6314.147590075281;6324.873502529924;6330.4619107375465;5844.444777746107;6029.487493563096;6103.804638292137;6103.84740381494;6111.54163437744;5497.532709719639;5515.283013208337;5521.171824226318;5521.4478552145265;5523.640963337451;6521.380468855451;6529.608223506605;6539.5422320438065;6561.212654481493;6567.113439685581;6219.782307619212;6254.655993920378;6299.811005669837;6309.779157729457;6313.715882785194;6492.577982431127;6502;6503.02454631809;6511.186101737283;6517.771877984437;6323.36766323364;6351.714172862325;6352.714127864349;6362.968185159045;6375.458086062551;6172.888880001643;6206;6246.656433895998;6274.341194174728;6290.8427289316305;6276.466500347522;6277.058441233851;6295.622262664255;6301.6219026858535;6308.558400911892;6127.464420129145;6278.183836101278;6288.245410550763;6292.811215663354;6302.810915672537;6119.082137679384;6139.338817383189;6163.044728067157;6166.4758495526585;6180.165677633642;6211.751529938751;6297.433231009048;6312.652804095819;6318.526110541636;6331.683415829282;6022.668753218615;6072.574919755575;6093.9390606093375;6120.44915957566;6200.472959798287 13:28:07 INFO - PROCESS | 2328 | |1;ext.html;449.5235050846101;560.6243816642849;563.276190095727;606.6178307666172;652.7225928980183;27310.590341144874;39236.80381598088;39247;39361.60638393615;39402.99999999996;41420.17159656805;42011.78994105025;42030;42041;42142.7892860536;9786.85319720203;10038.34750741203;10055.597776088947;10063.949680251626;10064.748381290454;9793.657221997231;9921.255905807056;9924.702258932244;9951.800963980717;10059.597616095347;10009.949950250275;10070.194384449263;10084.899151008469;10087.394756314645;10092.444915529642;9979.550920208572;10048.799024019552;10065.647702330383;10103.343282686601;10111.241656875764;9921.10710036093;10058.89941100587;10066;10067.194624430029;10069;40839.38740918859;41175.38236926449;41182.38226426606;41234.96912577179;41313;3180.761442891769;3249.366373557157;3343.9498407523906;3398.6261511233743;3714.4428335749585;26269.868650656816;28633.141005769652;29397.265068373246;29459.852700736574;29616;2741.876615552305;2791.7068707785593;2819.210621026116;2844.5875348074414;2891.334992951612;497665;497723;498648;498843;499376;46163.30755038677;46720.766396167804;60280;60808.08787868186;60871.69564152151;46868.06263874772;47048.764756176;47575.28637070447;47679;47694.5230547697;16463.176841157896;16660.58348541296;16666.6666666666;16683.749743753855;16703.582410439838;13091.345432728325;13138.211707297593;13165.736685266242;13169.802452963213;13173.946084313231;14886.404543818126;14919.179445130405;14940.178290193926;14954.626134346729;15015.849841501664;6226.439620434183;6398.488120950313;6537.346265373425;6554.541182117206;6570.375814297634;949.3070058856935;988.6045581767207;1031.7214352124884;1131.2251107991053;1136.0457215938486;30130.37373136696;30181.849090754407;30315.393692126036;30401.956349936077;30680.693193067782;1080.5407701726735;1126.0934947367284;1136.4261048170786;1189.8869607387458;1195.235049568277;14102.435902563988;14119.364628591738;14388.06477578954;14483.78274325886;14583.05210161336;550683;555130.4486955078;555736;556931;557053;56915.430845691844;57028.144577831365;57117.42882571204;57181;57189;1436.1957303909635;1487.256371814093;1506.3070987345943;1515.5377609828888;1621.4162901355503;28694.713052869203;28743.712562874105;29066.982655606953;29279.560806588343;29312.41375172527;44899.77550112228;45157.77421112874;45619;45626.315605265285;45710.54289457063;414239;417900;418459;419763;420710;29155.708442916148;32413.18967025843;32908;33042.008739737845;33383.66616333806;39433.80283098566;39610.009749756486;40808.38787418132;41158;41294.1741165181;33430.83284583561;33492.832535837166;34680.17833810443;35318.29363412769;36191.91424257276;31057.0682879514;32932.01203963789;35169.82415087908;35438.11404714903;35745.82127089452;34580.789672361345;34890.58787270158;35120.47319290264;35569.28861422809;35710.4643430354;29673.85163074171;30531.93454803286;31104.65404563815;31273;33241.33517329591;25036.74963250344;25208.78363875114;25236.747632524173;25691.972321106947;25873.22380328593 13:28:07 INFO - PROCESS | 2328 | |2;jquery.html;332.54441415261095;381.30411998103466;382.98851034468964;383.5972229159382;393.3490073927647;20421.795782042194;20686.379408617748;20981.055852486636;21750;21750.782492175073;20981.37055888322;21079.367618971417;21301.786982130212;21329.93350332481;21445.463863403424;5644.717764111788;5907.852303692399;5951;5987.341392446828;5989.341172471025;3698.6301369863068;4612.100640375128;5745.655260684352;6243.282022567418;6539.6730163491875;6473.255575608795;6477.74089036438;6486.643234622094;6490.188726409199;6490.545661803676;6173.783917562886;6491.285958544557;6503.28463868974;6503.349665033506;6521;5013.774380152902;5424.294841670597;5623.015972204888;5644.491995720364;5651.576131790132;13109.672258193526;13595.252261125634;13607.183568985893;13620.727585448334;13630;2172.5144011371412;2185.3007037747925;2269.5574362999223;2325.4186453386656;2639.934001649955;9841.360311579725;10063.14463270623;10104.797904041952;10424.322419042737;12166;1760.9647807043787;1852.3239017758556;1865.6362009408172;1875.2405275863298;1939.0692467615625;95856;98436.50781746117;101098;101411.49294253555;101470;9137.223336016514;11134.49894754738;11301.26541774782;11331.886681133083;11472.713182170513;13738.450461981409;13797.655058623615;13798.517051903134;13817.447302107803;13830.86169138316;8389.454685445426;8633.007204171476;8681.869771953427;8757.343199259954;8773;8820.691275805317;8837.204651581389;8841.513716745641;8906.821863562693;8910;3791.962080379216;4363.890902727458;4410.1400226956075;4483.170613436525;4525.818967241339;1500.664408676279;1821.902370549039;1830.5789668376349;1860.6929856573784;1865.8040905704977;801.723405425139;966.3139171188535;979.9363041402286;1041.739565108723;1061.2571200159764;19901.104450299772;21017.579648406947;21269.46826329354;21282;21581;863.7797361672733;974.5565767575736;998.2313618513704;1012.7366884610054;1042.1089968077185;10984.945075274572;11252.606158784403;11273.943630281796;11280.943595281971;11287.153463490271;542228;542741;552351.2382438062;668463;678550;78556;78612;94160.52919735358;115585;131618;1049.2655141401049;1071.5713714514102;1089.4824958144818;1089.727568107973;1094.6168840905777;18545.44363669092;18911.527211819815;18997.43007709771;19591.824490530613;19870.006499675248;52345.7382713084;54072;54881.042248872895;55582.72208638931;55758;78266.82599760895;80211;80442.19557804581;81058.78411823709;84159.5792021036;7907.84184316299;8191.959040204761;8269.255766981001;8363.874541881754;8399.118092600189;9608.711738647851;13187.60437186886;13441.193528388329;13503.189808611514;13650.044496885122;11267.323960562393;11579.073674105883;11701.707457313636;11783.705407364885;11881.821772673244;11133.387663678575;11282.548698051985;11384.316940983568;11485.138614603771;11568.421578921188;11641;11738.530458781554;11843.052555795688;11974.940125299318;12051.51793928233;8146.796330091795;8156.510609363457;8331.541765202972;8336.249737523653;8445.831083378422;8581.699640512552;11024.393658348868;11633.127515436545;12043.458044388199;12145.14983951115 13:28:07 INFO - PROCESS | 2328 | |3;mootools.html;1361.6731984323765;1596.5689263898744;1599.2963096237654;1699.3287651377698;1794.676958147533;8291.378146639003;8718.912810871889;8958.41770284931;8961.417507861985;8964.731058068252;8739.606717697703;9003.279737620975;9025.548722563863;9028.638854445831;9042.502662353569;2506.385935445818;2535.746425357468;2536.378587246127;2539.4540173862615;2540;2203.867767933921;2413.81896357773;2556.8593727344987;2558.872056397182;2564.76917077463;2496.251124662603;2512.849229046263;2546.4907018596264;2551;2551.081610620175;2521.420073383132;2535.632333311669;2548.885300161488;2560.6287088372083;2567.56351420259;2495.6755621769053;2533.2020413569667;2533.5439620868237;2534.6451496790464;2537.9974909910484;9022.278217742565;9103.544822758835;9103.63585456581;9135.314851386107;9144.908550914472;5508.91736623947;5621.522170615503;5663.546916246691;5683.630564013326;5691.26013618227;3575.6960658344074;3650.689691376236;3720.4977328060636;3729.459228411892;3732.701383889282;1056.6037735849056;1078.730317420645;1078.8705355357329;1082.6048492300333;1107.396468924438;12324.630261092181;12356.8146477802;12362.01103911685;12392;12414.565490207799;4893.779779909913;4988.476209997971;5017.197248440232;5050.84847454577;5081.0854046272025;10430.530626121843;10437.373757574418;10491.737706557396;10514.737131571772;10515.158787296998;5658.971705141448;5665.49010589049;5670.886582268414;5681.176229446707;5684.9431505684415;3856.614338566177;4793.592544633745;4888.462269150391;5024.221245706921;5127.769250383742;3982.8406863725127;4003.8398464061693;4038.8990275243355;4062.370332598452;4086.6117718816663;1323.6293837725452;1333.8999575031912;1334.4728832111261;1348.9460421583224;1354.2551596621818;1349.6625843539116;1366.6993261482457;1407.4862675123711;1413.7172565486737;1417.5818133650598;8352.997640283205;8363.080061193265;8403.453775504573;8407.327413806881;8459.407841451039;512.3237326728682;515.7653267763159;520.4301290087349;522.1775703267369;526.6129394894749;6314.0844577536;6339.270983836917;6395.744170233139;6409.102725618417;6410.294867564658;8746.34402419821;11070.059044981106;11077.446127693744;11084.612038578773;11099.500522476508;10613.681589552172;10764.677059688222;10826.783464330827;10847.566097356175;10928.562857485771;8529.616167272363;8573.314134869195;8596.8710469343;8604.0965698602;8698.21716045559;8050.87923681157;8082.555459449787;8131.390145738975;8134.918650813416;8144.063432705315;9700.563474643517;9784.85322720174;9881.802363952824;10045.146162575971;10057.446840423847;9821.950890245504;10150.492475376053;10356;10361.896381036093;10363.378197308186;7647.005889234364;7665.770026899202;7671.194524574839;7758.340541054074;7760.3403710685225;8409.495430274203;8455.112213217524;8520.914790852012;8523.445976011539;8525.019622743464;7499.1750907399055;7635.350995165251;7712.460127791001;7714.575698336421;7733.690652374067;7339.522931009467;7432.405407567274;7442.479026468095;7558.357539609195;7564.659590318339;7990.760277191694;8045.718399855977;8063.596820159086;8065.1934806518875;8081.515109093473;7214.386777124003;7243.348098671145;7278;7312.085989251344;7316.707331706885;6516.250631177475;7362.852742945218;7390.704371825067;7426.108866936002;7433.405327573889 13:28:07 INFO - PROCESS | 2328 | |4;prototype.html;338.0517647997367;341.81371152721766;345.6439866937056;347.69576620457093;352.0828242428472;5007.52428519291;6660.9000864987;6679.2318883328435;6685.298043705414;6793.01107512694;6658.167729033871;6682.59904405736;6704.22901366343;6705.564138331018;6711.697973591188;4780.737059461728;4876.683015603974;4918.262260660912;4967.056259310738;5019.949800501994;4999.450060493343;5008.774605142778;5026.29631851541;5036.564579094958;5070.695758254498;4927.359443272369;4941.728204948727;4943;4949.628777841658;4983.177775667011;4748.192807222763;4777.761111944389;4889.608831293488;4934.629902757308;4948.208286674115;4218.6835987300765;4221.07136429988;4231.70378073535;4233.1956928183545;4235.0682849773;5649.802256921029;5906.202662640531;6424.807255782334;6427.42153206209;6435.581687190364;5365.758540865631;5786.247787787603;5786.855328616776;5797.130430435468;5801.187833703285;6079.787207447718;6850.554713943628;6852.897206541906;7132.179799323092;7167.319104685047;4717.669763116583;4739;4742.5731684148595;4748.19280722278;4751.026039661861;7500.5874676892745;7527.9247207528315;7531;7548.735794247175;7584.089909210875;4808.903821923542;4809.711417314972;4814.013127308894;4820.469748327681;4833.154198015333;4879.658423910363;4882.12121818069;4883.926741098886;4884.48712885142;4893.290472881412;4723.834665786681;5747.942520574741;5806.158107074535;5812.912806307909;5820.854478638068;6835.1114355134505;7158.355747982707;7173;7194.568325900358;7204.9639751800905;1700.8554272886943;1711.8701656906383;1725.5254804928745;1728.032301910934;1730.480855743272;1072.8873468285717;1100.1308965916996;1113.0761467981556;1125.1336470917347;1147.6270212181075;6744.595324280559;6858.142732158481;6915.861682766316;6919.135108111486;6926.238113807477;6171.382861713792;7456.85086298271;7472;7515.549067055885;7532.887006694904;6849.109615750021;6932.480063995221;6945.617991010543;6945.7221711132;6960.582365058112;3812.885613431546;3929.371300591949;3964.861229856941;3967.6429121379215;3971.7021223407783;7904.4071694623135;7934.603269836485;7936.206379362017;7945.364370850318;7952;6485.77299794505;7438.5536867788105;7717.382609391235;7722.189170137167;7750.302472777477;7837.49056311338;7850.919506330827;7889.605519723991;7892.395509481972;7903.091144518224;6372.490200783834;7166.211716711054;7220.241874603091;7464.290892365217;7483.214262502359;7275.490715649854;7314.08573928259;7325.120985481776;7347.375473084634;7369.115706115301;5703.001974654336;6352.745890164341;7857.135715071452;7870.645820937957;7891.408144389308;4918.606511479002;4922.261660750916;4927.778249978831;4936.531029552187;4940.086084074458;6228.813135605757;6986.973777604438;7419.811155708971;7423.146338171179;7432.591207483641;7105.609191494517;7162.677679504331;7187.676554554953;7191.460640452092;7192.640367981476;7154.856902861809;7173.964130179315;7183.604901730455;7192.568445893263;7202.603856787927;7010.474214433836;7011.824704382431;7017.543859649107;7031.472639552157;7032.331928466788;6691;6953.6523173842115;7149.7497587584185;7220.205777364381;7233.059702238886;6789.490788190807;6934.06390137325;6941.132358455193;6955.269696681978;7089.432845372255 13:28:07 INFO - PROCESS | 2328 | |5;yui.html;697.7906628011597;735.2610626320554;736.3924762071289;747.7420289999948;773.3156156801231;15515;15903.966242194248;15905.761413578806;15908.125053122074;15950.441734539294;14429.350679219435;14618.926905365484;14635.341409636565;14663.900207484454;14975.176365299903;928.350154891577;931.1200915135166;949.3402085550545;949.3971328206604;950.8193443245796;824.8185399212164;837.5853952293593;936.0499093420184;959.3045042344314;961;1016.9338992965434;1019.7705516258857;1020.6937918624383;1021.4688362051729;1025.4923812712718;866.2939704141105;984.4979060679034;1013.4324778124274;1016.0398423489805;1017.4607458047246;760.741347941697;761.478387304698;762.0208032677982;763.9809004774869;765.414457939671;15545.689086218212;15636.843631563652;15650.765238521431;15655.765163522556;15656.982296150714;12807.487700491969;12991.610251692464;13080.86919130806;13108.737825243441;13237.271950042743;10376.325538840027;10637.57449702011;10786.622468213653;10910.454477276104;11057.944710276397;3057.7095175958248;3632.5640923089136;3659.6340365963456;3664.157243833933;3891.0855948851995;77806.61096694537;77950;77986.22013779846;78183.43633127306;79263.20736792615;9010.86483702745;9319.767005824908;9444.244460443286;9531.99914009033;9684.225261979025;21194.364169074954;21195.47011324729;21577.24479643205;21816;21822.454438638844;7817;7854.3716502679645;7909.169537198626;7962;7970.123286438487;4206.927233555424;4305.7201281917205;4367.235733746582;4381.6932814703305;4441.067375851043;3577.8032208228797;3608.1340478285024;3612.3497770401054;3615.9638403616154;3617.168051348152;635.2726128582839;638.6902352359102;639.9840003999844;654.1365397675119;655.0796131435341;536.1903525676179;574.9022666146765;602.3735315272155;605.7370382752011;632.2697284636253;8290.088155233148;8463.957680211559;8553.272971797342;8664.263537599374;8819.9416070072;607.5473772039859;613.408061220924;614.7295190116334;619.0899377914459;628.0641843652925;3434.8321570665594;3760.2291530236234;3811.2377524495214;3914;3991.6607088397814;95534.5223273893;96234;97359;102790;103072.48463757633;85671;86417.13582864091;87024;87131;87211.12788872157;70593.9410908847;71829;73589.89615155777;74882.6255868728;77508.22491775123;7760.223977602194;7883.64523596451;8086.43394962347;8096.947396838374;8111;52658.736706316224;52906.206406903155;53469.19796203138;54012;54330;64968.35031649812;74266.68733157743;74916;75294.87057694249;75820.48359032678;9830.361026533252;9909.108180263811;10055;10252.487375631039;10380.27338086357;10806.729831754268;11084.445777711244;11100.722481938015;11102.500387482422;11368.431578420881;9343.813123737624;10558.524866380878;10644.20168487382;10739.942171835175;10854.945725271638;10532.684019479428;10538.998795114452;10605;10942.617008404986;11150.832737508781;9411.670591529537;9498.430094194371;9559.044095590385;9585.90414095878;9837.803243935225;9099.454032758056;9255.305852061258;9280.675176369065;9401.952990235006;9618.182454491447;8968.86546701787;9054.230390416888;9083.137101975302;9108.544572771467;9119.316051296311 13:28:07 INFO - PROCESS | 2328 | __end_tp_report 13:28:07 INFO - PROCESS | 2328 | __start_cc_report 13:28:07 INFO - PROCESS | 2328 | _x_x_mozilla_cycle_collect,1066 13:28:07 INFO - PROCESS | 2328 | __end_cc_report 13:28:07 INFO - PROCESS | 2328 | __startTimestamp1464035287302__endTimestamp 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | ------- Summary: start ------- 13:28:07 INFO - PROCESS | 2328 | Number of tests: 6 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#0] dojo.html Cycles:165 Average:5880.12 Median:6143.75 stddev:665.79 (10.8%) stddev-sans-first:641.46 13:28:07 INFO - PROCESS | 2328 | Values: 3515.2 3578.7 3583.1 3600.5 3639.6 4836.6 5882.1 5883.9 5902.3 5987.2 5916.3 5951.3 5957.2 5968.8 5971.2 5218.6 5266.7 5274.4 5303.3 5333.8 5373.4 5381.0 5391.2 5399.1 5406.3 5308.2 5354.4 5370.8 5374.5 5380.4 5366.9 5376.1 5384.4 5394.1 5419.4 5151.2 5314.6 5327.1 5327.2 5328.0 4567.0 5748.8 5810.7 5814.6 5823.0 6219.9 6386.3 6391.9 6399.1 6402.0 6271.9 6282.3 6306.1 6341.2 6342.8 5941.1 5982.8 5986.1 5989.8 5993.3 6247.2 6279.3 6378.6 6384.3 6400.5 6300.8 6335.8 6353.8 6361.8 6371.3 6353.6 6353.9 6359.0 6380.5 6382.4 6230.8 6266.7 6312.7 6381.1 6404.2 6334.9 6384.6 6390.5 6393.4 6414.9 4972.6 4976.0 4976.2 4977.5 5012.8 3815.2 4373.1 4395.9 4490.1 4530.9 6102.5 6102.7 6108.9 6111.7 6143.8 5536.4 6295.9 6314.1 6324.9 6330.5 5844.4 6029.5 6103.8 6103.8 6111.5 5497.5 5515.3 5521.2 5521.4 5523.6 6521.4 6529.6 6539.5 6561.2 6567.1 6219.8 6254.7 6299.8 6309.8 6313.7 6492.6 6502.0 6503.0 6511.2 6517.8 6323.4 6351.7 6352.7 6363.0 6375.5 6172.9 6206.0 6246.7 6274.3 6290.8 6276.5 6277.1 6295.6 6301.6 6308.6 6127.5 6278.2 6288.2 6292.8 6302.8 6119.1 6139.3 6163.0 6166.5 6180.2 6211.8 6297.4 6312.7 6318.5 6331.7 6022.7 6072.6 6093.9 6120.4 6200.5 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#1] ext.html Cycles:180 Average:62327.71 Median:18363.81 stddev:131499.75 (716.1%) stddev-sans-first:131786.58 13:28:07 INFO - PROCESS | 2328 | Values: 449.5 560.6 563.3 606.6 652.7 27310.6 39236.8 39247.0 39361.6 39403.0 41420.2 42011.8 42030.0 42041.0 42142.8 9786.9 10038.3 10055.6 10063.9 10064.7 9793.7 9921.3 9924.7 9951.8 10059.6 10009.9 10070.2 10084.9 10087.4 10092.4 9979.6 10048.8 10065.6 10103.3 10111.2 9921.1 10058.9 10066.0 10067.2 10069.0 40839.4 41175.4 41182.4 41235.0 41313.0 3180.8 3249.4 3343.9 3398.6 3714.4 26269.9 28633.1 29397.3 29459.9 29616.0 2741.9 2791.7 2819.2 2844.6 2891.3 497665.0 497723.0 498648.0 498843.0 499376.0 46163.3 46720.8 60280.0 60808.1 60871.7 46868.1 47048.8 47575.3 47679.0 47694.5 16463.2 16660.6 16666.7 16683.7 16703.6 13091.3 13138.2 13165.7 13169.8 13173.9 14886.4 14919.2 14940.2 14954.6 15015.8 6226.4 6398.5 6537.3 6554.5 6570.4 949.3 988.6 1031.7 1131.2 1136.0 30130.4 30181.8 30315.4 30402.0 30680.7 1080.5 1126.1 1136.4 1189.9 1195.2 14102.4 14119.4 14388.1 14483.8 14583.1 550683.0 555130.4 555736.0 556931.0 557053.0 56915.4 57028.1 57117.4 57181.0 57189.0 1436.2 1487.3 1506.3 1515.5 1621.4 28694.7 28743.7 29067.0 29279.6 29312.4 44899.8 45157.8 45619.0 45626.3 45710.5 414239.0 417900.0 418459.0 419763.0 420710.0 29155.7 32413.2 32908.0 33042.0 33383.7 39433.8 39610.0 40808.4 41158.0 41294.2 33430.8 33492.8 34680.2 35318.3 36191.9 31057.1 32932.0 35169.8 35438.1 35745.8 34580.8 34890.6 35120.5 35569.3 35710.5 29673.9 30531.9 31104.7 31273.0 33241.3 25036.7 25208.8 25236.7 25692.0 25873.2 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#2] jquery.html Cycles:180 Average:33611.59 Median:11968.04 stddev:99295.95 (829.7%) stddev-sans-first:99543.06 13:28:07 INFO - PROCESS | 2328 | Values: 332.5 381.3 383.0 383.6 393.3 20421.8 20686.4 20981.1 21750.0 21750.8 20981.4 21079.4 21301.8 21329.9 21445.5 5644.7 5907.9 5951.0 5987.3 5989.3 3698.6 4612.1 5745.7 6243.3 6539.7 6473.3 6477.7 6486.6 6490.2 6490.5 6173.8 6491.3 6503.3 6503.3 6521.0 5013.8 5424.3 5623.0 5644.5 5651.6 13109.7 13595.3 13607.2 13620.7 13630.0 2172.5 2185.3 2269.6 2325.4 2639.9 9841.4 10063.1 10104.8 10424.3 12166.0 1761.0 1852.3 1865.6 1875.2 1939.1 95856.0 98436.5 101098.0 101411.5 101470.0 9137.2 11134.5 11301.3 11331.9 11472.7 13738.5 13797.7 13798.5 13817.4 13830.9 8389.5 8633.0 8681.9 8757.3 8773.0 8820.7 8837.2 8841.5 8906.8 8910.0 3792.0 4363.9 4410.1 4483.2 4525.8 1500.7 1821.9 1830.6 1860.7 1865.8 801.7 966.3 979.9 1041.7 1061.3 19901.1 21017.6 21269.5 21282.0 21581.0 863.8 974.6 998.2 1012.7 1042.1 10984.9 11252.6 11273.9 11280.9 11287.2 542228.0 542741.0 552351.2 668463.0 678550.0 78556.0 78612.0 94160.5 115585.0 131618.0 1049.3 1071.6 1089.5 1089.7 1094.6 18545.4 18911.5 18997.4 19591.8 19870.0 52345.7 54072.0 54881.0 55582.7 55758.0 78266.8 80211.0 80442.2 81058.8 84159.6 7907.8 8192.0 8269.3 8363.9 8399.1 9608.7 13187.6 13441.2 13503.2 13650.0 11267.3 11579.1 11701.7 11783.7 11881.8 11133.4 11282.5 11384.3 11485.1 11568.4 11641.0 11738.5 11843.1 11974.9 12051.5 8146.8 8156.5 8331.5 8336.2 8445.8 8581.7 11024.4 11633.1 12043.5 12145.1 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#3] mootools.html Cycles:180 Average:6218.33 Median:2821.77 stddev:3305.78 (117.2%) stddev-sans-first:3294.90 13:28:07 INFO - PROCESS | 2328 | Values: 1361.7 1596.6 1599.3 1699.3 1794.7 8291.4 8718.9 8958.4 8961.4 8964.7 8739.6 9003.3 9025.5 9028.6 9042.5 2506.4 2535.7 2536.4 2539.5 2540.0 2203.9 2413.8 2556.9 2558.9 2564.8 2496.3 2512.8 2546.5 2551.0 2551.1 2521.4 2535.6 2548.9 2560.6 2567.6 2495.7 2533.2 2533.5 2534.6 2538.0 9022.3 9103.5 9103.6 9135.3 9144.9 5508.9 5621.5 5663.5 5683.6 5691.3 3575.7 3650.7 3720.5 3729.5 3732.7 1056.6 1078.7 1078.9 1082.6 1107.4 12324.6 12356.8 12362.0 12392.0 12414.6 4893.8 4988.5 5017.2 5050.8 5081.1 10430.5 10437.4 10491.7 10514.7 10515.2 5659.0 5665.5 5670.9 5681.2 5684.9 3856.6 4793.6 4888.5 5024.2 5127.8 3982.8 4003.8 4038.9 4062.4 4086.6 1323.6 1333.9 1334.5 1348.9 1354.3 1349.7 1366.7 1407.5 1413.7 1417.6 8353.0 8363.1 8403.5 8407.3 8459.4 512.3 515.8 520.4 522.2 526.6 6314.1 6339.3 6395.7 6409.1 6410.3 8746.3 11070.1 11077.4 11084.6 11099.5 10613.7 10764.7 10826.8 10847.6 10928.6 8529.6 8573.3 8596.9 8604.1 8698.2 8050.9 8082.6 8131.4 8134.9 8144.1 9700.6 9784.9 9881.8 10045.1 10057.4 9822.0 10150.5 10356.0 10361.9 10363.4 7647.0 7665.8 7671.2 7758.3 7760.3 8409.5 8455.1 8520.9 8523.4 8525.0 7499.2 7635.4 7712.5 7714.6 7733.7 7339.5 7432.4 7442.5 7558.4 7564.7 7990.8 8045.7 8063.6 8065.2 8081.5 7214.4 7243.3 7278.0 7312.1 7316.7 6516.3 7362.9 7390.7 7426.1 7433.4 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#4] prototype.html Cycles:180 Average:5854.49 Median:6680.92 stddev:1849.82 (27.7%) stddev-sans-first:1808.08 13:28:07 INFO - PROCESS | 2328 | Values: 338.1 341.8 345.6 347.7 352.1 5007.5 6660.9 6679.2 6685.3 6793.0 6658.2 6682.6 6704.2 6705.6 6711.7 4780.7 4876.7 4918.3 4967.1 5019.9 4999.5 5008.8 5026.3 5036.6 5070.7 4927.4 4941.7 4943.0 4949.6 4983.2 4748.2 4777.8 4889.6 4934.6 4948.2 4218.7 4221.1 4231.7 4233.2 4235.1 5649.8 5906.2 6424.8 6427.4 6435.6 5365.8 5786.2 5786.9 5797.1 5801.2 6079.8 6850.6 6852.9 7132.2 7167.3 4717.7 4739.0 4742.6 4748.2 4751.0 7500.6 7527.9 7531.0 7548.7 7584.1 4808.9 4809.7 4814.0 4820.5 4833.2 4879.7 4882.1 4883.9 4884.5 4893.3 4723.8 5747.9 5806.2 5812.9 5820.9 6835.1 7158.4 7173.0 7194.6 7205.0 1700.9 1711.9 1725.5 1728.0 1730.5 1072.9 1100.1 1113.1 1125.1 1147.6 6744.6 6858.1 6915.9 6919.1 6926.2 6171.4 7456.9 7472.0 7515.5 7532.9 6849.1 6932.5 6945.6 6945.7 6960.6 3812.9 3929.4 3964.9 3967.6 3971.7 7904.4 7934.6 7936.2 7945.4 7952.0 6485.8 7438.6 7717.4 7722.2 7750.3 7837.5 7850.9 7889.6 7892.4 7903.1 6372.5 7166.2 7220.2 7464.3 7483.2 7275.5 7314.1 7325.1 7347.4 7369.1 5703.0 6352.7 7857.1 7870.6 7891.4 4918.6 4922.3 4927.8 4936.5 4940.1 6228.8 6987.0 7419.8 7423.1 7432.6 7105.6 7162.7 7187.7 7191.5 7192.6 7154.9 7174.0 7183.6 7192.6 7202.6 7010.5 7011.8 7017.5 7031.5 7032.3 6691.0 6953.7 7149.7 7220.2 7233.1 6789.5 6934.1 6941.1 6955.3 7089.4 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - PROCESS | 2328 | [#5] yui.html Cycles:180 Average:18952.18 Median:630.17 stddev:27303.76 (4332.8%) stddev-sans-first:27345.95 13:28:07 INFO - PROCESS | 2328 | Values: 697.8 735.3 736.4 747.7 773.3 15515.0 15904.0 15905.8 15908.1 15950.4 14429.4 14618.9 14635.3 14663.9 14975.2 928.4 931.1 949.3 949.4 950.8 824.8 837.6 936.0 959.3 961.0 1016.9 1019.8 1020.7 1021.5 1025.5 866.3 984.5 1013.4 1016.0 1017.5 760.7 761.5 762.0 764.0 765.4 15545.7 15636.8 15650.8 15655.8 15657.0 12807.5 12991.6 13080.9 13108.7 13237.3 10376.3 10637.6 10786.6 10910.5 11057.9 3057.7 3632.6 3659.6 3664.2 3891.1 77806.6 77950.0 77986.2 78183.4 79263.2 9010.9 9319.8 9444.2 9532.0 9684.2 21194.4 21195.5 21577.2 21816.0 21822.5 7817.0 7854.4 7909.2 7962.0 7970.1 4206.9 4305.7 4367.2 4381.7 4441.1 3577.8 3608.1 3612.3 3616.0 3617.2 635.3 638.7 640.0 654.1 655.1 536.2 574.9 602.4 605.7 632.3 8290.1 8464.0 8553.3 8664.3 8819.9 607.5 613.4 614.7 619.1 628.1 3434.8 3760.2 3811.2 3914.0 3991.7 95534.5 96234.0 97359.0 102790.0 103072.5 85671.0 86417.1 87024.0 87131.0 87211.1 70593.9 71829.0 73589.9 74882.6 77508.2 7760.2 7883.6 8086.4 8096.9 8111.0 52658.7 52906.2 53469.2 54012.0 54330.0 64968.4 74266.7 74916.0 75294.9 75820.5 9830.4 9909.1 10055.0 10252.5 10380.3 10806.7 11084.4 11100.7 11102.5 11368.4 9343.8 10558.5 10644.2 10739.9 10854.9 10532.7 10539.0 10605.0 10942.6 11150.8 9411.7 9498.4 9559.0 9585.9 9837.8 9099.5 9255.3 9280.7 9402.0 9618.2 8968.9 9054.2 9083.1 9108.5 9119.3 13:28:07 INFO - PROCESS | 2328 | -------- Summary: end -------- 13:28:07 INFO - PROCESS | 2328 | 13:28:07 INFO - TEST-INFO | 2328: exit 0 13:28:07 INFO - TEST-OK | dromaeo_css | took 1111036ms 13:28:07 INFO - TEST-START | kraken 13:28:07 INFO - operating with platform_type : mac_ 13:28:07 INFO - Initialising browser for kraken test... 13:28:07 INFO - TEST-INFO | started process 2331 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp2DaNpU/profile http://localhost:53536/getInfo.html) 13:28:09 INFO - PROCESS | 2331 | __metrics Screen width/height:1600/1200 13:28:09 INFO - PROCESS | 2331 | colorDepth:24 13:28:09 INFO - PROCESS | 2331 | Browser inner width/height: 1024/689 13:28:09 INFO - PROCESS | 2331 | __metrics 13:28:10 INFO - PROCESS | 2331 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:28:10 INFO - PROCESS | 2331 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:28:10 INFO - TEST-INFO | 2331: exit 0 13:28:10 INFO - Browser initialized. 13:28:10 INFO - Running cycle 1/1 for kraken test... 13:28:10 INFO - TEST-INFO | started process 2334 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp2DaNpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:22 INFO - PROCESS | 2334 | RSS: Main: 157368320 13:28:22 INFO - PROCESS | 2334 | 13:28:24 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53536/tests/kraken/driver.html?testName=audio-beat-detection) 13:28:25 INFO - PROCESS | 2334 | RSS: Main: 212930560 13:28:25 INFO - PROCESS | 2334 | 13:28:28 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53536/tests/kraken/driver.html?testName=audio-dft) 13:28:28 INFO - PROCESS | 2334 | RSS: Main: 223350784 13:28:28 INFO - PROCESS | 2334 | 13:28:32 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53536/tests/kraken/driver.html?testName=audio-fft) 13:28:32 INFO - PROCESS | 2334 | RSS: Main: 214568960 13:28:32 INFO - PROCESS | 2334 | 13:28:34 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53536/tests/kraken/driver.html?testName=audio-oscillator) 13:28:35 INFO - PROCESS | 2334 | RSS: Main: 215523328 13:28:35 INFO - PROCESS | 2334 | 13:28:37 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:38 INFO - PROCESS | 2334 | RSS: Main: 215891968 13:28:38 INFO - PROCESS | 2334 | 13:28:40 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53536/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:41 INFO - PROCESS | 2334 | RSS: Main: 215728128 13:28:41 INFO - PROCESS | 2334 | 13:28:44 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53536/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:44 INFO - PROCESS | 2334 | RSS: Main: 215924736 13:28:44 INFO - PROCESS | 2334 | 13:28:47 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53536/tests/kraken/driver.html?testName=json-parse-financial) 13:28:48 INFO - PROCESS | 2334 | RSS: Main: 216215552 13:28:48 INFO - PROCESS | 2334 | 13:28:49 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:50 INFO - PROCESS | 2334 | RSS: Main: 248037376 13:28:50 INFO - PROCESS | 2334 | 13:28:52 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:52 INFO - PROCESS | 2334 | RSS: Main: 246996992 13:28:52 INFO - PROCESS | 2334 | 13:28:54 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:55 INFO - PROCESS | 2334 | RSS: Main: 252997632 13:28:55 INFO - PROCESS | 2334 | 13:28:58 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:58 INFO - PROCESS | 2334 | RSS: Main: 254496768 13:28:58 INFO - PROCESS | 2334 | 13:29:01 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:01 INFO - PROCESS | 2334 | RSS: Main: 254046208 13:29:01 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | Cycle 1(1): loaded http://localhost:53536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53536/tests/kraken/driver.html?testName=ai-astar) 13:29:03 INFO - PROCESS | 2334 | RSS: Main: 317104128 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | __start_tp_report 13:29:03 INFO - PROCESS | 2334 | _x_x_mozilla_page_load 13:29:03 INFO - PROCESS | 2334 | _x_x_mozilla_page_load_details 13:29:03 INFO - PROCESS | 2334 | |i|pagename|runs| 13:29:03 INFO - PROCESS | 2334 | |0;ai-astar;111;111;110;110;112;111;122;110;110;111 13:29:03 INFO - PROCESS | 2334 | |1;audio-beat-detection;155;119;156;147;116;140;118;147;151;116 13:29:03 INFO - PROCESS | 2334 | |2;audio-dft;183;184;188;259;235;186;184;186;210;261 13:29:03 INFO - PROCESS | 2334 | |3;audio-fft;72;79;73;113;78;82;85;66;123;55 13:29:03 INFO - PROCESS | 2334 | |4;audio-oscillator;89;93;129;81;104;122;159;76;78;117 13:29:03 INFO - PROCESS | 2334 | |5;imaging-gaussian-blur;88;85;94;85;87;85;88;86;88;86 13:29:03 INFO - PROCESS | 2334 | |6;imaging-darkroom;94;94;94;94;101;90;149;148;93;93 13:29:03 INFO - PROCESS | 2334 | |7;imaging-desaturate;85;87;85;86;86;84;85;87;85;83 13:29:03 INFO - PROCESS | 2334 | |8;json-parse-financial;53;54;60;79;87;87;87;57;53;54 13:29:03 INFO - PROCESS | 2334 | |9;json-stringify-tinderbox;63;67;64;78;74;71;68;67;72;68 13:29:03 INFO - PROCESS | 2334 | |10;stanford-crypto-aes;80;81;77;79;81;80;80;79;87;84 13:29:03 INFO - PROCESS | 2334 | |11;stanford-crypto-ccm;117;121;132;117;118;118;116;117;117;117 13:29:03 INFO - PROCESS | 2334 | |12;stanford-crypto-pbkdf2;133;122;145;169;170;114;155;171;155;130 13:29:03 INFO - PROCESS | 2334 | |13;stanford-crypto-sha256-iterative;66;65;65;66;68;65;65;66;65;65 13:29:03 INFO - PROCESS | 2334 | __end_tp_report 13:29:03 INFO - PROCESS | 2334 | __start_cc_report 13:29:03 INFO - PROCESS | 2334 | _x_x_mozilla_cycle_collect,1195 13:29:03 INFO - PROCESS | 2334 | __end_cc_report 13:29:03 INFO - PROCESS | 2334 | __startTimestamp1464035343743__endTimestamp 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | ------- Summary: start ------- 13:29:03 INFO - PROCESS | 2334 | Number of tests: 14 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:3.86 13:29:03 INFO - PROCESS | 2334 | Values: 111.0 111.0 110.0 110.0 112.0 111.0 122.0 110.0 110.0 111.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:147.00 stddev:17.17 (11.7%) stddev-sans-first:16.86 13:29:03 INFO - PROCESS | 2334 | Values: 155.0 119.0 156.0 147.0 116.0 140.0 118.0 147.0 151.0 116.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#2] audio-dft Cycles:10 Average:207.60 Median:199.00 stddev:32.12 (16.1%) stddev-sans-first:32.81 13:29:03 INFO - PROCESS | 2334 | Values: 183.0 184.0 188.0 259.0 235.0 186.0 184.0 186.0 210.0 261.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:20.65 (27.4%) stddev-sans-first:21.55 13:29:03 INFO - PROCESS | 2334 | Values: 72.0 79.0 73.0 113.0 78.0 82.0 85.0 66.0 123.0 55.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:77.00 stddev:26.82 (34.8%) stddev-sans-first:27.83 13:29:03 INFO - PROCESS | 2334 | Values: 89.0 93.0 129.0 81.0 104.0 122.0 159.0 76.0 78.0 117.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.50 stddev:2.70 (3.1%) stddev-sans-first:2.85 13:29:03 INFO - PROCESS | 2334 | Values: 88.0 85.0 94.0 85.0 87.0 85.0 88.0 86.0 88.0 86.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:93.50 stddev:23.09 (24.7%) stddev-sans-first:24.14 13:29:03 INFO - PROCESS | 2334 | Values: 94.0 94.0 94.0 94.0 101.0 90.0 149.0 148.0 93.0 93.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.25 (1.5%) stddev-sans-first:1.32 13:29:03 INFO - PROCESS | 2334 | Values: 85.0 87.0 85.0 86.0 86.0 84.0 85.0 87.0 85.0 83.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:69.50 stddev:15.72 (22.6%) stddev-sans-first:15.82 13:29:03 INFO - PROCESS | 2334 | Values: 53.0 54.0 60.0 79.0 87.0 87.0 87.0 57.0 53.0 54.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.59 (6.6%) stddev-sans-first:4.28 13:29:03 INFO - PROCESS | 2334 | Values: 63.0 67.0 64.0 78.0 74.0 71.0 68.0 67.0 72.0 68.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:2.82 (3.5%) stddev-sans-first:2.98 13:29:03 INFO - PROCESS | 2334 | Values: 80.0 81.0 77.0 79.0 81.0 80.0 80.0 79.0 87.0 84.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:117.50 stddev:4.76 (4.1%) stddev-sans-first:4.99 13:29:03 INFO - PROCESS | 2334 | Values: 117.0 121.0 132.0 117.0 118.0 118.0 116.0 117.0 117.0 117.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:155.00 stddev:20.86 (13.5%) stddev-sans-first:21.55 13:29:03 INFO - PROCESS | 2334 | Values: 133.0 122.0 145.0 169.0 170.0 114.0 155.0 171.0 155.0 130.0 13:29:03 INFO - PROCESS | 2334 | 13:29:03 INFO - PROCESS | 2334 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:1.01 13:29:03 INFO - PROCESS | 2334 | Values: 66.0 65.0 65.0 66.0 68.0 65.0 65.0 66.0 65.0 65.0 13:29:03 INFO - PROCESS | 2334 | -------- Summary: end -------- 13:29:03 INFO - PROCESS | 2334 | 13:29:04 INFO - TEST-INFO | 2334: exit 0 13:29:04 INFO - TEST-OK | kraken | took 56629ms 13:29:04 INFO - SUITE-END | took 1167s 13:29:04 INFO - Completed test suite (00:19:28) 13:29:04 INFO - javascript benchmark 13:29:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3515.156362473006, 3578.6779189872905, 3583.0684022154232, 3600.5139306193664, 3639.636036396361, 4836.637252206086, 5882.117682347639, 5883.911741323878, 5902.291724992996, 5987.191729116574, 5916.349201587822, 5951.285845698522, 5957.225560677106, 5968.79109231177, 5971.164037034819, 5218.608604354669, 5266.683998960075, 5274.393444753864, 5303.310569625944, 5333.786648534054, 5373.408925018245, 5381.031414345416, 5391.245225668409, 5399.055165346068, 5406.270153529263, 5308.203769434577, 5354.437784032679, 5370.812021579245, 5374.516293533581, 5380.381256155553, 5366.9463305366835, 5376.1398176291805, 5384.434634363374, 5394.083005889008, 5419.403865574784, 5151.201563757623, 5314.5748340132695, 5327.094393953037, 5327.174287985368, 5328.040952628526, 4566.972431202986, 5748.770049198027, 5810.709464526799, 5814.563907706896, 5822.951868663639, 6219.906701399483, 6386.265579458375, 6391.936080639181, 6399.072134540465, 6402.007688808242, 6271.937280627181, 6282.277538083134, 6306.1486699295465, 6341.1756471658855, 6342.778002769927, 5941.10883367494, 5982.820515384546, 5986.102084687332, 5989.760409583655, 5993.280806303272, 6247.187865577446, 6279.309275979638, 6378.617282962944, 6384.265809431882, 6400.519961002943, 6300.842478938063, 6335.841603959938, 6353.841153971188, 6361.777337793247, 6371.33101024395, 6353.618782873043, 6353.936460635427, 6358.968205159037, 6380.457661098766, 6382.393672601095, 6230.7507699691505, 6266.749330026839, 6312.652804095819, 6381.074744162071, 6404.199475065617, 6334.873302533923, 6384.553081284358, 6390.488760899117, 6393.424591786761, 6414.935850641527, 4972.627052971042, 4976.0, 4976.178930476503, 4977.527134922177, 5012.774425150877, 3815.1797363566966, 4373.103513779667, 4395.912081758347, 4490.079533695584, 4530.932036019462, 6102.511799056065, 6102.664353460602, 6108.938910610926, 6111.650364618297, 6143.754249829957, 5536.363318218457, 6295.937040629535, 6314.147590075281, 6324.873502529924, 6330.4619107375465, 5844.444777746107, 6029.487493563096, 6103.804638292137, 6103.84740381494, 6111.54163437744, 5497.532709719639, 5515.283013208337, 5521.171824226318, 5521.4478552145265, 5523.640963337451, 6521.380468855451, 6529.608223506605, 6539.5422320438065, 6561.212654481493, 6567.113439685581, 6219.782307619212, 6254.655993920378, 6299.811005669837, 6309.779157729457, 6313.715882785194, 6492.577982431127, 6502.0, 6503.02454631809, 6511.186101737283, 6517.771877984437, 6323.36766323364, 6351.714172862325, 6352.714127864349, 6362.968185159045, 6375.458086062551, 6172.888880001643, 6206.0, 6246.656433895998, 6274.341194174728, 6290.8427289316305, 6276.466500347522, 6277.058441233851, 6295.622262664255, 6301.6219026858535, 6308.558400911892, 6127.464420129145, 6278.183836101278, 6288.245410550763, 6292.811215663354, 6302.810915672537, 6119.082137679384, 6139.338817383189, 6163.044728067157, 6166.4758495526585, 6180.165677633642, 6211.751529938751, 6297.433231009048, 6312.652804095819, 6318.526110541636, 6331.683415829282, 6022.668753218615, 6072.574919755575, 6093.9390606093375, 6120.44915957566, 6200.472959798287], "unit": "score", "name": "dojo.html", "value": 5837.9890392509}, {"lowerIsBetter": false, "replicates": [449.5235050846101, 560.6243816642849, 563.276190095727, 606.6178307666172, 652.7225928980183, 27310.590341144874, 39236.80381598088, 39247.0, 39361.60638393615, 39402.99999999996, 41420.17159656805, 42011.78994105025, 42030.0, 42041.0, 42142.7892860536, 9786.85319720203, 10038.34750741203, 10055.597776088947, 10063.949680251626, 10064.748381290454, 9793.657221997231, 9921.255905807056, 9924.702258932244, 9951.800963980717, 10059.597616095347, 10009.949950250275, 10070.194384449263, 10084.899151008469, 10087.394756314645, 10092.444915529642, 9979.550920208572, 10048.799024019552, 10065.647702330383, 10103.343282686601, 10111.241656875764, 9921.10710036093, 10058.89941100587, 10066.0, 10067.194624430029, 10069.0, 40839.38740918859, 41175.38236926449, 41182.38226426606, 41234.96912577179, 41313.0, 3180.761442891769, 3249.366373557157, 3343.9498407523906, 3398.6261511233743, 3714.4428335749585, 26269.868650656816, 28633.141005769652, 29397.265068373246, 29459.852700736574, 29616.0, 2741.876615552305, 2791.7068707785593, 2819.210621026116, 2844.5875348074414, 2891.334992951612, 497665.0, 497723.0, 498648.0, 498843.0, 499376.0, 46163.30755038677, 46720.766396167804, 60280.0, 60808.08787868186, 60871.69564152151, 46868.06263874772, 47048.764756176, 47575.28637070447, 47679.0, 47694.5230547697, 16463.176841157896, 16660.58348541296, 16666.6666666666, 16683.749743753855, 16703.582410439838, 13091.345432728325, 13138.211707297593, 13165.736685266242, 13169.802452963213, 13173.946084313231, 14886.404543818126, 14919.179445130405, 14940.178290193926, 14954.626134346729, 15015.849841501664, 6226.439620434183, 6398.488120950313, 6537.346265373425, 6554.541182117206, 6570.375814297634, 949.3070058856935, 988.6045581767207, 1031.7214352124884, 1131.2251107991053, 1136.0457215938486, 30130.37373136696, 30181.849090754407, 30315.393692126036, 30401.956349936077, 30680.693193067782, 1080.5407701726735, 1126.0934947367284, 1136.4261048170786, 1189.8869607387458, 1195.235049568277, 14102.435902563988, 14119.364628591738, 14388.06477578954, 14483.78274325886, 14583.05210161336, 550683.0, 555130.4486955078, 555736.0, 556931.0, 557053.0, 56915.430845691844, 57028.144577831365, 57117.42882571204, 57181.0, 57189.0, 1436.1957303909635, 1487.256371814093, 1506.3070987345943, 1515.5377609828888, 1621.4162901355503, 28694.713052869203, 28743.712562874105, 29066.982655606953, 29279.560806588343, 29312.41375172527, 44899.77550112228, 45157.77421112874, 45619.0, 45626.315605265285, 45710.54289457063, 414239.0, 417900.0, 418459.0, 419763.0, 420710.0, 29155.708442916148, 32413.18967025843, 32908.0, 33042.008739737845, 33383.66616333806, 39433.80283098566, 39610.009749756486, 40808.38787418132, 41158.0, 41294.1741165181, 33430.83284583561, 33492.832535837166, 34680.17833810443, 35318.29363412769, 36191.91424257276, 31057.0682879514, 32932.01203963789, 35169.82415087908, 35438.11404714903, 35745.82127089452, 34580.789672361345, 34890.58787270158, 35120.47319290264, 35569.28861422809, 35710.4643430354, 29673.85163074171, 30531.93454803286, 31104.65404563815, 31273.0, 33241.33517329591, 25036.74963250344, 25208.78363875114, 25236.747632524173, 25691.972321106947, 25873.22380328593], "unit": "score", "name": "ext.html", "value": 19211.242258147082}, {"lowerIsBetter": false, "replicates": [332.54441415261095, 381.30411998103466, 382.98851034468964, 383.5972229159382, 393.3490073927647, 20421.795782042194, 20686.379408617748, 20981.055852486636, 21750.0, 21750.782492175073, 20981.37055888322, 21079.367618971417, 21301.786982130212, 21329.93350332481, 21445.463863403424, 5644.717764111788, 5907.852303692399, 5951.0, 5987.341392446828, 5989.341172471025, 3698.6301369863068, 4612.100640375128, 5745.655260684352, 6243.282022567418, 6539.6730163491875, 6473.255575608795, 6477.74089036438, 6486.643234622094, 6490.188726409199, 6490.545661803676, 6173.783917562886, 6491.285958544557, 6503.28463868974, 6503.349665033506, 6521.0, 5013.774380152902, 5424.294841670597, 5623.015972204888, 5644.491995720364, 5651.576131790132, 13109.672258193526, 13595.252261125634, 13607.183568985893, 13620.727585448334, 13630.0, 2172.5144011371412, 2185.3007037747925, 2269.5574362999223, 2325.4186453386656, 2639.934001649955, 9841.360311579725, 10063.14463270623, 10104.797904041952, 10424.322419042737, 12166.0, 1760.9647807043787, 1852.3239017758556, 1865.6362009408172, 1875.2405275863298, 1939.0692467615625, 95856.0, 98436.50781746117, 101098.0, 101411.49294253555, 101470.0, 9137.223336016514, 11134.49894754738, 11301.26541774782, 11331.886681133083, 11472.713182170513, 13738.450461981409, 13797.655058623615, 13798.517051903134, 13817.447302107803, 13830.86169138316, 8389.454685445426, 8633.007204171476, 8681.869771953427, 8757.343199259954, 8773.0, 8820.691275805317, 8837.204651581389, 8841.513716745641, 8906.821863562693, 8910.0, 3791.962080379216, 4363.890902727458, 4410.1400226956075, 4483.170613436525, 4525.818967241339, 1500.664408676279, 1821.902370549039, 1830.5789668376349, 1860.6929856573784, 1865.8040905704977, 801.723405425139, 966.3139171188535, 979.9363041402286, 1041.739565108723, 1061.2571200159764, 19901.104450299772, 21017.579648406947, 21269.46826329354, 21282.0, 21581.0, 863.7797361672733, 974.5565767575736, 998.2313618513704, 1012.7366884610054, 1042.1089968077185, 10984.945075274572, 11252.606158784403, 11273.943630281796, 11280.943595281971, 11287.153463490271, 542228.0, 542741.0, 552351.2382438062, 668463.0, 678550.0, 78556.0, 78612.0, 94160.52919735358, 115585.0, 131618.0, 1049.2655141401049, 1071.5713714514102, 1089.4824958144818, 1089.727568107973, 1094.6168840905777, 18545.44363669092, 18911.527211819815, 18997.43007709771, 19591.824490530613, 19870.006499675248, 52345.7382713084, 54072.0, 54881.042248872895, 55582.72208638931, 55758.0, 78266.82599760895, 80211.0, 80442.19557804581, 81058.78411823709, 84159.5792021036, 7907.84184316299, 8191.959040204761, 8269.255766981001, 8363.874541881754, 8399.118092600189, 9608.711738647851, 13187.60437186886, 13441.193528388329, 13503.189808611514, 13650.044496885122, 11267.323960562393, 11579.073674105883, 11701.707457313636, 11783.705407364885, 11881.821772673244, 11133.387663678575, 11282.548698051985, 11384.316940983568, 11485.138614603771, 11568.421578921188, 11641.0, 11738.530458781554, 11843.052555795688, 11974.940125299318, 12051.51793928233, 8146.796330091795, 8156.510609363457, 8331.541765202972, 8336.249737523653, 8445.831083378422, 8581.699640512552, 11024.393658348868, 11633.127515436545, 12043.458044388199, 12145.14983951115], "unit": "score", "name": "jquery.html", "value": 9427.814079345266}, {"lowerIsBetter": false, "replicates": [1361.6731984323765, 1596.5689263898744, 1599.2963096237654, 1699.3287651377698, 1794.676958147533, 8291.378146639003, 8718.912810871889, 8958.41770284931, 8961.417507861985, 8964.731058068252, 8739.606717697703, 9003.279737620975, 9025.548722563863, 9028.638854445831, 9042.502662353569, 2506.385935445818, 2535.746425357468, 2536.378587246127, 2539.4540173862615, 2540.0, 2203.867767933921, 2413.81896357773, 2556.8593727344987, 2558.872056397182, 2564.76917077463, 2496.251124662603, 2512.849229046263, 2546.4907018596264, 2551.0, 2551.081610620175, 2521.420073383132, 2535.632333311669, 2548.885300161488, 2560.6287088372083, 2567.56351420259, 2495.6755621769053, 2533.2020413569667, 2533.5439620868237, 2534.6451496790464, 2537.9974909910484, 9022.278217742565, 9103.544822758835, 9103.63585456581, 9135.314851386107, 9144.908550914472, 5508.91736623947, 5621.522170615503, 5663.546916246691, 5683.630564013326, 5691.26013618227, 3575.6960658344074, 3650.689691376236, 3720.4977328060636, 3729.459228411892, 3732.701383889282, 1056.6037735849056, 1078.730317420645, 1078.8705355357329, 1082.6048492300333, 1107.396468924438, 12324.630261092181, 12356.8146477802, 12362.01103911685, 12392.0, 12414.565490207799, 4893.779779909913, 4988.476209997971, 5017.197248440232, 5050.84847454577, 5081.0854046272025, 10430.530626121843, 10437.373757574418, 10491.737706557396, 10514.737131571772, 10515.158787296998, 5658.971705141448, 5665.49010589049, 5670.886582268414, 5681.176229446707, 5684.9431505684415, 3856.614338566177, 4793.592544633745, 4888.462269150391, 5024.221245706921, 5127.769250383742, 3982.8406863725127, 4003.8398464061693, 4038.8990275243355, 4062.370332598452, 4086.6117718816663, 1323.6293837725452, 1333.8999575031912, 1334.4728832111261, 1348.9460421583224, 1354.2551596621818, 1349.6625843539116, 1366.6993261482457, 1407.4862675123711, 1413.7172565486737, 1417.5818133650598, 8352.997640283205, 8363.080061193265, 8403.453775504573, 8407.327413806881, 8459.407841451039, 512.3237326728682, 515.7653267763159, 520.4301290087349, 522.1775703267369, 526.6129394894749, 6314.0844577536, 6339.270983836917, 6395.744170233139, 6409.102725618417, 6410.294867564658, 8746.34402419821, 11070.059044981106, 11077.446127693744, 11084.612038578773, 11099.500522476508, 10613.681589552172, 10764.677059688222, 10826.783464330827, 10847.566097356175, 10928.562857485771, 8529.616167272363, 8573.314134869195, 8596.8710469343, 8604.0965698602, 8698.21716045559, 8050.87923681157, 8082.555459449787, 8131.390145738975, 8134.918650813416, 8144.063432705315, 9700.563474643517, 9784.85322720174, 9881.802363952824, 10045.146162575971, 10057.446840423847, 9821.950890245504, 10150.492475376053, 10356.0, 10361.896381036093, 10363.378197308186, 7647.005889234364, 7665.770026899202, 7671.194524574839, 7758.340541054074, 7760.3403710685225, 8409.495430274203, 8455.112213217524, 8520.914790852012, 8523.445976011539, 8525.019622743464, 7499.1750907399055, 7635.350995165251, 7712.460127791001, 7714.575698336421, 7733.690652374067, 7339.522931009467, 7432.405407567274, 7442.479026468095, 7558.357539609195, 7564.659590318339, 7990.760277191694, 8045.718399855977, 8063.596820159086, 8065.1934806518875, 8081.515109093473, 7214.386777124003, 7243.348098671145, 7278.0, 7312.085989251344, 7316.707331706885, 6516.250631177475, 7362.852742945218, 7390.704371825067, 7426.108866936002, 7433.405327573889], "unit": "score", "name": "mootools.html", "value": 4976.145562429219}, {"lowerIsBetter": false, "replicates": [338.0517647997367, 341.81371152721766, 345.6439866937056, 347.69576620457093, 352.0828242428472, 5007.52428519291, 6660.9000864987, 6679.2318883328435, 6685.298043705414, 6793.01107512694, 6658.167729033871, 6682.59904405736, 6704.22901366343, 6705.564138331018, 6711.697973591188, 4780.737059461728, 4876.683015603974, 4918.262260660912, 4967.056259310738, 5019.949800501994, 4999.450060493343, 5008.774605142778, 5026.29631851541, 5036.564579094958, 5070.695758254498, 4927.359443272369, 4941.728204948727, 4943.0, 4949.628777841658, 4983.177775667011, 4748.192807222763, 4777.761111944389, 4889.608831293488, 4934.629902757308, 4948.208286674115, 4218.6835987300765, 4221.07136429988, 4231.70378073535, 4233.1956928183545, 4235.0682849773, 5649.802256921029, 5906.202662640531, 6424.807255782334, 6427.42153206209, 6435.581687190364, 5365.758540865631, 5786.247787787603, 5786.855328616776, 5797.130430435468, 5801.187833703285, 6079.787207447718, 6850.554713943628, 6852.897206541906, 7132.179799323092, 7167.319104685047, 4717.669763116583, 4739.0, 4742.5731684148595, 4748.19280722278, 4751.026039661861, 7500.5874676892745, 7527.9247207528315, 7531.0, 7548.735794247175, 7584.089909210875, 4808.903821923542, 4809.711417314972, 4814.013127308894, 4820.469748327681, 4833.154198015333, 4879.658423910363, 4882.12121818069, 4883.926741098886, 4884.48712885142, 4893.290472881412, 4723.834665786681, 5747.942520574741, 5806.158107074535, 5812.912806307909, 5820.854478638068, 6835.1114355134505, 7158.355747982707, 7173.0, 7194.568325900358, 7204.9639751800905, 1700.8554272886943, 1711.8701656906383, 1725.5254804928745, 1728.032301910934, 1730.480855743272, 1072.8873468285717, 1100.1308965916996, 1113.0761467981556, 1125.1336470917347, 1147.6270212181075, 6744.595324280559, 6858.142732158481, 6915.861682766316, 6919.135108111486, 6926.238113807477, 6171.382861713792, 7456.85086298271, 7472.0, 7515.549067055885, 7532.887006694904, 6849.109615750021, 6932.480063995221, 6945.617991010543, 6945.7221711132, 6960.582365058112, 3812.885613431546, 3929.371300591949, 3964.861229856941, 3967.6429121379215, 3971.7021223407783, 7904.4071694623135, 7934.603269836485, 7936.206379362017, 7945.364370850318, 7952.0, 6485.77299794505, 7438.5536867788105, 7717.382609391235, 7722.189170137167, 7750.302472777477, 7837.49056311338, 7850.919506330827, 7889.605519723991, 7892.395509481972, 7903.091144518224, 6372.490200783834, 7166.211716711054, 7220.241874603091, 7464.290892365217, 7483.214262502359, 7275.490715649854, 7314.08573928259, 7325.120985481776, 7347.375473084634, 7369.115706115301, 5703.001974654336, 6352.745890164341, 7857.135715071452, 7870.645820937957, 7891.408144389308, 4918.606511479002, 4922.261660750916, 4927.778249978831, 4936.531029552187, 4940.086084074458, 6228.813135605757, 6986.973777604438, 7419.811155708971, 7423.146338171179, 7432.591207483641, 7105.609191494517, 7162.677679504331, 7187.676554554953, 7191.460640452092, 7192.640367981476, 7154.856902861809, 7173.964130179315, 7183.604901730455, 7192.568445893263, 7202.603856787927, 7010.474214433836, 7011.824704382431, 7017.543859649107, 7031.472639552157, 7032.331928466788, 6691.0, 6953.6523173842115, 7149.7497587584185, 7220.205777364381, 7233.059702238886, 6789.490788190807, 6934.06390137325, 6941.132358455193, 6955.269696681978, 7089.432845372255], "unit": "score", "name": "prototype.html", "value": 5246.301874980767}, {"lowerIsBetter": false, "replicates": [697.7906628011597, 735.2610626320554, 736.3924762071289, 747.7420289999948, 773.3156156801231, 15515.0, 15903.966242194248, 15905.761413578806, 15908.125053122074, 15950.441734539294, 14429.350679219435, 14618.926905365484, 14635.341409636565, 14663.900207484454, 14975.176365299903, 928.350154891577, 931.1200915135166, 949.3402085550545, 949.3971328206604, 950.8193443245796, 824.8185399212164, 837.5853952293593, 936.0499093420184, 959.3045042344314, 961.0, 1016.9338992965434, 1019.7705516258857, 1020.6937918624383, 1021.4688362051729, 1025.4923812712718, 866.2939704141105, 984.4979060679034, 1013.4324778124274, 1016.0398423489805, 1017.4607458047246, 760.741347941697, 761.478387304698, 762.0208032677982, 763.9809004774869, 765.414457939671, 15545.689086218212, 15636.843631563652, 15650.765238521431, 15655.765163522556, 15656.982296150714, 12807.487700491969, 12991.610251692464, 13080.86919130806, 13108.737825243441, 13237.271950042743, 10376.325538840027, 10637.57449702011, 10786.622468213653, 10910.454477276104, 11057.944710276397, 3057.7095175958248, 3632.5640923089136, 3659.6340365963456, 3664.157243833933, 3891.0855948851995, 77806.61096694537, 77950.0, 77986.22013779846, 78183.43633127306, 79263.20736792615, 9010.86483702745, 9319.767005824908, 9444.244460443286, 9531.99914009033, 9684.225261979025, 21194.364169074954, 21195.47011324729, 21577.24479643205, 21816.0, 21822.454438638844, 7817.0, 7854.3716502679645, 7909.169537198626, 7962.0, 7970.123286438487, 4206.927233555424, 4305.7201281917205, 4367.235733746582, 4381.6932814703305, 4441.067375851043, 3577.8032208228797, 3608.1340478285024, 3612.3497770401054, 3615.9638403616154, 3617.168051348152, 635.2726128582839, 638.6902352359102, 639.9840003999844, 654.1365397675119, 655.0796131435341, 536.1903525676179, 574.9022666146765, 602.3735315272155, 605.7370382752011, 632.2697284636253, 8290.088155233148, 8463.957680211559, 8553.272971797342, 8664.263537599374, 8819.9416070072, 607.5473772039859, 613.408061220924, 614.7295190116334, 619.0899377914459, 628.0641843652925, 3434.8321570665594, 3760.2291530236234, 3811.2377524495214, 3914.0, 3991.6607088397814, 95534.5223273893, 96234.0, 97359.0, 102790.0, 103072.48463757633, 85671.0, 86417.13582864091, 87024.0, 87131.0, 87211.12788872157, 70593.9410908847, 71829.0, 73589.89615155777, 74882.6255868728, 77508.22491775123, 7760.223977602194, 7883.64523596451, 8086.43394962347, 8096.947396838374, 8111.0, 52658.736706316224, 52906.206406903155, 53469.19796203138, 54012.0, 54330.0, 64968.35031649812, 74266.68733157743, 74916.0, 75294.87057694249, 75820.48359032678, 9830.361026533252, 9909.108180263811, 10055.0, 10252.487375631039, 10380.27338086357, 10806.729831754268, 11084.445777711244, 11100.722481938015, 11102.500387482422, 11368.431578420881, 9343.813123737624, 10558.524866380878, 10644.20168487382, 10739.942171835175, 10854.945725271638, 10532.684019479428, 10538.998795114452, 10605.0, 10942.617008404986, 11150.832737508781, 9411.670591529537, 9498.430094194371, 9559.044095590385, 9585.90414095878, 9837.803243935225, 9099.454032758056, 9255.305852061258, 9280.675176369065, 9401.952990235006, 9618.182454491447, 8968.86546701787, 9054.230390416888, 9083.137101975302, 9108.544572771467, 9119.316051296311], "unit": "score", "name": "yui.html", "value": 6998.412044811323}], "name": "dromaeo_css", "value": 7603.286245908233}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 112.0, 111.0, 122.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 156.0, 147.0, 116.0, 140.0, 118.0, 147.0, 151.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 136.5}, {"lowerIsBetter": true, "replicates": [183.0, 184.0, 188.0, 259.0, 235.0, 186.0, 184.0, 186.0, 210.0, 261.0], "unit": "score", "name": "audio-dft", "value": 207.6}, {"lowerIsBetter": true, "replicates": [72.0, 79.0, 73.0, 113.0, 78.0, 82.0, 85.0, 66.0, 123.0, 55.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 129.0, 81.0, 104.0, 122.0, 159.0, 76.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 94.0, 85.0, 87.0, 85.0, 88.0, 86.0, 88.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 101.0, 90.0, 149.0, 148.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 105.0}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 86.0, 86.0, 84.0, 85.0, 87.0, 85.0, 83.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 60.0, 79.0, 87.0, 87.0, 87.0, 57.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 67.1}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 64.0, 78.0, 74.0, 71.0, 68.0, 67.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 77.0, 79.0, 81.0, 80.0, 80.0, 79.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.8}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 132.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [133.0, 122.0, 145.0, 169.0, 170.0, 114.0, 155.0, 171.0, 155.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 66.0, 68.0, 65.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1468.8999999999999}]} 13:29:05 INFO - Return code: 0 13:29:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:29:05 INFO - # TBPL SUCCESS # 13:29:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:29:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:29:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:29:05 INFO - 2016-05-23 13:29:05.068 screenresolution[2338:23188] starting screenresolution argv=screenresolution get 13:29:05 INFO - 2016-05-23 13:29:05.070 screenresolution[2338:23188] Display 0: 1600x1200x32@60 13:29:05 INFO - 2016-05-23 13:29:05.076 screenresolution[2339:23191] starting screenresolution argv=screenresolution list 13:29:05 INFO - Available Modes on Display 0 13:29:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:29:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:29:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:29:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:29:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:29:05 INFO - Intel Iris: 13:29:05 INFO - Chipset Model: Intel Iris 13:29:05 INFO - Type: GPU 13:29:05 INFO - Bus: Built-In 13:29:05 INFO - VRAM (Dynamic, Max): 1536 MB 13:29:05 INFO - Vendor: Intel (0x8086) 13:29:05 INFO - Device ID: 0x0a2e 13:29:05 INFO - Revision ID: 0x0009 13:29:05 INFO - Displays: 13:29:05 INFO - Display: 13:29:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:29:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:29:05 INFO - Display Serial Number: 1600x1200 60 13:29:05 INFO - Main Display: Yes 13:29:05 INFO - Mirror: Off 13:29:05 INFO - Online: Yes 13:29:05 INFO - Rotation: Supported 13:29:05 INFO - Return code: 0 13:29:05 INFO - Running post-action listener: _resource_record_post_action 13:29:05 INFO - Running post-run listener: _resource_record_post_run 13:29:06 INFO - Total resource usage - Wall time: 1193s; CPU: 52.0%; Read bytes: 798720; Write bytes: 505698816; Read time: 9; Write time: 1557 13:29:06 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 202592768; Write bytes: 196259840; Read time: 19277; Write time: 432 13:29:06 INFO - run-tests - Wall time: 1170s; CPU: 52.0%; Read bytes: 798720; Write bytes: 298646016; Read time: 9; Write time: 1092 13:29:06 INFO - Running post-run listener: _upload_blobber_files 13:29:06 INFO - Blob upload gear active. 13:29:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:06 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:29:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:07 INFO - (blobuploader) - INFO - Done attempting. 13:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:09 INFO - (blobuploader) - INFO - Done attempting. 13:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 13:29:09 INFO - Return code: 0 13:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea105e1f2b7c231b2cb1bd7d54ef5f9f87ca30c6ef9add59a6184ae5b3351c5c974b93e45d19bd98fd5a560527022b8290dedc3e7c2620593c6f63eaa64d16f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef9eb81ee961b65405b223caf7a5e1539edf45c1c84d08930c6b042eaa62e5f798686683329f75da076e276ca5a52f7cddc3c397b2633721e03088e53d9015c1"} 13:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:29:09 INFO - Contents: 13:29:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea105e1f2b7c231b2cb1bd7d54ef5f9f87ca30c6ef9add59a6184ae5b3351c5c974b93e45d19bd98fd5a560527022b8290dedc3e7c2620593c6f63eaa64d16f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef9eb81ee961b65405b223caf7a5e1539edf45c1c84d08930c6b042eaa62e5f798686683329f75da076e276ca5a52f7cddc3c397b2633721e03088e53d9015c1"} 13:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 13:29:09 INFO - Copying logs to upload dir... 13:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 13:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.489837 ========= master_lag: 1.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-23 13:29:11.429801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 13:29:11.433160) ========= 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.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea105e1f2b7c231b2cb1bd7d54ef5f9f87ca30c6ef9add59a6184ae5b3351c5c974b93e45d19bd98fd5a560527022b8290dedc3e7c2620593c6f63eaa64d16f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef9eb81ee961b65405b223caf7a5e1539edf45c1c84d08930c6b042eaa62e5f798686683329f75da076e276ca5a52f7cddc3c397b2633721e03088e53d9015c1"} build_url:https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011121 build_url: 'https://queue.taskcluster.net/v1/task/Yg_Lc72wRmya-wEx0MLs5A/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea105e1f2b7c231b2cb1bd7d54ef5f9f87ca30c6ef9add59a6184ae5b3351c5c974b93e45d19bd98fd5a560527022b8290dedc3e7c2620593c6f63eaa64d16f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef9eb81ee961b65405b223caf7a5e1539edf45c1c84d08930c6b042eaa62e5f798686683329f75da076e276ca5a52f7cddc3c397b2633721e03088e53d9015c1"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 13:29:11.576082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:29:11.576435) ========= 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.FylbEF6DZj/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.oQknvpPgrJ/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005209 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 13:29:11.777892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 13:29:11.778196) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 13:29:11.778547) ========= ========= Total master_lag: 5.44 =========