builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0019 starttime: 1463434690.42 results: success (0) buildid: 20160516123243 builduid: ca9d176cf7c0498281e7cb5a743c4edb revision: 7d1f3450acc47025876964c1eca854ae027934f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.422514) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.422930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.423432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.480018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.480294) ========= 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.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-16 14:38:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.0M=0.001s 2016-05-16 14:38:10 (12.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.583452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.583796) ========= 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.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.026626 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:10.636436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 14:38:10.636753) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7d1f3450acc47025876964c1eca854ae027934f3 --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 7d1f3450acc47025876964c1eca854ae027934f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-16 14:38:10,713 truncating revision to first 12 chars 2016-05-16 14:38:10,713 Setting DEBUG logging. 2016-05-16 14:38:10,713 attempt 1/10 2016-05-16 14:38:10,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7d1f3450acc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 14:38:11,742 unpacking tar archive at: mozilla-beta-7d1f3450acc4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.280077 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 14:38:11.937810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:11.938072) ========= script_repo_revision: 7d1f3450acc47025876964c1eca854ae027934f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:11.938446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:11.938700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 14:38:11.953348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-16 14:38:11.953621) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:38:12 INFO - MultiFileLogger online at 20160516 14:38:12 in /builds/slave/test 14:38:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:38:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:12 INFO - {'append_to_log': False, 14:38:12 INFO - 'base_work_dir': '/builds/slave/test', 14:38:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:38:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:12 INFO - 'branch': 'Mozilla-Beta', 14:38:12 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:12 INFO - 'config_files': ('talos/mac_config.py',), 14:38:12 INFO - 'default_actions': ('clobber', 14:38:12 INFO - 'read-buildbot-config', 14:38:12 INFO - 'download-and-extract', 14:38:12 INFO - 'populate-webroot', 14:38:12 INFO - 'create-virtualenv', 14:38:12 INFO - 'install', 14:38:12 INFO - 'run-tests'), 14:38:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:12 INFO - 'download_minidump_stackwalk': True, 14:38:12 INFO - 'download_symbols': 'ondemand', 14:38:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:12 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:12 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:12 INFO - 'installer_path': 'installer.exe', 14:38:12 INFO - 'log_level': 'info', 14:38:12 INFO - 'log_name': 'talos', 14:38:12 INFO - 'log_to_console': True, 14:38:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:38:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:38:12 INFO - 'opt_config_files': (), 14:38:12 INFO - 'pip_index': False, 14:38:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:12 INFO - 'cmd': ('bash', 14:38:12 INFO - '-c', 14:38:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:12 INFO - 'enabled': True, 14:38:12 INFO - 'halt_on_failure': False, 14:38:12 INFO - 'name': 'check_screen_resolution'},), 14:38:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:38:12 INFO - 'cmd': ('bash', 14:38:12 INFO - '-c', 14:38:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:38:12 INFO - 'enabled': True, 14:38:12 INFO - 'halt_on_failure': False, 14:38:12 INFO - 'name': 'check_screen_resolution'},), 14:38:12 INFO - 'run_cmd_checks_enabled': True, 14:38:12 INFO - 'sps_profile': False, 14:38:12 INFO - 'sps_profile_interval': 0, 14:38:12 INFO - 'suite': 'dromaeojs-e10s', 14:38:12 INFO - 'system_bits': '32', 14:38:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:12 INFO - 'title': 't-yosemite-r7-0019', 14:38:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:12 INFO - 'use_talos_json': True, 14:38:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:12 INFO - 'work_dir': 'build'} 14:38:12 INFO - ##### 14:38:12 INFO - ##### Running clobber step. 14:38:12 INFO - ##### 14:38:12 INFO - Running pre-action listener: _resource_record_pre_action 14:38:12 INFO - Running main action method: clobber 14:38:12 INFO - rmtree: /builds/slave/test/build 14:38:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:13 INFO - Running post-action listener: _resource_record_post_action 14:38:13 INFO - ##### 14:38:13 INFO - ##### Running read-buildbot-config step. 14:38:13 INFO - ##### 14:38:13 INFO - Running pre-action listener: _resource_record_pre_action 14:38:13 INFO - Running main action method: read_buildbot_config 14:38:13 INFO - Using buildbot properties: 14:38:13 INFO - { 14:38:13 INFO - "project": "", 14:38:13 INFO - "product": "firefox", 14:38:13 INFO - "script_repo_revision": "production", 14:38:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:38:13 INFO - "repository": "", 14:38:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:38:13 INFO - "buildid": "20160516123243", 14:38:13 INFO - "pgo_build": "False", 14:38:13 INFO - "basedir": "/builds/slave/test", 14:38:13 INFO - "buildnumber": 5, 14:38:13 INFO - "slavename": "t-yosemite-r7-0019", 14:38:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:38:13 INFO - "platform": "yosemite_r7", 14:38:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:38:13 INFO - "branch": "mozilla-beta", 14:38:13 INFO - "repo_path": "releases/mozilla-beta", 14:38:13 INFO - "revision": "7d1f3450acc47025876964c1eca854ae027934f3", 14:38:13 INFO - "stage_platform": "macosx64", 14:38:13 INFO - "builduid": "ca9d176cf7c0498281e7cb5a743c4edb", 14:38:13 INFO - "slavebuilddir": "test" 14:38:13 INFO - } 14:38:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 14:38:13 INFO - Running post-action listener: _resource_record_post_action 14:38:13 INFO - ##### 14:38:13 INFO - ##### Running download-and-extract step. 14:38:13 INFO - ##### 14:38:13 INFO - Running pre-action listener: _resource_record_pre_action 14:38:13 INFO - Running main action method: download_and_extract 14:38:13 INFO - mkdir: /builds/slave/test/build/tests 14:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:13 INFO - https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:38:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:38:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 14:38:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:38:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:38:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json: timed out 14:38:44 INFO - retry: attempt #1 caught exception: timed out 14:38:44 INFO - retry: Failed, sleeping 30 seconds before retrying 14:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 #2 14:39:15 INFO - Downloaded 1241 bytes. 14:39:15 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 14:39:15 INFO - Using the following test package requirements: 14:39:15 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:39:15 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 14:39:15 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 14:39:15 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:39:15 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 14:39:15 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:39:15 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 14:39:15 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 14:39:15 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 14:39:15 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 14:39:15 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 14:39:15 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 14:39:15 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 14:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:15 INFO - https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:39:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:39:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:39:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:17 INFO - Downloaded 17747767 bytes. 14:39:17 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'] 14:39:17 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 14:39:20 INFO - Return code: 0 14:39:20 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 14:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:20 INFO - https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:39:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:39:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 14:39:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:22 INFO - Downloaded 17747767 bytes. 14:39: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'] 14:39: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 14:39:25 INFO - Return code: 0 14:39: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')]} 14:39:25 INFO - https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:39:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:39:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 14:39:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:26 INFO - Downloaded 10845194 bytes. 14:39:26 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'] 14:39:26 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 14:39:27 INFO - Return code: 0 14:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:27 INFO - https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 14:39:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:39:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:39:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 14:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BfPopITTSVKStSB17yMgMg/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 14:39:33 INFO - Downloaded 88288080 bytes. 14:39:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:39:33 INFO - mkdir: /builds/slave/test/properties 14:39:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:33 INFO - Contents: 14:39:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 14:39:34 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg! 14:39:34 INFO - Running post-action listener: _resource_record_post_action 14:39:34 INFO - Running post-action listener: set_extra_try_arguments 14:39:34 INFO - ##### 14:39:34 INFO - ##### Running populate-webroot step. 14:39:34 INFO - ##### 14:39:34 INFO - Running pre-action listener: _resource_record_pre_action 14:39:34 INFO - Running main action method: populate_webroot 14:39:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:34 INFO - '--tppagecycles', 14:39:34 INFO - '7'], 14:39:34 INFO - 'tests': ['tsvgm']}}, 14:39:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:39:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:39:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'tests': ['damp', 'tps']}, 14:39:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['damp', 'tps']}, 14:39:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:39:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:34 INFO - 'other': {'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'other_l64': {'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'other_nol64': {'tests': ['a11yr', 14:39:34 INFO - 'ts_paint', 14:39:34 INFO - 'tpaint', 14:39:34 INFO - 'sessionrestore', 14:39:34 INFO - 'sessionrestore_no_auto_restore', 14:39:34 INFO - 'tabpaint']}, 14:39:34 INFO - 'svgr': {'tests': ['tsvgx', 14:39:34 INFO - 'tsvgr_opacity', 14:39:34 INFO - 'tart', 14:39:34 INFO - 'tscrollx', 14:39:34 INFO - 'cart']}, 14:39:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['tsvgx', 14:39:34 INFO - 'tsvgr_opacity', 14:39:34 INFO - 'tart', 14:39:34 INFO - 'tscrollx', 14:39:34 INFO - 'cart']}, 14:39:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'tests': ['tp5o']}, 14:39:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'talos_options': ['--e10s'], 14:39:34 INFO - 'tests': ['tp5o']}, 14:39:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'talos_options': ['--xperf_path', 14:39:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:34 INFO - 'tests': ['tp5n']}, 14:39:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:34 INFO - 'talos_options': ['--e10s', 14:39:34 INFO - '--xperf_path', 14:39:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:34 INFO - 'tests': ['tp5n']}}, 14:39:34 INFO - 'talos.zip': {'path': '', 14:39:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:34 INFO - Running post-action listener: _resource_record_post_action 14:39:34 INFO - ##### 14:39:34 INFO - ##### Running create-virtualenv step. 14:39:34 INFO - ##### 14:39:34 INFO - Running pre-action listener: _resource_record_pre_action 14:39:34 INFO - Running main action method: create_virtualenv 14:39:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:39:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:34 INFO - Using real prefix '/tools/python27' 14:39:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:38 INFO - Installing pip.................done. 14:39:38 INFO - Return code: 0 14:39:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:38 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:38 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 14:39:38 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 14:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:38 INFO - 'HOME': '/Users/cltbld', 14:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:38 INFO - 'LOGNAME': 'cltbld', 14:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:38 INFO - 'MOZ_NO_REMOTE': '1', 14:39:38 INFO - 'NO_EM_RESTART': '1', 14:39:38 INFO - 'PAGER': '/bin/cat', 14:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:38 INFO - 'PWD': '/builds/slave/test', 14:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:38 INFO - 'SHELL': '/bin/bash', 14:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:38 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:38 INFO - 'USER': 'cltbld', 14:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:38 INFO - 'XPC_FLAGS': '0x0', 14:39:38 INFO - 'XPC_SERVICE_NAME': '0', 14:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:39:38 INFO - Cleaning up... 14:39:38 INFO - Return code: 0 14:39:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:38 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:38 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 14:39:38 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 14:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:38 INFO - 'HOME': '/Users/cltbld', 14:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:38 INFO - 'LOGNAME': 'cltbld', 14:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:38 INFO - 'MOZ_NO_REMOTE': '1', 14:39:38 INFO - 'NO_EM_RESTART': '1', 14:39:38 INFO - 'PAGER': '/bin/cat', 14:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:38 INFO - 'PWD': '/builds/slave/test', 14:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:38 INFO - 'SHELL': '/bin/bash', 14:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:38 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:38 INFO - 'USER': 'cltbld', 14:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:38 INFO - 'XPC_FLAGS': '0x0', 14:39:38 INFO - 'XPC_SERVICE_NAME': '0', 14:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:38 INFO - Downloading/unpacking psutil>=0.7.1 14:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:42 INFO - Installing collected packages: psutil 14:39:42 INFO - Running setup.py install for psutil 14:39:42 INFO - building 'psutil._psutil_osx' extension 14:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:39:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:39:42 INFO - building 'psutil._psutil_posix' extension 14:39:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:39:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:39:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:39:43 INFO - ^ 14:39:43 INFO - 1 warning generated. 14:39:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:39:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:43 INFO - Successfully installed psutil 14:39:43 INFO - Cleaning up... 14:39:43 INFO - Return code: 0 14:39:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:43 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:43 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 14:39:43 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 14:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:43 INFO - 'HOME': '/Users/cltbld', 14:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:43 INFO - 'LOGNAME': 'cltbld', 14:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:43 INFO - 'MOZ_NO_REMOTE': '1', 14:39:43 INFO - 'NO_EM_RESTART': '1', 14:39:43 INFO - 'PAGER': '/bin/cat', 14:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:43 INFO - 'PWD': '/builds/slave/test', 14:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:43 INFO - 'SHELL': '/bin/bash', 14:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:43 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:43 INFO - 'USER': 'cltbld', 14:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:43 INFO - 'XPC_FLAGS': '0x0', 14:39:43 INFO - 'XPC_SERVICE_NAME': '0', 14:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:39:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:39:46 INFO - Installing collected packages: mozsystemmonitor 14:39:46 INFO - Running setup.py install for mozsystemmonitor 14:39:46 INFO - Successfully installed mozsystemmonitor 14:39:46 INFO - Cleaning up... 14:39:46 INFO - Return code: 0 14:39:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:46 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:46 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 14:39:46 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 14:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:46 INFO - 'HOME': '/Users/cltbld', 14:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:46 INFO - 'LOGNAME': 'cltbld', 14:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:46 INFO - 'MOZ_NO_REMOTE': '1', 14:39:46 INFO - 'NO_EM_RESTART': '1', 14:39:46 INFO - 'PAGER': '/bin/cat', 14:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:46 INFO - 'PWD': '/builds/slave/test', 14:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:46 INFO - 'SHELL': '/bin/bash', 14:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:46 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:46 INFO - 'USER': 'cltbld', 14:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:46 INFO - 'XPC_FLAGS': '0x0', 14:39:46 INFO - 'XPC_SERVICE_NAME': '0', 14:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:50 INFO - Downloading docopt-0.6.1.tar.gz 14:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:50 INFO - Running setup.py install for blobuploader 14:39:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:50 INFO - Running setup.py install for requests 14:39:50 INFO - Running setup.py install for docopt 14:39:50 INFO - Successfully installed blobuploader requests docopt 14:39:50 INFO - Cleaning up... 14:39:51 INFO - Return code: 0 14:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:51 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:51 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 14:39:51 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 14:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:51 INFO - 'HOME': '/Users/cltbld', 14:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:51 INFO - 'LOGNAME': 'cltbld', 14:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:51 INFO - 'MOZ_NO_REMOTE': '1', 14:39:51 INFO - 'NO_EM_RESTART': '1', 14:39:51 INFO - 'PAGER': '/bin/cat', 14:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:51 INFO - 'PWD': '/builds/slave/test', 14:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:51 INFO - 'SHELL': '/bin/bash', 14:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:51 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:51 INFO - 'USER': 'cltbld', 14:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:51 INFO - 'XPC_FLAGS': '0x0', 14:39:51 INFO - 'XPC_SERVICE_NAME': '0', 14:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-IHuxpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-0mvWqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-MMM_Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-d8Rjm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Kqek8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Uw3niY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:51 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-97FEGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-3B4BM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-he4nbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-CqIGsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-kMOOq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-uGMWZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-aKvqCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-xO59B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-HNP2Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:52 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-KwfPnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:53 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Nl_rNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:53 INFO - Running setup.py install for manifestparser 14:39:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:53 INFO - Running setup.py install for mozcrash 14:39:53 INFO - Running setup.py install for mozdebug 14:39:53 INFO - Running setup.py install for mozdevice 14:39:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:53 INFO - Running setup.py install for mozfile 14:39:54 INFO - Running setup.py install for mozhttpd 14:39:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Running setup.py install for mozinfo 14:39:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Running setup.py install for mozInstall 14:39:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Running setup.py install for mozleak 14:39:54 INFO - Running setup.py install for mozlog 14:39:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Running setup.py install for moznetwork 14:39:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:54 INFO - Running setup.py install for mozprocess 14:39:55 INFO - Running setup.py install for mozprofile 14:39:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Running setup.py install for mozrunner 14:39:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Running setup.py install for mozscreenshot 14:39:55 INFO - Running setup.py install for moztest 14:39:55 INFO - Running setup.py install for mozversion 14:39:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:55 INFO - Cleaning up... 14:39:55 INFO - Return code: 0 14:39:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:55 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:39:55 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 14:39:55 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 14:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:39:55 INFO - 'HOME': '/Users/cltbld', 14:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:39:55 INFO - 'LOGNAME': 'cltbld', 14:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:55 INFO - 'MOZ_NO_REMOTE': '1', 14:39:55 INFO - 'NO_EM_RESTART': '1', 14:39:55 INFO - 'PAGER': '/bin/cat', 14:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:55 INFO - 'PWD': '/builds/slave/test', 14:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:39:55 INFO - 'SHELL': '/bin/bash', 14:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:39:55 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:39:55 INFO - 'USER': 'cltbld', 14:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:55 INFO - 'XPC_FLAGS': '0x0', 14:39:55 INFO - 'XPC_SERVICE_NAME': '0', 14:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-95I_6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-4ZVUps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:56 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)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-y7dpDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-pJ9jzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:56 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)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-GVRmRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-9ChHgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-IpEcQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:56 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-d_k7kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-yVpZAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-7g6HUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-XQs8Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-bXidTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-vKrwpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:57 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)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-l8ytRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-ErLkqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-Tl4aqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:57 INFO - Running setup.py (path:/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/pip-JFoXKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:39:57 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)) 14:39:57 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)) 14:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:39:57 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)) 14:39:57 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)) 14:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:00 INFO - Downloading blessings-1.6.tar.gz 14:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:00 INFO - Installing collected packages: blessings 14:40:00 INFO - Running setup.py install for blessings 14:40:00 INFO - Successfully installed blessings 14:40:00 INFO - Cleaning up... 14:40:00 INFO - Return code: 0 14:40:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:00 INFO - Reading from file tmpfile_stdout 14:40:00 INFO - Current package versions: 14:40:00 INFO - blessings == 1.6 14:40:00 INFO - blobuploader == 1.2.4 14:40:00 INFO - docopt == 0.6.1 14:40:00 INFO - manifestparser == 1.1 14:40:00 INFO - mozInstall == 1.12 14:40:00 INFO - mozcrash == 0.17 14:40:00 INFO - mozdebug == 0.1 14:40:00 INFO - mozdevice == 0.48 14:40:00 INFO - mozfile == 1.2 14:40:00 INFO - mozhttpd == 0.7 14:40:00 INFO - mozinfo == 0.9 14:40:00 INFO - mozleak == 0.1 14:40:00 INFO - mozlog == 3.1 14:40:00 INFO - moznetwork == 0.27 14:40:00 INFO - mozprocess == 0.22 14:40:00 INFO - mozprofile == 0.28 14:40:00 INFO - mozrunner == 6.11 14:40:00 INFO - mozscreenshot == 0.1 14:40:00 INFO - mozsystemmonitor == 0.0 14:40:00 INFO - moztest == 0.7 14:40:00 INFO - mozversion == 1.4 14:40:00 INFO - psutil == 3.1.1 14:40:00 INFO - requests == 1.2.3 14:40:00 INFO - wsgiref == 0.1.2 14:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:00 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:40:00 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 14:40:00 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 14:40:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:40:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:00 INFO - 'HOME': '/Users/cltbld', 14:40:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:00 INFO - 'LOGNAME': 'cltbld', 14:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:00 INFO - 'MOZ_NO_REMOTE': '1', 14:40:00 INFO - 'NO_EM_RESTART': '1', 14:40:00 INFO - 'PAGER': '/bin/cat', 14:40:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:00 INFO - 'PWD': '/builds/slave/test', 14:40:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:00 INFO - 'SHELL': '/bin/bash', 14:40:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:40:00 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:40:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:00 INFO - 'USER': 'cltbld', 14:40:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:00 INFO - 'XPC_FLAGS': '0x0', 14:40:00 INFO - 'XPC_SERVICE_NAME': '0', 14:40:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 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)) 14:40:01 INFO - Cleaning up... 14:40:01 INFO - Return code: 0 14:40:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:01 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:40:01 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 14:40:01 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 14:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:01 INFO - 'HOME': '/Users/cltbld', 14:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:01 INFO - 'LOGNAME': 'cltbld', 14:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:01 INFO - 'MOZ_NO_REMOTE': '1', 14:40:01 INFO - 'NO_EM_RESTART': '1', 14:40:01 INFO - 'PAGER': '/bin/cat', 14:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:01 INFO - 'PWD': '/builds/slave/test', 14:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:01 INFO - 'SHELL': '/bin/bash', 14:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:40:01 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:01 INFO - 'USER': 'cltbld', 14:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:01 INFO - 'XPC_FLAGS': '0x0', 14:40:01 INFO - 'XPC_SERVICE_NAME': '0', 14:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:01 INFO - Downloading/unpacking jsonschema 14:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:03 INFO - Downloading/unpacking functools32 (from jsonschema) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:04 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:04 INFO - warning: no files found matching '*.txt' 14:40:04 INFO - no previously-included directories found matching 'build' 14:40:04 INFO - no previously-included directories found matching 'dist' 14:40:04 INFO - no previously-included directories found matching '.git*' 14:40:04 INFO - Installing collected packages: jsonschema, functools32 14:40:04 INFO - Running setup.py install for functools32 14:40:04 INFO - warning: no files found matching '*.txt' 14:40:04 INFO - no previously-included directories found matching 'build' 14:40:04 INFO - no previously-included directories found matching 'dist' 14:40:04 INFO - no previously-included directories found matching '.git*' 14:40:04 INFO - Successfully installed jsonschema functools32 14:40:04 INFO - Cleaning up... 14:40:04 INFO - Return code: 0 14:40:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:04 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 0x10f908a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f90f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd79d934d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, '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.6YdmJeXawk/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.YgxGpwXxLP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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 14:40:04 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 14:40:04 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 14:40:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:40:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:04 INFO - 'HOME': '/Users/cltbld', 14:40:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:04 INFO - 'LOGNAME': 'cltbld', 14:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:04 INFO - 'MOZ_NO_REMOTE': '1', 14:40:04 INFO - 'NO_EM_RESTART': '1', 14:40:04 INFO - 'PAGER': '/bin/cat', 14:40:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:04 INFO - 'PWD': '/builds/slave/test', 14:40:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:04 INFO - 'SHELL': '/bin/bash', 14:40:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:40:04 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:40:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:04 INFO - 'USER': 'cltbld', 14:40:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:04 INFO - 'XPC_FLAGS': '0x0', 14:40:04 INFO - 'XPC_SERVICE_NAME': '0', 14:40:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:04 INFO - Downloading/unpacking flake8 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:40:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:40:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:08 INFO - no previously-included directories found matching 'docs/_build' 14:40:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:40:08 INFO - Running setup.py install for pep8 14:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:40:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:40:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:40:08 INFO - no previously-included directories found matching 'docs/_build' 14:40:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:40:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:40:09 INFO - Cleaning up... 14:40:09 INFO - Return code: 0 14:40:09 INFO - Running post-action listener: _resource_record_post_action 14:40:09 INFO - Running post-action listener: _start_resource_monitoring 14:40:09 INFO - Starting resource monitoring. 14:40:09 INFO - ##### 14:40:09 INFO - ##### Running install step. 14:40:09 INFO - ##### 14:40:09 INFO - Running pre-action listener: _resource_record_pre_action 14:40:09 INFO - Running main action method: install 14:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:09 INFO - Reading from file tmpfile_stdout 14:40:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:09 INFO - Reading from file tmpfile_stdout 14:40:09 INFO - Output received: 14:40:09 INFO - Usage: mozinstall [options] installer 14:40:09 INFO - Options: 14:40:09 INFO - -h, --help show this help message and exit 14:40:09 INFO - -d DEST, --destination=DEST 14:40:09 INFO - Directory to install application into. [default: 14:40:09 INFO - "/builds/slave/test"] 14:40:09 INFO - --app=APP Application being installed. [default: firefox] 14:40:09 INFO - mkdir: /builds/slave/test/build/application 14:40:09 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'] 14:40:09 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 14:40:31 INFO - Reading from file tmpfile_stdout 14:40:31 INFO - Output received: 14:40:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:40:31 INFO - Running post-action listener: _resource_record_post_action 14:40:31 INFO - ##### 14:40:31 INFO - ##### Running run-tests step. 14:40:31 INFO - ##### 14:40:31 INFO - Running pre-action listener: _resource_record_pre_action 14:40:31 INFO - Running main action method: run_tests 14:40:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:40:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:40:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:40:31 INFO - 2016-05-16 14:40:31.764 screenresolution[1647:7607] starting screenresolution argv=screenresolution get 14:40:31 INFO - 2016-05-16 14:40:31.767 screenresolution[1647:7607] Display 0: 1600x1200x32@60 14:40:31 INFO - 2016-05-16 14:40:31.773 screenresolution[1648:7610] starting screenresolution argv=screenresolution list 14:40:31 INFO - Available Modes on Display 0 14:40:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:40:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:40:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:40:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:40:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:40:31 INFO - Intel Iris: 14:40:31 INFO - Chipset Model: Intel Iris 14:40:31 INFO - Type: GPU 14:40:31 INFO - Bus: Built-In 14:40:31 INFO - VRAM (Dynamic, Max): 1536 MB 14:40:31 INFO - Vendor: Intel (0x8086) 14:40:31 INFO - Device ID: 0x0a2e 14:40:31 INFO - Revision ID: 0x0009 14:40:31 INFO - Displays: 14:40:31 INFO - Display: 14:40:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:40:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:40:31 INFO - Display Serial Number: 1600x1200 60 14:40:31 INFO - Main Display: Yes 14:40:31 INFO - Mirror: Off 14:40:31 INFO - Online: Yes 14:40:31 INFO - Rotation: Supported 14:40:32 INFO - Return code: 0 14:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:32 INFO - Python 2.7.3 14:40:32 INFO - Return code: 0 14:40:32 INFO - grabbing minidump binary from tooltool 14:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:40:32 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 0x10f7acd30>, '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 0x10f610db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7a3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:40:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:40:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:32 INFO - Return code: 0 14:40:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:40:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:40:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:40:33 INFO - Return code: 0 14:40:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:40:33 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --title t-yosemite-r7-0019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:40:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6YdmJeXawk/Render', 14:40:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:40:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:40:33 INFO - 'HOME': '/Users/cltbld', 14:40:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:40:33 INFO - 'LOGNAME': 'cltbld', 14:40:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:33 INFO - 'MOZ_NO_REMOTE': '1', 14:40:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:33 INFO - 'NO_EM_RESTART': '1', 14:40:33 INFO - 'PAGER': '/bin/cat', 14:40:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:33 INFO - 'PWD': '/builds/slave/test', 14:40:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:40:33 INFO - 'SHELL': '/bin/bash', 14:40:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YgxGpwXxLP/Listeners', 14:40:33 INFO - 'TMPDIR': '/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/', 14:40:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:40:33 INFO - 'USER': 'cltbld', 14:40:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:40:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:33 INFO - 'XPC_FLAGS': '0x0', 14:40:33 INFO - 'XPC_SERVICE_NAME': '0', 14:40:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:40:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:40:33 INFO - mozversion application_buildid: 20160516123243 14:40:33 INFO - mozversion application_changeset: 7d1f3450acc47025876964c1eca854ae027934f3 14:40:33 INFO - mozversion application_display_name: Firefox 14:40:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:33 INFO - mozversion application_name: Firefox 14:40:33 INFO - mozversion application_remotingname: firefox 14:40:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:33 INFO - mozversion application_vendor: Mozilla 14:40:33 INFO - mozversion application_version: 47.0 14:40:33 INFO - mozversion platform_buildid: 20160516123243 14:40:33 INFO - mozversion platform_changeset: 7d1f3450acc47025876964c1eca854ae027934f3 14:40:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:33 INFO - mozversion platform_version: 47.0 14:40:33 INFO - using testdate: 1463434833 14:40:33 INFO - actual date: 1463434833 14:40:33 INFO - starting webserver on 'localhost:49272' 14:40:33 INFO - SUITE-START | Running 2 tests 14:40:33 INFO - TEST-START | dromaeo_css 14:40:33 INFO - operating with platform_type : mac_ 14:40:33 INFO - Initialising browser for dromaeo_css test... 14:40:33 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpe9bC1f/profile http://localhost:49272/getInfo.html) 14:40:36 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 14:40:36 INFO - PROCESS | 1666 | colorDepth:24 14:40:36 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 14:40:36 INFO - PROCESS | 1666 | __metrics 14:40:36 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 14:40:36 INFO - TEST-INFO | 1666: exit 0 14:40:36 INFO - Browser initialized. 14:40:36 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:36 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpe9bC1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:48 INFO - PROCESS | 1670 | RSS: Main: 167428096 14:40:48 INFO - PROCESS | 1670 | 14:41:38 INFO - PROCESS | 1670 | 1463434898613 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] 14:43:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 14:43:50 INFO - PROCESS | 1670 | RSS: Main: 179412992 14:43:50 INFO - PROCESS | 1670 | 14:46:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 14:46:53 INFO - PROCESS | 1670 | RSS: Main: 189370368 14:46:53 INFO - PROCESS | 1670 | 14:49:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 14:49:55 INFO - PROCESS | 1670 | RSS: Main: 191414272 14:49:55 INFO - PROCESS | 1670 | 14:52:57 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 14:52:57 INFO - PROCESS | 1670 | RSS: Main: 195158016 14:52:57 INFO - PROCESS | 1670 | 14:56:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 14:56:01 INFO - PROCESS | 1670 | RSS: Main: 193974272 14:56:01 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 14:59:03 INFO - PROCESS | 1670 | RSS: Main: 199729152 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | __start_tp_report 14:59:03 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 14:59:03 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 14:59:03 INFO - PROCESS | 1670 | |i|pagename|runs| 14:59:03 INFO - PROCESS | 1670 | |0;dojo.html;3695.648913353232;3708.1656627258853;3731.626837316267;3780.5841357450677;3780.8676696315633;4862.124817532847;5150.072986862373;5686.20393144959;6035.245594300713;6083.482903953164;4859.514048595139;6004.909926351097;6070.757169713206;6087.39126087391;6112.235970503687;5350.785968561253;5353.892922141555;5406.756695948692;5443.074677304848;5503.587230957674;4443.622292105175;5270.341207349082;5328.92006619901;5392.460753924615;5409.972950135244;5379.435159308275;5384.91922621161;5396.757145928423;5397.163439666839;5425.077736784737;5350.678959262456;5382.946170538303;5397.595180361489;5517.2551705519645;5533.474319939599;4398.978005109986;5308.230306605559;5457.890842183134;5466.644668096561;5494.36814766303;5856.32652244993;5957.314908785458;6060.454559089703;6106.053561697944;6144.047672610708;6170;6232.421982325838;6287.276963149251;6290.4024117709205;6302.842428939267;5318.574514038906;5752.964466396047;6299.65351905645;6313.305536390993;6356.745730170787;6002.819915402589;6050.969745151246;6100.633961962252;6111.655435804116;6127.754889804447;5415.009307827053;6479.028145778171;6483.870322593616;6487.675616219264;6522.771702990467;6264.342244064308;6281.309056003836;6283.3088360280335;6289.119523266746;6327.367263273636;6243.8126856194385;6292.2134733158355;6338.809835704937;6341.936580634227;6381.298057213703;6238.282597501255;6242.719077641426;6264.718087686065;6286.371362863769;6291.402316779899;6221.3778622138325;6285.371462853678;6290.245170579468;6299.748010079546;6300.401461861115;4930.91519865629;4947.25791131326;4961.7271050092595;4968.8757781055765;4996.275540046673;4556.2937744649635;4571.794269257892;4589.449266088091;4602;4610.631149508032;6040.184575082308;6147.231596050494;6173.69131543421;6197.4732147767945;6215.005599104122;6228.968855155786;6298.370162983665;6323.019931910561;6379.298277189506;6387.297397286295;6173.47525460332;6191.164192834;6198.256209254918;6226.501879849601;6238.594491358047;5603;5610.410906854803;5623.353314368818;5624.831255062355;5625.156226566048;6399.9040014399825;6490.935090649127;6546.509011824228;6601.76893808724;6613.801585952429;6381.202349706286;6389.904151437825;6394.520410969289;6409.551331406943;6432.839179020375;6363.745450181941;6516.087747715229;6601.405873471411;6602.966985165043;6610.2398224204835;6195;6241.001439769615;6269.96865015672;6293.55945083858;6318.399752023551;5249.317588713443;6329.841753956004;6332.176817013758;6334.619922804646;6336.112944187726;5716.114002329646;6262.686865656608;6279.591826531444;6281.057841323838;6289.308176100717;4814.398200224972;4824.903501930012;6246.781362652286;6247.906281405873;6273.466755325849;6107.450329470369;6134.294556126102;6168.19813424252;6168.691565421621;6171.352008039091;6170.136180934763;6193.349698281616;6244.531660125418;6262.4990000800735;6268.4671802897265;6189.783357582463;6243.500519958483;6252.437280644582;6259.593126446948;6269.937300626935 14:59:03 INFO - PROCESS | 1670 | |1;ext.html;442.33870363806113;497.79341573247103;591.4558606082404;614.7295190116348;660.3165723476202;39380.80309598451;39955.800220998855;40045.79862604119;40110.598894011055;40442.595574044215;35978.8201058995;43556;43660;43951.68144955656;44270.7786461068;9539.999999999982;9742.659006934759;9775.462349570771;9797.90202097977;9801.431770916655;8676.783080422976;9720.562574684122;9756.902430975706;9833.213342932584;9894.604215831358;9788.55951482185;9873.308868379216;9874.308798384116;9888.208943284555;9889.307748457612;9820.50897455128;9889.10998010179;9909;9917.553710083064;9918.008199180096;9655.131038206526;9819.263555233387;9824;9836.31145819793;9855.753606159831;36213.81893090544;40854.38718419226;41084.589154108675;41230.1753964922;41408.58591414077;3158.510430883217;3346.531485592019;3413.5050417689295;3494.5631796025496;3514.595821480537;27144.864275678694;27467.31331716703;28204.858975705196;28534.28664283389;28767.424651507063;2670.185593394014;2739.821911575741;2778.7221277872254;2794.02209226769;2893.8842446302124;279614;342572;343823;344905;345952.27023864974;48064.27903581449;48079.519204807504;48085.5191448088;65285;66575.66712166506;47617;47807.04385912262;47812;47884;48166.5183348162;13839.962002849625;16938.23777929996;17044.97730136196;17060.402885898933;17073.40243091486;13475.865241347658;13477.663058423423;13647.931760341135;13695.86304136946;13711.931440342934;15328.540143795704;15449.9227503864;15490.457833975757;15495.225238738018;15623.609409764847;5866.7066646668345;5866.8266346730825;5883.3234178069215;5902.911456328158;5906.291245050621;930.9627614895463;1002.711515702319;1065.81881080215;1159.8492196014633;1235.5057976809348;27307.590386144224;30135.849320753256;30385.696143038727;30814.53778193329;30863.074107776803;1134.8127558952845;1171.5957994491887;1233.2538814017569;1243.1981372015;1302.4594793160732;15222.771658425132;15635.296411661502;15748.291326890318;15794.36822527109;15910.522684319489;480305;515938.8406115966;538211;546886;547190;62131.689341553;62441.687791560755;62820.05769913455;62822;62933.056004159975;1361.6868120332379;1380.4892189889806;1536.861682448585;1554.8056492938383;1591.1884938681355;29787.404251915275;30629.846850765603;30633.00885442439;30761.230969225948;30822.767089316178;52343.47656523538;52552.21171682504;52714.73642631762;53053.46946530485;53092;415728;417479;422674;489513;490271;34339.31321373609;34709.13227169341;45634.54365456303;45998.310025350314;47403.762981184875;44854.77572612116;45073.77463112663;45481.54518454773;45511.31733024074;45747.31379029251;36273.27453450969;37374;37458.62541374551;37610.247795044495;37977.81011094927;36492.0876978067;36568;36757.52969881175;37021.81489092537;37105.14474276221;34998.30003399969;38897.416538752506;39636.00909977274;40203.79388618346;41182.38226426666;32425.83787081144;32614;33205.83397082999;33571.66428335783;34859;25441;25899.61150582705;26215.475690485702;26215.737842622093;26497.205083847515 14:59:03 INFO - PROCESS | 1670 | |2;jquery.html;378.19821977407884;379.1090936299696;382.5180272856201;386.58442174662247;387.4324115171274;20184.798152018495;21808.672869906964;22049.889750551243;22711.20510782125;22721.863906804676;22285.44286392841;22453.55092898141;22688.205912793055;22709.318720438372;22727.772722272774;5840.883182336351;5842.32813226478;6064.272287325527;6119.602225855305;6163.599366041193;4175.248455278049;5947.01874190758;6166.321704612489;6167.62994220346;6188.81433556994;5917.704114794265;6077.969610151943;6138.355472675372;6145.324014358417;6177.691115444232;6086.147939288503;6088.543359248052;6106.786262480814;6109.297430795471;6118.755249790003;4906.828261010884;5443.700596467193;5899.056151015817;5900.468957793819;5929.377415371367;25647;25814.354641134123;25928.351791205183;26132.085377011714;26262.474750504884;2021.433998480413;2192.901319440629;2229.4649284171846;2233.3969828146473;2252.662100684894;10065.396076235449;15631;15784.210789460596;16520.339186432528;16850.915745421316;1909.2458478900755;1924.018750437287;1957.3051566693762;1965.6461836869357;2041.6529190037581;82863;131298;134476.98284525838;134887.6511234895;134896;19961.301354452524;20402.795972040385;20531.794682053285;20585.89707051455;20723.378298651063;30505.542416863766;30861.84569077185;30894.536581951288;30953.380932381675;31578.052658420285;11489.942550287195;11595.304281743123;11791.705207369885;11792.938635522843;11822.52709891612;9205.907940920639;9220.216281616003;9948.253880958957;10043.296969212084;10051.24615653829;9109.81780364389;9195.218406435528;9230.215431688248;9236.769080773034;9263.444193348421;1903.3433465454395;1959.1281879563458;1984.5435549823621;1988.9502762431055;2018.0111745244724;924.4453328003278;960.4333443268505;1012.9240306977006;1048.4967215736337;1054.5096530113533;20561.140075078532;20565.897170514352;20830.79169208319;21006.789932100484;21071.051802668917;982.1602529837029;990.9653162139291;1016.5527168046036;1025.6512785652915;1046.8796088449774;11044.558217671363;11162.832557511643;11227.989480946591;11261.268017578832;11271.098312135173;504953;620273;631685;631980;645532;84614.15385846185;111283.44358278156;112351;112684;112947;1052.9943903572223;1054.335768465877;1067.685032915292;1073.0878753059992;1091.6070214722693;18113.45659630213;18440.446786596425;18613.906930465262;18633.627327453647;18777.90611046936;35716.46425303674;48944.75527622339;49849;50429.74785126198;50763.49236507588;65394.34605653882;67924.98112528415;68094.3190568088;68309.97535037078;68899;8202.138775428493;8245.134260902758;8250.793730156794;8390.370722195981;8493.023302320313;9549.09283618055;11708.297502149899;12979.740405192033;13289.66775830612;13328.533501327795;11229.101671866069;11363.488643010918;11548.538058477567;11558;11812.586559470377;9283.582238799136;10958.287711299059;11216.66350009501;11247.381394023407;11588.594399195988;9558;9929.553170107507;11261.380624065427;11402.82895756581;11813.70465738329;7161.606111663908;7239.457040721862;8214.753557393287;8287.295579875778;8338;10352.896471035194;11809.586664466702;11968.281903085843;12054.819177712166;12138.696532586757 14:59:03 INFO - PROCESS | 1670 | |3;mootools.html;1703.1484257871064;1713.1348668922196;1929.3633101076646;2092.587503435182;2094;8390.370722195828;9058.23005044572;9120.224780893624;9326.766830829232;9340.71977840665;9096.363254572183;9113.179813816756;9173.403728757643;9181.77045573861;9197.31020173488;2584.4185058361904;2616.293600727802;2619.4630100829286;2619.882105305256;2621.685397752263;2551.400420901087;2581.070814506776;2620.9254205775637;2622.1215892675978;2622.252657992463;2573.7554932281496;2590.6632137822057;2611.281897478199;2622.72461391554;2637.3406648337914;2602.726713695063;2615.921522354323;2628.907988220413;2635.736426357368;2643.510950474149;2552.5788244939563;2586.2887705880844;2587.5083734090463;2629.5529759940855;2638.1557901471538;9199.310051746146;9236.9839317675;9261.16649501548;9269.351145419823;9288.767780805467;5636.971815140939;5721.056025755745;5753.568482363798;5854.47309742121;5875.148103525008;3602.765820221677;3756.1360886996144;3785.356489396809;3804.619538046173;3827.311084004878;1018.2464975917842;1065.733566608348;1075.295681328731;1109.1514991031868;1121.6578943422253;12414.689632759162;12435.44040518179;12493.312867792269;12516.249025058525;12573.874261257362;5048;5069.391672999263;5165.715885626327;5204.531592156724;5214.7914083436235;10606.840897386546;10660.307080039773;10673.62642307531;10682.51928663212;10708.678739637824;5697.145428185805;5793.7392817323325;5799.3620701722775;5823.359430462646;5885.61743486672;4741.644376671695;5064.620153488503;5164.04465173944;5165;5266.473352664703;4029.852960814331;4138.6482149017065;4169.478815148106;4169.520505141887;4183.91632167355;1361.8910487161004;1364.3968337203746;1373.6085215713474;1381.550995926328;1396.5880065380736;1162.2329262686587;1205.5479195301762;1233.784087784634;1404.3399602186955;1454.8399676035629;8484.703035393855;8576.742697719079;8671.306295496472;8688.609012594323;8689.435186712843;548.1144861675822;548.8298627425511;550.9421510741395;551.9089350257243;555.7971340460783;6344.365563443619;6404.7117879695525;6434.034894765729;6445.097686323918;6445.516586255956;9561.282903782245;10939.12487001038;11110.833337499944;11164.162687798447;11293.378864162385;10746.301490403099;10941.12471002318;10965.61620343284;11036.724081898017;11256.099512039018;8750.47497150173;8789.472631642122;8820.029796722227;8842.646294148162;8876.378653494194;8004.759857204293;8057.153998830038;8170.264676179172;8199.549024803693;8200.42597018203;9790;9963.601455941971;10080.092791648494;10144.239182061227;10148.340357876714;8315.459495132796;9762.414255144715;10009.649662261785;10121.949390253001;10584.36493810343;6558.311377305505;7683.308502234826;7711.884321735066;7887;7901.881471778043;7717.961410192913;7722.729704460542;7798.220177982384;7824.804379890548;7859.60701964888;7535.095788505414;7667.0416197975255;7754.6898124074405;7800.6099695016155;7856.25365590268;7575.431842611716;7637.083549974039;7653.6938522460705;7691.653875575725;7759.456838021284;6853.280405557344;7515.910193021872;7729.227077292226;7822.804429889298;7853.842923141619;7151.892721609284;7338.082739657543;7360.595167265852;7371.815704607213;7411.777646670608;7062.081929349151;7069.187043490065;7070.929290707027;7078.787636370917;7091 14:59:03 INFO - PROCESS | 1670 | |4;prototype.html;339.65864306372094;342.8165931226794;343.0651474731357;345.51627721190346;350.6738732978331;6847.554908930929;6916.2737912519215;6993.790186294413;7007.369336759691;7060.258672839349;6859.554128981613;6910.896336554943;6922.4462043036565;6924.549904256232;6945.687444065016;4762.904741905159;4893;5021.397432308128;5025.974870125644;5092.465291144423;4026.4161696553983;4991.151504244287;5012.72430016349;5016.749162541876;5032.723200223986;4997.225430058329;4997.625178111638;5005.799768009275;5047.520485553867;5062.620303477235;5043.773030213649;5047.823326183584;5051.5201055899815;5061.468545802674;5071.112555302844;4344.9348259776125;4346.8913277168;4349.108432771274;4357.954091018165;4368.847090351823;6324.9051264231075;6601.768938087144;6682.465402767767;6682.565633233824;6701.765438209639;5850.297964244275;5894.793682221145;5903.085021821625;5903.232579764646;5923.052311630162;7390.408767298603;7390.445716571278;7399.3710534604625;7401.925980740178;7407.074115735533;4095.3242714952;4635.142498637762;4726.196546587088;4751.619870410359;4757.738324392157;7713.305802477804;7737.187595302525;7751.3411360035025;7805.1804560520895;7808.726694565719;4147.253494370982;4252.043290259729;4791.149266186613;4828.61371090312;4849.442314133919;4902.2156454967035;4915.557599815962;4929.482404347564;4945.901081978341;4967.950320496821;5888.705564721832;5903.58674892762;5906.852328691817;5912.733926973297;5939.524838012949;7314;7360.521566098187;7399.6670149843385;7402.444816638774;7426.814329641694;1387.6322774464775;1711.2128420926265;1711.5293294343905;1711.606330543957;1712.315073970397;1035.984460233097;1079.2768844873954;1079.9406032668278;1089.2810744908322;1099.2799716185912;6105.236845394325;6346.904796428057;6894.586324820427;6930.099087118743;6986.93013069873;7446.813829654302;7563.470557061063;7571.318581327707;7586.848263034708;7618.771436856903;6000.639961602318;6939.93060069403;7110.786676399716;7145.392641625416;7176.210616832144;4037.5154981401834;4089.2230476209425;4102.446169767103;4103.117829666636;4117.341225403921;8070.112287648354;8077.798055048671;8097.514149151069;8104.959475202586;8122.675092996214;7722.92277077222;7854.096778870503;7989.320907722792;7992.280694737501;8013.919860801318;6472.644004579794;8080.232377924088;8103.594820258963;8106.351491880635;8133.674653013932;6096.390360964046;7758.340541054074;7764.340031097194;7770.494917830323;7800.570968596781;6598.581305019444;7081.221065682667;7550.093988721389;7567.167611562613;7606;6581.473482121514;7483.32650061497;7775.883361749691;8004.119546849958;8076.636551355321;4788.664793464424;4824.107540105092;4844.85084694937;4850.757462126809;4863.927041094457;7644.0827100748265;7655.540667559964;7675.692972281269;7680.963069985704;7681.846363072819;7377.114746230487;7393.889091663522;7395.963020184865;7416.8887466686965;7433.553986760811;5890.558208134493;7333.826587745935;7383.446241531799;7385.9630701846145;7425.777226683208;7169;7194.532355396883;7199.532030418216;7209.279072092749;7242.818929526804;6423.389777971085;6873.865812140941;7375.963120184365;7376.668049937873;7415.258474152542;6930.5148639594745;7201;7209.279072092749;7209.855802883808;7251.347378735939 14:59:03 INFO - PROCESS | 1670 | |5;yui.html;700.3801635552535;707.6956908529334;727.8435136445664;775.2054144501885;813.3574476163831;15380;15510.534683959471;15637.609059773511;15684.921575392107;15754.212289385528;14611.488597899075;14666.12003279804;14676.779848302283;14679.97240193187;14691.77962330566;820.5897051474263;968.9176420004308;987.4470296633872;1009.1825621246777;1011.8414415494254;947.0576776107782;966.1739212972913;985.0445068283789;991.5785791038816;998.0817647764038;1008.495752123938;1011.0849681038671;1012.1093437774784;1067.6049861551237;1069.3316677076828;1033.9948300258488;1042.7393151712072;1051.2378525568977;1058.9622170273099;1062.9954692815293;751.1924680967927;765.3685709289858;771.3559178086305;781.8788087846393;790.0795573157264;15015;15038.248087595577;15134.697306053817;15141.924290378478;15186.924065379713;13398.598042058753;13406.195628262336;13418.865811341957;13536.796948045787;13541.729165416735;10120.544575494121;10133.695989120339;10167.898321016843;10237.078662920372;10446.320989135682;3482.4428091505238;3511.0344655219765;3518.6305437928904;3576.3204991051875;3600.027992442026;85319;86041;86065.70901436484;86236;86301.56849215776;9721.319507634538;9753.463559504153;9763.02369763018;9802.36284641496;9926.2059035277;22942.311730648107;23678;23688.763112369;23718.93264803088;24104.638430423558;7438.66526006331;7553.206913274027;7581.924180758232;7615.16233214346;7915.564643944638;4072.144849581621;4144.295469770146;4205.537390887;4212.957870421256;4338.34924761282;3738.756980796294;3759.605241449663;3762.6237376262156;3767.962320376816;3785.470034195215;715.9296851207478;724.2033762860812;728.4391018915405;733;740.0416460683427;525.6478159633054;538.0530266730582;588.9734961926638;621.4438077920236;636.3064259956669;8185.918140818516;8435.903332566728;8477.23704866565;8503.1921967413;8585.055643879168;608.6256951974503;620.2649859915924;623.2583225961092;623.6538721009792;629.351767679291;3364.7812892161933;3940.8817735467983;4078.408630748525;4093.16090201508;4145.233131870614;55675.72162139245;80714;95408.52295738478;96751.54872676915;97493.02506974981;85057.57471212605;86447.56776216204;86673.56663216643;87086.12913870908;87594;49428;66652.33347666558;69369.65315173392;69678;70044.2995570048;7664.770056898302;7819.687212511436;8166.265036146775;8291.83416331682;8467.661293548435;51423;51859.96280074302;51947.74026129845;53457.7327113362;54001.45998540121;69862.65068674624;73686;73918.26081739328;74411;74958.62520687362;11129.666110016713;11298.435078246219;11371.488283027118;11496.90779375958;12155.392230388268;11910.225835320676;12215.144939854481;12262.20295680778;12423.378831058591;12631.684207894508;11745.236559623598;11815.172937894265;12027.819582706441;12072.3360215189;12442.315672638091;11771.352575608424;11818.349990750246;11976.221545599508;12347.444365003417;12384.256944583354;11502.309861408343;11753.823692644788;11816.76366472683;11874.82187767167;12053.035757139232;10082.54628541732;10156.542955566869;10230.795384092426;10239.795204096024;10519.94740026295;9827.31208815376;10199.949000254952;10284.640037598649;10287.43419111926;10308.793824123626 14:59:03 INFO - PROCESS | 1670 | __end_tp_report 14:59:03 INFO - PROCESS | 1670 | __start_cc_report 14:59:03 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,360 14:59:03 INFO - PROCESS | 1670 | __end_cc_report 14:59:03 INFO - PROCESS | 1670 | __startTimestamp1463435943345__endTimestamp 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | ------- Summary: start ------- 14:59:03 INFO - PROCESS | 1670 | Number of tests: 6 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5870.76 Median:6173.69 stddev:652.90 (10.6%) stddev-sans-first:632.21 14:59:03 INFO - PROCESS | 1670 | Values: 3695.6 3708.2 3731.6 3780.6 3780.9 4862.1 5150.1 5686.2 6035.2 6083.5 4859.5 6004.9 6070.8 6087.4 6112.2 5350.8 5353.9 5406.8 5443.1 5503.6 4443.6 5270.3 5328.9 5392.5 5410.0 5379.4 5384.9 5396.8 5397.2 5425.1 5350.7 5382.9 5397.6 5517.3 5533.5 4399.0 5308.2 5457.9 5466.6 5494.4 5856.3 5957.3 6060.5 6106.1 6144.0 6170.0 6232.4 6287.3 6290.4 6302.8 5318.6 5753.0 6299.7 6313.3 6356.7 6002.8 6051.0 6100.6 6111.7 6127.8 5415.0 6479.0 6483.9 6487.7 6522.8 6264.3 6281.3 6283.3 6289.1 6327.4 6243.8 6292.2 6338.8 6341.9 6381.3 6238.3 6242.7 6264.7 6286.4 6291.4 6221.4 6285.4 6290.2 6299.7 6300.4 4930.9 4947.3 4961.7 4968.9 4996.3 4556.3 4571.8 4589.4 4602.0 4610.6 6040.2 6147.2 6173.7 6197.5 6215.0 6229.0 6298.4 6323.0 6379.3 6387.3 6173.5 6191.2 6198.3 6226.5 6238.6 5603.0 5610.4 5623.4 5624.8 5625.2 6399.9 6490.9 6546.5 6601.8 6613.8 6381.2 6389.9 6394.5 6409.6 6432.8 6363.7 6516.1 6601.4 6603.0 6610.2 6195.0 6241.0 6270.0 6293.6 6318.4 5249.3 6329.8 6332.2 6334.6 6336.1 5716.1 6262.7 6279.6 6281.1 6289.3 4814.4 4824.9 6246.8 6247.9 6273.5 6107.5 6134.3 6168.2 6168.7 6171.4 6170.1 6193.3 6244.5 6262.5 6268.5 6189.8 6243.5 6252.4 6259.6 6269.9 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:58871.71 Median:39508.41 stddev:117585.25 (297.6%) stddev-sans-first:117833.27 14:59:03 INFO - PROCESS | 1670 | Values: 442.3 497.8 591.5 614.7 660.3 39380.8 39955.8 40045.8 40110.6 40442.6 35978.8 43556.0 43660.0 43951.7 44270.8 9540.0 9742.7 9775.5 9797.9 9801.4 8676.8 9720.6 9756.9 9833.2 9894.6 9788.6 9873.3 9874.3 9888.2 9889.3 9820.5 9889.1 9909.0 9917.6 9918.0 9655.1 9819.3 9824.0 9836.3 9855.8 36213.8 40854.4 41084.6 41230.2 41408.6 3158.5 3346.5 3413.5 3494.6 3514.6 27144.9 27467.3 28204.9 28534.3 28767.4 2670.2 2739.8 2778.7 2794.0 2893.9 279614.0 342572.0 343823.0 344905.0 345952.3 48064.3 48079.5 48085.5 65285.0 66575.7 47617.0 47807.0 47812.0 47884.0 48166.5 13840.0 16938.2 17045.0 17060.4 17073.4 13475.9 13477.7 13647.9 13695.9 13711.9 15328.5 15449.9 15490.5 15495.2 15623.6 5866.7 5866.8 5883.3 5902.9 5906.3 931.0 1002.7 1065.8 1159.8 1235.5 27307.6 30135.8 30385.7 30814.5 30863.1 1134.8 1171.6 1233.3 1243.2 1302.5 15222.8 15635.3 15748.3 15794.4 15910.5 480305.0 515938.8 538211.0 546886.0 547190.0 62131.7 62441.7 62820.1 62822.0 62933.1 1361.7 1380.5 1536.9 1554.8 1591.2 29787.4 30629.8 30633.0 30761.2 30822.8 52343.5 52552.2 52714.7 53053.5 53092.0 415728.0 417479.0 422674.0 489513.0 490271.0 34339.3 34709.1 45634.5 45998.3 47403.8 44854.8 45073.8 45481.5 45511.3 45747.3 36273.3 37374.0 37458.6 37610.2 37977.8 36492.1 36568.0 36757.5 37021.8 37105.1 34998.3 38897.4 39636.0 40203.8 41182.4 32425.8 32614.0 33205.8 33571.7 34859.0 25441.0 25899.6 26215.5 26215.7 26497.2 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35622.22 Median:12353.11 stddev:100950.38 (817.2%) stddev-sans-first:101198.88 14:59:03 INFO - PROCESS | 1670 | Values: 378.2 379.1 382.5 386.6 387.4 20184.8 21808.7 22049.9 22711.2 22721.9 22285.4 22453.6 22688.2 22709.3 22727.8 5840.9 5842.3 6064.3 6119.6 6163.6 4175.2 5947.0 6166.3 6167.6 6188.8 5917.7 6078.0 6138.4 6145.3 6177.7 6086.1 6088.5 6106.8 6109.3 6118.8 4906.8 5443.7 5899.1 5900.5 5929.4 25647.0 25814.4 25928.4 26132.1 26262.5 2021.4 2192.9 2229.5 2233.4 2252.7 10065.4 15631.0 15784.2 16520.3 16850.9 1909.2 1924.0 1957.3 1965.6 2041.7 82863.0 131298.0 134477.0 134887.7 134896.0 19961.3 20402.8 20531.8 20585.9 20723.4 30505.5 30861.8 30894.5 30953.4 31578.1 11489.9 11595.3 11791.7 11792.9 11822.5 9205.9 9220.2 9948.3 10043.3 10051.2 9109.8 9195.2 9230.2 9236.8 9263.4 1903.3 1959.1 1984.5 1989.0 2018.0 924.4 960.4 1012.9 1048.5 1054.5 20561.1 20565.9 20830.8 21006.8 21071.1 982.2 991.0 1016.6 1025.7 1046.9 11044.6 11162.8 11228.0 11261.3 11271.1 504953.0 620273.0 631685.0 631980.0 645532.0 84614.2 111283.4 112351.0 112684.0 112947.0 1053.0 1054.3 1067.7 1073.1 1091.6 18113.5 18440.4 18613.9 18633.6 18777.9 35716.5 48944.8 49849.0 50429.7 50763.5 65394.3 67925.0 68094.3 68310.0 68899.0 8202.1 8245.1 8250.8 8390.4 8493.0 9549.1 11708.3 12979.7 13289.7 13328.5 11229.1 11363.5 11548.5 11558.0 11812.6 9283.6 10958.3 11216.7 11247.4 11588.6 9558.0 9929.6 11261.4 11402.8 11813.7 7161.6 7239.5 8214.8 8287.3 8338.0 10352.9 11809.6 11968.3 12054.8 12138.7 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6271.52 Median:548.47 stddev:3297.02 (601.1%) stddev-sans-first:3288.39 14:59:03 INFO - PROCESS | 1670 | Values: 1703.1 1713.1 1929.4 2092.6 2094.0 8390.4 9058.2 9120.2 9326.8 9340.7 9096.4 9113.2 9173.4 9181.8 9197.3 2584.4 2616.3 2619.5 2619.9 2621.7 2551.4 2581.1 2620.9 2622.1 2622.3 2573.8 2590.7 2611.3 2622.7 2637.3 2602.7 2615.9 2628.9 2635.7 2643.5 2552.6 2586.3 2587.5 2629.6 2638.2 9199.3 9237.0 9261.2 9269.4 9288.8 5637.0 5721.1 5753.6 5854.5 5875.1 3602.8 3756.1 3785.4 3804.6 3827.3 1018.2 1065.7 1075.3 1109.2 1121.7 12414.7 12435.4 12493.3 12516.2 12573.9 5048.0 5069.4 5165.7 5204.5 5214.8 10606.8 10660.3 10673.6 10682.5 10708.7 5697.1 5793.7 5799.4 5823.4 5885.6 4741.6 5064.6 5164.0 5165.0 5266.5 4029.9 4138.6 4169.5 4169.5 4183.9 1361.9 1364.4 1373.6 1381.6 1396.6 1162.2 1205.5 1233.8 1404.3 1454.8 8484.7 8576.7 8671.3 8688.6 8689.4 548.1 548.8 550.9 551.9 555.8 6344.4 6404.7 6434.0 6445.1 6445.5 9561.3 10939.1 11110.8 11164.2 11293.4 10746.3 10941.1 10965.6 11036.7 11256.1 8750.5 8789.5 8820.0 8842.6 8876.4 8004.8 8057.2 8170.3 8199.5 8200.4 9790.0 9963.6 10080.1 10144.2 10148.3 8315.5 9762.4 10009.6 10121.9 10584.4 6558.3 7683.3 7711.9 7887.0 7901.9 7718.0 7722.7 7798.2 7824.8 7859.6 7535.1 7667.0 7754.7 7800.6 7856.3 7575.4 7637.1 7653.7 7691.7 7759.5 6853.3 7515.9 7729.2 7822.8 7853.8 7151.9 7338.1 7360.6 7371.8 7411.8 7062.1 7069.2 7070.9 7078.8 7091.0 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5997.45 Median:6866.71 stddev:1942.09 (28.3%) stddev-sans-first:1900.54 14:59:03 INFO - PROCESS | 1670 | Values: 339.7 342.8 343.1 345.5 350.7 6847.6 6916.3 6993.8 7007.4 7060.3 6859.6 6910.9 6922.4 6924.5 6945.7 4762.9 4893.0 5021.4 5026.0 5092.5 4026.4 4991.2 5012.7 5016.7 5032.7 4997.2 4997.6 5005.8 5047.5 5062.6 5043.8 5047.8 5051.5 5061.5 5071.1 4344.9 4346.9 4349.1 4358.0 4368.8 6324.9 6601.8 6682.5 6682.6 6701.8 5850.3 5894.8 5903.1 5903.2 5923.1 7390.4 7390.4 7399.4 7401.9 7407.1 4095.3 4635.1 4726.2 4751.6 4757.7 7713.3 7737.2 7751.3 7805.2 7808.7 4147.3 4252.0 4791.1 4828.6 4849.4 4902.2 4915.6 4929.5 4945.9 4968.0 5888.7 5903.6 5906.9 5912.7 5939.5 7314.0 7360.5 7399.7 7402.4 7426.8 1387.6 1711.2 1711.5 1711.6 1712.3 1036.0 1079.3 1079.9 1089.3 1099.3 6105.2 6346.9 6894.6 6930.1 6986.9 7446.8 7563.5 7571.3 7586.8 7618.8 6000.6 6939.9 7110.8 7145.4 7176.2 4037.5 4089.2 4102.4 4103.1 4117.3 8070.1 8077.8 8097.5 8105.0 8122.7 7722.9 7854.1 7989.3 7992.3 8013.9 6472.6 8080.2 8103.6 8106.4 8133.7 6096.4 7758.3 7764.3 7770.5 7800.6 6598.6 7081.2 7550.1 7567.2 7606.0 6581.5 7483.3 7775.9 8004.1 8076.6 4788.7 4824.1 4844.9 4850.8 4863.9 7644.1 7655.5 7675.7 7681.0 7681.8 7377.1 7393.9 7396.0 7416.9 7433.6 5890.6 7333.8 7383.4 7386.0 7425.8 7169.0 7194.5 7199.5 7209.3 7242.8 6423.4 6873.9 7376.0 7376.7 7415.3 6930.5 7201.0 7209.3 7209.9 7251.3 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18841.45 Median:4118.73 stddev:26359.38 (640.0%) stddev-sans-first:26398.12 14:59:03 INFO - PROCESS | 1670 | Values: 700.4 707.7 727.8 775.2 813.4 15380.0 15510.5 15637.6 15684.9 15754.2 14611.5 14666.1 14676.8 14680.0 14691.8 820.6 968.9 987.4 1009.2 1011.8 947.1 966.2 985.0 991.6 998.1 1008.5 1011.1 1012.1 1067.6 1069.3 1034.0 1042.7 1051.2 1059.0 1063.0 751.2 765.4 771.4 781.9 790.1 15015.0 15038.2 15134.7 15141.9 15186.9 13398.6 13406.2 13418.9 13536.8 13541.7 10120.5 10133.7 10167.9 10237.1 10446.3 3482.4 3511.0 3518.6 3576.3 3600.0 85319.0 86041.0 86065.7 86236.0 86301.6 9721.3 9753.5 9763.0 9802.4 9926.2 22942.3 23678.0 23688.8 23718.9 24104.6 7438.7 7553.2 7581.9 7615.2 7915.6 4072.1 4144.3 4205.5 4213.0 4338.3 3738.8 3759.6 3762.6 3768.0 3785.5 715.9 724.2 728.4 733.0 740.0 525.6 538.1 589.0 621.4 636.3 8185.9 8435.9 8477.2 8503.2 8585.1 608.6 620.3 623.3 623.7 629.4 3364.8 3940.9 4078.4 4093.2 4145.2 55675.7 80714.0 95408.5 96751.5 97493.0 85057.6 86447.6 86673.6 87086.1 87594.0 49428.0 66652.3 69369.7 69678.0 70044.3 7664.8 7819.7 8166.3 8291.8 8467.7 51423.0 51860.0 51947.7 53457.7 54001.5 69862.7 73686.0 73918.3 74411.0 74958.6 11129.7 11298.4 11371.5 11496.9 12155.4 11910.2 12215.1 12262.2 12423.4 12631.7 11745.2 11815.2 12027.8 12072.3 12442.3 11771.4 11818.3 11976.2 12347.4 12384.3 11502.3 11753.8 11816.8 11874.8 12053.0 10082.5 10156.5 10230.8 10239.8 10519.9 9827.3 10199.9 10284.6 10287.4 10308.8 14:59:03 INFO - PROCESS | 1670 | -------- Summary: end -------- 14:59:03 INFO - PROCESS | 1670 | 14:59:03 INFO - TEST-INFO | 1670: exit 0 14:59:03 INFO - TEST-OK | dromaeo_css | took 1110410ms 14:59:03 INFO - TEST-START | kraken 14:59:03 INFO - operating with platform_type : mac_ 14:59:03 INFO - Initialising browser for kraken test... 14:59:03 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpg8a13V/profile http://localhost:49272/getInfo.html) 14:59:06 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 14:59:06 INFO - PROCESS | 1679 | colorDepth:24 14:59:06 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 14:59:06 INFO - PROCESS | 1679 | __metrics 14:59:06 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 14:59:07 INFO - TEST-INFO | 1679: exit 0 14:59:07 INFO - Browser initialized. 14:59:07 INFO - Running cycle 1/1 for kraken test... 14:59:07 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/T/tmpg8a13V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:19 INFO - PROCESS | 1683 | RSS: Main: 168099840 14:59:19 INFO - PROCESS | 1683 | 14:59:21 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:22 INFO - PROCESS | 1683 | RSS: Main: 180109312 14:59:22 INFO - PROCESS | 1683 | 14:59:24 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 14:59:25 INFO - PROCESS | 1683 | RSS: Main: 188985344 14:59:25 INFO - PROCESS | 1683 | 14:59:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 14:59:29 INFO - PROCESS | 1683 | RSS: Main: 192950272 14:59:29 INFO - PROCESS | 1683 | 14:59:31 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 14:59:32 INFO - PROCESS | 1683 | RSS: Main: 193925120 14:59:32 INFO - PROCESS | 1683 | 14:59:34 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:34 INFO - PROCESS | 1683 | RSS: Main: 193646592 14:59:34 INFO - PROCESS | 1683 | 14:59:37 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:38 INFO - PROCESS | 1683 | RSS: Main: 194228224 14:59:38 INFO - PROCESS | 1683 | 14:59:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:41 INFO - PROCESS | 1683 | RSS: Main: 194199552 14:59:41 INFO - PROCESS | 1683 | 14:59:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 14:59:44 INFO - PROCESS | 1683 | RSS: Main: 194158592 14:59:44 INFO - PROCESS | 1683 | 14:59:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:46 INFO - PROCESS | 1683 | RSS: Main: 194662400 14:59:46 INFO - PROCESS | 1683 | 14:59:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:49 INFO - PROCESS | 1683 | RSS: Main: 194732032 14:59:49 INFO - PROCESS | 1683 | 14:59:51 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:52 INFO - PROCESS | 1683 | RSS: Main: 194949120 14:59:52 INFO - PROCESS | 1683 | 14:59:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:55 INFO - PROCESS | 1683 | RSS: Main: 194949120 14:59:55 INFO - PROCESS | 1683 | 14:59:57 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:58 INFO - PROCESS | 1683 | RSS: Main: 194469888 14:59:58 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 15:00:00 INFO - PROCESS | 1683 | RSS: Main: 196026368 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | __start_tp_report 15:00:00 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 15:00:00 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 15:00:00 INFO - PROCESS | 1683 | |i|pagename|runs| 15:00:00 INFO - PROCESS | 1683 | |0;ai-astar;115;111;114;115;117;129;114;114;114;115 15:00:00 INFO - PROCESS | 1683 | |1;audio-beat-detection;150;117;141;149;119;153;152;184;162;118 15:00:00 INFO - PROCESS | 1683 | |2;audio-dft;199;200;197;196;201;198;200;198;201;201 15:00:00 INFO - PROCESS | 1683 | |3;audio-fft;73;83;105;159;52;83;82;76;148;85 15:00:00 INFO - PROCESS | 1683 | |4;audio-oscillator;88;96;158;116;87;80;116;82;79;116 15:00:00 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;87;130;87;89;85;90;87;89;86 15:00:00 INFO - PROCESS | 1683 | |6;imaging-darkroom;94;95;95;95;96;95;95;95;94;94 15:00:00 INFO - PROCESS | 1683 | |7;imaging-desaturate;92;92;89;96;95;91;93;99;90;90 15:00:00 INFO - PROCESS | 1683 | |8;json-parse-financial;55;59;57;59;59;60;57;59;55;57 15:00:00 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;62;66;70;66;65;71;70;67;64;66 15:00:00 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;70;98;99;103;106;82;85;80;85;85 15:00:00 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;118;119;129;129;136;111;129;120;133;119 15:00:00 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;126;135;139;134;135;135;146;134;131;125 15:00:00 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;66;94;100;86;67;67;77;95;92;82 15:00:00 INFO - PROCESS | 1683 | __end_tp_report 15:00:00 INFO - PROCESS | 1683 | __start_cc_report 15:00:00 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,920 15:00:00 INFO - PROCESS | 1683 | __end_cc_report 15:00:00 INFO - PROCESS | 1683 | __startTimestamp1463436000278__endTimestamp 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | ------- Summary: start ------- 15:00:00 INFO - PROCESS | 1683 | Number of tests: 14 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:115.80 Median:115.00 stddev:4.87 (4.2%) stddev-sans-first:5.16 15:00:00 INFO - PROCESS | 1683 | Values: 115.0 111.0 114.0 115.0 117.0 129.0 114.0 114.0 114.0 115.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.00 stddev:21.52 (14.2%) stddev-sans-first:22.73 15:00:00 INFO - PROCESS | 1683 | Values: 150.0 117.0 141.0 149.0 119.0 153.0 152.0 184.0 162.0 118.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:199.10 Median:200.00 stddev:1.79 (0.9%) stddev-sans-first:1.90 15:00:00 INFO - PROCESS | 1683 | Values: 199.0 200.0 197.0 196.0 201.0 198.0 200.0 198.0 201.0 201.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:94.60 Median:79.00 stddev:33.75 (42.7%) stddev-sans-first:34.89 15:00:00 INFO - PROCESS | 1683 | Values: 73.0 83.0 105.0 159.0 52.0 83.0 82.0 76.0 148.0 85.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:81.00 stddev:24.93 (30.8%) stddev-sans-first:25.94 15:00:00 INFO - PROCESS | 1683 | Values: 88.0 96.0 158.0 116.0 87.0 80.0 116.0 82.0 79.0 116.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.00 stddev:13.48 (15.3%) stddev-sans-first:14.25 15:00:00 INFO - PROCESS | 1683 | Values: 89.0 87.0 130.0 87.0 89.0 85.0 90.0 87.0 89.0 86.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:00:00 INFO - PROCESS | 1683 | Values: 94.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 94.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:92.50 stddev:3.13 (3.4%) stddev-sans-first:3.31 15:00:00 INFO - PROCESS | 1683 | Values: 92.0 92.0 89.0 96.0 95.0 91.0 93.0 99.0 90.0 90.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:1.77 (3.0%) stddev-sans-first:1.58 15:00:00 INFO - PROCESS | 1683 | Values: 55.0 59.0 57.0 59.0 59.0 60.0 57.0 59.0 55.0 57.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:2.87 (4.3%) stddev-sans-first:2.49 15:00:00 INFO - PROCESS | 1683 | Values: 62.0 66.0 70.0 66.0 65.0 71.0 70.0 67.0 64.0 66.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:85.00 stddev:11.57 (13.6%) stddev-sans-first:9.94 15:00:00 INFO - PROCESS | 1683 | Values: 70.0 98.0 99.0 103.0 106.0 82.0 85.0 80.0 85.0 85.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:129.00 stddev:7.96 (6.2%) stddev-sans-first:8.11 15:00:00 INFO - PROCESS | 1683 | Values: 118.0 119.0 129.0 129.0 136.0 111.0 129.0 120.0 133.0 119.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.00 Median:135.00 stddev:6.02 (4.5%) stddev-sans-first:5.64 15:00:00 INFO - PROCESS | 1683 | Values: 126.0 135.0 139.0 134.0 135.0 135.0 146.0 134.0 131.0 125.0 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.60 Median:84.00 stddev:12.83 (15.3%) stddev-sans-first:12.12 15:00:00 INFO - PROCESS | 1683 | Values: 66.0 94.0 100.0 86.0 67.0 67.0 77.0 95.0 92.0 82.0 15:00:00 INFO - PROCESS | 1683 | -------- Summary: end -------- 15:00:00 INFO - PROCESS | 1683 | 15:00:00 INFO - TEST-INFO | 1683: exit 0 15:00:00 INFO - TEST-OK | kraken | took 57057ms 15:00:00 INFO - SUITE-END | took 1167s 15:00:01 INFO - Completed test suite (00:19:27) 15:00:01 INFO - javascript benchmark 15:00:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3695.648913353232, 3708.1656627258853, 3731.626837316267, 3780.5841357450677, 3780.8676696315633, 4862.124817532847, 5150.072986862373, 5686.20393144959, 6035.245594300713, 6083.482903953164, 4859.514048595139, 6004.909926351097, 6070.757169713206, 6087.39126087391, 6112.235970503687, 5350.785968561253, 5353.892922141555, 5406.756695948692, 5443.074677304848, 5503.587230957674, 4443.622292105175, 5270.341207349082, 5328.92006619901, 5392.460753924615, 5409.972950135244, 5379.435159308275, 5384.91922621161, 5396.757145928423, 5397.163439666839, 5425.077736784737, 5350.678959262456, 5382.946170538303, 5397.595180361489, 5517.2551705519645, 5533.474319939599, 4398.978005109986, 5308.230306605559, 5457.890842183134, 5466.644668096561, 5494.36814766303, 5856.32652244993, 5957.314908785458, 6060.454559089703, 6106.053561697944, 6144.047672610708, 6170.0, 6232.421982325838, 6287.276963149251, 6290.4024117709205, 6302.842428939267, 5318.574514038906, 5752.964466396047, 6299.65351905645, 6313.305536390993, 6356.745730170787, 6002.819915402589, 6050.969745151246, 6100.633961962252, 6111.655435804116, 6127.754889804447, 5415.009307827053, 6479.028145778171, 6483.870322593616, 6487.675616219264, 6522.771702990467, 6264.342244064308, 6281.309056003836, 6283.3088360280335, 6289.119523266746, 6327.367263273636, 6243.8126856194385, 6292.2134733158355, 6338.809835704937, 6341.936580634227, 6381.298057213703, 6238.282597501255, 6242.719077641426, 6264.718087686065, 6286.371362863769, 6291.402316779899, 6221.3778622138325, 6285.371462853678, 6290.245170579468, 6299.748010079546, 6300.401461861115, 4930.91519865629, 4947.25791131326, 4961.7271050092595, 4968.8757781055765, 4996.275540046673, 4556.2937744649635, 4571.794269257892, 4589.449266088091, 4602.0, 4610.631149508032, 6040.184575082308, 6147.231596050494, 6173.69131543421, 6197.4732147767945, 6215.005599104122, 6228.968855155786, 6298.370162983665, 6323.019931910561, 6379.298277189506, 6387.297397286295, 6173.47525460332, 6191.164192834, 6198.256209254918, 6226.501879849601, 6238.594491358047, 5603.0, 5610.410906854803, 5623.353314368818, 5624.831255062355, 5625.156226566048, 6399.9040014399825, 6490.935090649127, 6546.509011824228, 6601.76893808724, 6613.801585952429, 6381.202349706286, 6389.904151437825, 6394.520410969289, 6409.551331406943, 6432.839179020375, 6363.745450181941, 6516.087747715229, 6601.405873471411, 6602.966985165043, 6610.2398224204835, 6195.0, 6241.001439769615, 6269.96865015672, 6293.55945083858, 6318.399752023551, 5249.317588713443, 6329.841753956004, 6332.176817013758, 6334.619922804646, 6336.112944187726, 5716.114002329646, 6262.686865656608, 6279.591826531444, 6281.057841323838, 6289.308176100717, 4814.398200224972, 4824.903501930012, 6246.781362652286, 6247.906281405873, 6273.466755325849, 6107.450329470369, 6134.294556126102, 6168.19813424252, 6168.691565421621, 6171.352008039091, 6170.136180934763, 6193.349698281616, 6244.531660125418, 6262.4990000800735, 6268.4671802897265, 6189.783357582463, 6243.500519958483, 6252.437280644582, 6259.593126446948, 6269.937300626935], "unit": "score", "name": "dojo.html", "value": 5834.949983204349}, {"lowerIsBetter": false, "replicates": [442.33870363806113, 497.79341573247103, 591.4558606082404, 614.7295190116348, 660.3165723476202, 39380.80309598451, 39955.800220998855, 40045.79862604119, 40110.598894011055, 40442.595574044215, 35978.8201058995, 43556.0, 43660.0, 43951.68144955656, 44270.7786461068, 9539.999999999982, 9742.659006934759, 9775.462349570771, 9797.90202097977, 9801.431770916655, 8676.783080422976, 9720.562574684122, 9756.902430975706, 9833.213342932584, 9894.604215831358, 9788.55951482185, 9873.308868379216, 9874.308798384116, 9888.208943284555, 9889.307748457612, 9820.50897455128, 9889.10998010179, 9909.0, 9917.553710083064, 9918.008199180096, 9655.131038206526, 9819.263555233387, 9824.0, 9836.31145819793, 9855.753606159831, 36213.81893090544, 40854.38718419226, 41084.589154108675, 41230.1753964922, 41408.58591414077, 3158.510430883217, 3346.531485592019, 3413.5050417689295, 3494.5631796025496, 3514.595821480537, 27144.864275678694, 27467.31331716703, 28204.858975705196, 28534.28664283389, 28767.424651507063, 2670.185593394014, 2739.821911575741, 2778.7221277872254, 2794.02209226769, 2893.8842446302124, 279614.0, 342572.0, 343823.0, 344905.0, 345952.27023864974, 48064.27903581449, 48079.519204807504, 48085.5191448088, 65285.0, 66575.66712166506, 47617.0, 47807.04385912262, 47812.0, 47884.0, 48166.5183348162, 13839.962002849625, 16938.23777929996, 17044.97730136196, 17060.402885898933, 17073.40243091486, 13475.865241347658, 13477.663058423423, 13647.931760341135, 13695.86304136946, 13711.931440342934, 15328.540143795704, 15449.9227503864, 15490.457833975757, 15495.225238738018, 15623.609409764847, 5866.7066646668345, 5866.8266346730825, 5883.3234178069215, 5902.911456328158, 5906.291245050621, 930.9627614895463, 1002.711515702319, 1065.81881080215, 1159.8492196014633, 1235.5057976809348, 27307.590386144224, 30135.849320753256, 30385.696143038727, 30814.53778193329, 30863.074107776803, 1134.8127558952845, 1171.5957994491887, 1233.2538814017569, 1243.1981372015, 1302.4594793160732, 15222.771658425132, 15635.296411661502, 15748.291326890318, 15794.36822527109, 15910.522684319489, 480305.0, 515938.8406115966, 538211.0, 546886.0, 547190.0, 62131.689341553, 62441.687791560755, 62820.05769913455, 62822.0, 62933.056004159975, 1361.6868120332379, 1380.4892189889806, 1536.861682448585, 1554.8056492938383, 1591.1884938681355, 29787.404251915275, 30629.846850765603, 30633.00885442439, 30761.230969225948, 30822.767089316178, 52343.47656523538, 52552.21171682504, 52714.73642631762, 53053.46946530485, 53092.0, 415728.0, 417479.0, 422674.0, 489513.0, 490271.0, 34339.31321373609, 34709.13227169341, 45634.54365456303, 45998.310025350314, 47403.762981184875, 44854.77572612116, 45073.77463112663, 45481.54518454773, 45511.31733024074, 45747.31379029251, 36273.27453450969, 37374.0, 37458.62541374551, 37610.247795044495, 37977.81011094927, 36492.0876978067, 36568.0, 36757.52969881175, 37021.81489092537, 37105.14474276221, 34998.30003399969, 38897.416538752506, 39636.00909977274, 40203.79388618346, 41182.38226426666, 32425.83787081144, 32614.0, 33205.83397082999, 33571.66428335783, 34859.0, 25441.0, 25899.61150582705, 26215.475690485702, 26215.737842622093, 26497.205083847515], "unit": "score", "name": "ext.html", "value": 19550.822922898707}, {"lowerIsBetter": false, "replicates": [378.19821977407884, 379.1090936299696, 382.5180272856201, 386.58442174662247, 387.4324115171274, 20184.798152018495, 21808.672869906964, 22049.889750551243, 22711.20510782125, 22721.863906804676, 22285.44286392841, 22453.55092898141, 22688.205912793055, 22709.318720438372, 22727.772722272774, 5840.883182336351, 5842.32813226478, 6064.272287325527, 6119.602225855305, 6163.599366041193, 4175.248455278049, 5947.01874190758, 6166.321704612489, 6167.62994220346, 6188.81433556994, 5917.704114794265, 6077.969610151943, 6138.355472675372, 6145.324014358417, 6177.691115444232, 6086.147939288503, 6088.543359248052, 6106.786262480814, 6109.297430795471, 6118.755249790003, 4906.828261010884, 5443.700596467193, 5899.056151015817, 5900.468957793819, 5929.377415371367, 25647.0, 25814.354641134123, 25928.351791205183, 26132.085377011714, 26262.474750504884, 2021.433998480413, 2192.901319440629, 2229.4649284171846, 2233.3969828146473, 2252.662100684894, 10065.396076235449, 15631.0, 15784.210789460596, 16520.339186432528, 16850.915745421316, 1909.2458478900755, 1924.018750437287, 1957.3051566693762, 1965.6461836869357, 2041.6529190037581, 82863.0, 131298.0, 134476.98284525838, 134887.6511234895, 134896.0, 19961.301354452524, 20402.795972040385, 20531.794682053285, 20585.89707051455, 20723.378298651063, 30505.542416863766, 30861.84569077185, 30894.536581951288, 30953.380932381675, 31578.052658420285, 11489.942550287195, 11595.304281743123, 11791.705207369885, 11792.938635522843, 11822.52709891612, 9205.907940920639, 9220.216281616003, 9948.253880958957, 10043.296969212084, 10051.24615653829, 9109.81780364389, 9195.218406435528, 9230.215431688248, 9236.769080773034, 9263.444193348421, 1903.3433465454395, 1959.1281879563458, 1984.5435549823621, 1988.9502762431055, 2018.0111745244724, 924.4453328003278, 960.4333443268505, 1012.9240306977006, 1048.4967215736337, 1054.5096530113533, 20561.140075078532, 20565.897170514352, 20830.79169208319, 21006.789932100484, 21071.051802668917, 982.1602529837029, 990.9653162139291, 1016.5527168046036, 1025.6512785652915, 1046.8796088449774, 11044.558217671363, 11162.832557511643, 11227.989480946591, 11261.268017578832, 11271.098312135173, 504953.0, 620273.0, 631685.0, 631980.0, 645532.0, 84614.15385846185, 111283.44358278156, 112351.0, 112684.0, 112947.0, 1052.9943903572223, 1054.335768465877, 1067.685032915292, 1073.0878753059992, 1091.6070214722693, 18113.45659630213, 18440.446786596425, 18613.906930465262, 18633.627327453647, 18777.90611046936, 35716.46425303674, 48944.75527622339, 49849.0, 50429.74785126198, 50763.49236507588, 65394.34605653882, 67924.98112528415, 68094.3190568088, 68309.97535037078, 68899.0, 8202.138775428493, 8245.134260902758, 8250.793730156794, 8390.370722195981, 8493.023302320313, 9549.09283618055, 11708.297502149899, 12979.740405192033, 13289.66775830612, 13328.533501327795, 11229.101671866069, 11363.488643010918, 11548.538058477567, 11558.0, 11812.586559470377, 9283.582238799136, 10958.287711299059, 11216.66350009501, 11247.381394023407, 11588.594399195988, 9558.0, 9929.553170107507, 11261.380624065427, 11402.82895756581, 11813.70465738329, 7161.606111663908, 7239.457040721862, 8214.753557393287, 8287.295579875778, 8338.0, 10352.896471035194, 11809.586664466702, 11968.281903085843, 12054.819177712166, 12138.696532586757], "unit": "score", "name": "jquery.html", "value": 10421.209837918635}, {"lowerIsBetter": false, "replicates": [1703.1484257871064, 1713.1348668922196, 1929.3633101076646, 2092.587503435182, 2094.0, 8390.370722195828, 9058.23005044572, 9120.224780893624, 9326.766830829232, 9340.71977840665, 9096.363254572183, 9113.179813816756, 9173.403728757643, 9181.77045573861, 9197.31020173488, 2584.4185058361904, 2616.293600727802, 2619.4630100829286, 2619.882105305256, 2621.685397752263, 2551.400420901087, 2581.070814506776, 2620.9254205775637, 2622.1215892675978, 2622.252657992463, 2573.7554932281496, 2590.6632137822057, 2611.281897478199, 2622.72461391554, 2637.3406648337914, 2602.726713695063, 2615.921522354323, 2628.907988220413, 2635.736426357368, 2643.510950474149, 2552.5788244939563, 2586.2887705880844, 2587.5083734090463, 2629.5529759940855, 2638.1557901471538, 9199.310051746146, 9236.9839317675, 9261.16649501548, 9269.351145419823, 9288.767780805467, 5636.971815140939, 5721.056025755745, 5753.568482363798, 5854.47309742121, 5875.148103525008, 3602.765820221677, 3756.1360886996144, 3785.356489396809, 3804.619538046173, 3827.311084004878, 1018.2464975917842, 1065.733566608348, 1075.295681328731, 1109.1514991031868, 1121.6578943422253, 12414.689632759162, 12435.44040518179, 12493.312867792269, 12516.249025058525, 12573.874261257362, 5048.0, 5069.391672999263, 5165.715885626327, 5204.531592156724, 5214.7914083436235, 10606.840897386546, 10660.307080039773, 10673.62642307531, 10682.51928663212, 10708.678739637824, 5697.145428185805, 5793.7392817323325, 5799.3620701722775, 5823.359430462646, 5885.61743486672, 4741.644376671695, 5064.620153488503, 5164.04465173944, 5165.0, 5266.473352664703, 4029.852960814331, 4138.6482149017065, 4169.478815148106, 4169.520505141887, 4183.91632167355, 1361.8910487161004, 1364.3968337203746, 1373.6085215713474, 1381.550995926328, 1396.5880065380736, 1162.2329262686587, 1205.5479195301762, 1233.784087784634, 1404.3399602186955, 1454.8399676035629, 8484.703035393855, 8576.742697719079, 8671.306295496472, 8688.609012594323, 8689.435186712843, 548.1144861675822, 548.8298627425511, 550.9421510741395, 551.9089350257243, 555.7971340460783, 6344.365563443619, 6404.7117879695525, 6434.034894765729, 6445.097686323918, 6445.516586255956, 9561.282903782245, 10939.12487001038, 11110.833337499944, 11164.162687798447, 11293.378864162385, 10746.301490403099, 10941.12471002318, 10965.61620343284, 11036.724081898017, 11256.099512039018, 8750.47497150173, 8789.472631642122, 8820.029796722227, 8842.646294148162, 8876.378653494194, 8004.759857204293, 8057.153998830038, 8170.264676179172, 8199.549024803693, 8200.42597018203, 9790.0, 9963.601455941971, 10080.092791648494, 10144.239182061227, 10148.340357876714, 8315.459495132796, 9762.414255144715, 10009.649662261785, 10121.949390253001, 10584.36493810343, 6558.311377305505, 7683.308502234826, 7711.884321735066, 7887.0, 7901.881471778043, 7717.961410192913, 7722.729704460542, 7798.220177982384, 7824.804379890548, 7859.60701964888, 7535.095788505414, 7667.0416197975255, 7754.6898124074405, 7800.6099695016155, 7856.25365590268, 7575.431842611716, 7637.083549974039, 7653.6938522460705, 7691.653875575725, 7759.456838021284, 6853.280405557344, 7515.910193021872, 7729.227077292226, 7822.804429889298, 7853.842923141619, 7151.892721609284, 7338.082739657543, 7360.595167265852, 7371.815704607213, 7411.777646670608, 7062.081929349151, 7069.187043490065, 7070.929290707027, 7078.787636370917, 7091.0], "unit": "score", "name": "mootools.html", "value": 5052.548010906419}, {"lowerIsBetter": false, "replicates": [339.65864306372094, 342.8165931226794, 343.0651474731357, 345.51627721190346, 350.6738732978331, 6847.554908930929, 6916.2737912519215, 6993.790186294413, 7007.369336759691, 7060.258672839349, 6859.554128981613, 6910.896336554943, 6922.4462043036565, 6924.549904256232, 6945.687444065016, 4762.904741905159, 4893.0, 5021.397432308128, 5025.974870125644, 5092.465291144423, 4026.4161696553983, 4991.151504244287, 5012.72430016349, 5016.749162541876, 5032.723200223986, 4997.225430058329, 4997.625178111638, 5005.799768009275, 5047.520485553867, 5062.620303477235, 5043.773030213649, 5047.823326183584, 5051.5201055899815, 5061.468545802674, 5071.112555302844, 4344.9348259776125, 4346.8913277168, 4349.108432771274, 4357.954091018165, 4368.847090351823, 6324.9051264231075, 6601.768938087144, 6682.465402767767, 6682.565633233824, 6701.765438209639, 5850.297964244275, 5894.793682221145, 5903.085021821625, 5903.232579764646, 5923.052311630162, 7390.408767298603, 7390.445716571278, 7399.3710534604625, 7401.925980740178, 7407.074115735533, 4095.3242714952, 4635.142498637762, 4726.196546587088, 4751.619870410359, 4757.738324392157, 7713.305802477804, 7737.187595302525, 7751.3411360035025, 7805.1804560520895, 7808.726694565719, 4147.253494370982, 4252.043290259729, 4791.149266186613, 4828.61371090312, 4849.442314133919, 4902.2156454967035, 4915.557599815962, 4929.482404347564, 4945.901081978341, 4967.950320496821, 5888.705564721832, 5903.58674892762, 5906.852328691817, 5912.733926973297, 5939.524838012949, 7314.0, 7360.521566098187, 7399.6670149843385, 7402.444816638774, 7426.814329641694, 1387.6322774464775, 1711.2128420926265, 1711.5293294343905, 1711.606330543957, 1712.315073970397, 1035.984460233097, 1079.2768844873954, 1079.9406032668278, 1089.2810744908322, 1099.2799716185912, 6105.236845394325, 6346.904796428057, 6894.586324820427, 6930.099087118743, 6986.93013069873, 7446.813829654302, 7563.470557061063, 7571.318581327707, 7586.848263034708, 7618.771436856903, 6000.639961602318, 6939.93060069403, 7110.786676399716, 7145.392641625416, 7176.210616832144, 4037.5154981401834, 4089.2230476209425, 4102.446169767103, 4103.117829666636, 4117.341225403921, 8070.112287648354, 8077.798055048671, 8097.514149151069, 8104.959475202586, 8122.675092996214, 7722.92277077222, 7854.096778870503, 7989.320907722792, 7992.280694737501, 8013.919860801318, 6472.644004579794, 8080.232377924088, 8103.594820258963, 8106.351491880635, 8133.674653013932, 6096.390360964046, 7758.340541054074, 7764.340031097194, 7770.494917830323, 7800.570968596781, 6598.581305019444, 7081.221065682667, 7550.093988721389, 7567.167611562613, 7606.0, 6581.473482121514, 7483.32650061497, 7775.883361749691, 8004.119546849958, 8076.636551355321, 4788.664793464424, 4824.107540105092, 4844.85084694937, 4850.757462126809, 4863.927041094457, 7644.0827100748265, 7655.540667559964, 7675.692972281269, 7680.963069985704, 7681.846363072819, 7377.114746230487, 7393.889091663522, 7395.963020184865, 7416.8887466686965, 7433.553986760811, 5890.558208134493, 7333.826587745935, 7383.446241531799, 7385.9630701846145, 7425.777226683208, 7169.0, 7194.532355396883, 7199.532030418216, 7209.279072092749, 7242.818929526804, 6423.389777971085, 6873.865812140941, 7375.963120184365, 7376.668049937873, 7415.258474152542, 6930.5148639594745, 7201.0, 7209.279072092749, 7209.855802883808, 7251.347378735939], "unit": "score", "name": "prototype.html", "value": 5345.938600943071}, {"lowerIsBetter": false, "replicates": [700.3801635552535, 707.6956908529334, 727.8435136445664, 775.2054144501885, 813.3574476163831, 15380.0, 15510.534683959471, 15637.609059773511, 15684.921575392107, 15754.212289385528, 14611.488597899075, 14666.12003279804, 14676.779848302283, 14679.97240193187, 14691.77962330566, 820.5897051474263, 968.9176420004308, 987.4470296633872, 1009.1825621246777, 1011.8414415494254, 947.0576776107782, 966.1739212972913, 985.0445068283789, 991.5785791038816, 998.0817647764038, 1008.495752123938, 1011.0849681038671, 1012.1093437774784, 1067.6049861551237, 1069.3316677076828, 1033.9948300258488, 1042.7393151712072, 1051.2378525568977, 1058.9622170273099, 1062.9954692815293, 751.1924680967927, 765.3685709289858, 771.3559178086305, 781.8788087846393, 790.0795573157264, 15015.0, 15038.248087595577, 15134.697306053817, 15141.924290378478, 15186.924065379713, 13398.598042058753, 13406.195628262336, 13418.865811341957, 13536.796948045787, 13541.729165416735, 10120.544575494121, 10133.695989120339, 10167.898321016843, 10237.078662920372, 10446.320989135682, 3482.4428091505238, 3511.0344655219765, 3518.6305437928904, 3576.3204991051875, 3600.027992442026, 85319.0, 86041.0, 86065.70901436484, 86236.0, 86301.56849215776, 9721.319507634538, 9753.463559504153, 9763.02369763018, 9802.36284641496, 9926.2059035277, 22942.311730648107, 23678.0, 23688.763112369, 23718.93264803088, 24104.638430423558, 7438.66526006331, 7553.206913274027, 7581.924180758232, 7615.16233214346, 7915.564643944638, 4072.144849581621, 4144.295469770146, 4205.537390887, 4212.957870421256, 4338.34924761282, 3738.756980796294, 3759.605241449663, 3762.6237376262156, 3767.962320376816, 3785.470034195215, 715.9296851207478, 724.2033762860812, 728.4391018915405, 733.0, 740.0416460683427, 525.6478159633054, 538.0530266730582, 588.9734961926638, 621.4438077920236, 636.3064259956669, 8185.918140818516, 8435.903332566728, 8477.23704866565, 8503.1921967413, 8585.055643879168, 608.6256951974503, 620.2649859915924, 623.2583225961092, 623.6538721009792, 629.351767679291, 3364.7812892161933, 3940.8817735467983, 4078.408630748525, 4093.16090201508, 4145.233131870614, 55675.72162139245, 80714.0, 95408.52295738478, 96751.54872676915, 97493.02506974981, 85057.57471212605, 86447.56776216204, 86673.56663216643, 87086.12913870908, 87594.0, 49428.0, 66652.33347666558, 69369.65315173392, 69678.0, 70044.2995570048, 7664.770056898302, 7819.687212511436, 8166.265036146775, 8291.83416331682, 8467.661293548435, 51423.0, 51859.96280074302, 51947.74026129845, 53457.7327113362, 54001.45998540121, 69862.65068674624, 73686.0, 73918.26081739328, 74411.0, 74958.62520687362, 11129.666110016713, 11298.435078246219, 11371.488283027118, 11496.90779375958, 12155.392230388268, 11910.225835320676, 12215.144939854481, 12262.20295680778, 12423.378831058591, 12631.684207894508, 11745.236559623598, 11815.172937894265, 12027.819582706441, 12072.3360215189, 12442.315672638091, 11771.352575608424, 11818.349990750246, 11976.221545599508, 12347.444365003417, 12384.256944583354, 11502.309861408343, 11753.823692644788, 11816.76366472683, 11874.82187767167, 12053.035757139232, 10082.54628541732, 10156.542955566869, 10230.795384092426, 10239.795204096024, 10519.94740026295, 9827.31208815376, 10199.949000254952, 10284.640037598649, 10287.43419111926, 10308.793824123626], "unit": "score", "name": "yui.html", "value": 7213.048912900337}], "name": "dromaeo_css", "value": 7836.722522671796}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 114.0, 115.0, 117.0, 129.0, 114.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.8}, {"lowerIsBetter": true, "replicates": [150.0, 117.0, 141.0, 149.0, 119.0, 153.0, 152.0, 184.0, 162.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [199.0, 200.0, 197.0, 196.0, 201.0, 198.0, 200.0, 198.0, 201.0, 201.0], "unit": "score", "name": "audio-dft", "value": 199.1}, {"lowerIsBetter": true, "replicates": [73.0, 83.0, 105.0, 159.0, 52.0, 83.0, 82.0, 76.0, 148.0, 85.0], "unit": "score", "name": "audio-fft", "value": 94.6}, {"lowerIsBetter": true, "replicates": [88.0, 96.0, 158.0, 116.0, 87.0, 80.0, 116.0, 82.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 101.8}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 130.0, 87.0, 89.0, 85.0, 90.0, 87.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 89.0, 96.0, 95.0, 91.0, 93.0, 99.0, 90.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [55.0, 59.0, 57.0, 59.0, 59.0, 60.0, 57.0, 59.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 70.0, 66.0, 65.0, 71.0, 70.0, 67.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [70.0, 98.0, 99.0, 103.0, 106.0, 82.0, 85.0, 80.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 129.0, 129.0, 136.0, 111.0, 129.0, 120.0, 133.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [126.0, 135.0, 139.0, 134.0, 135.0, 135.0, 146.0, 134.0, 131.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.0}, {"lowerIsBetter": true, "replicates": [66.0, 94.0, 100.0, 86.0, 67.0, 67.0, 77.0, 95.0, 92.0, 82.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 82.6}], "name": "kraken", "value": 1489.7999999999997}]} 15:00:01 INFO - Return code: 0 15:00:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:00:01 ERROR - # TBPL SUCCESS # 15:00:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:00:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:00:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:00:01 INFO - 2016-05-16 15:00:01.567 screenresolution[1688:10404] starting screenresolution argv=screenresolution get 15:00:01 INFO - 2016-05-16 15:00:01.570 screenresolution[1688:10404] Display 0: 1600x1200x32@60 15:00:01 INFO - 2016-05-16 15:00:01.576 screenresolution[1689:10407] starting screenresolution argv=screenresolution list 15:00:01 INFO - Available Modes on Display 0 15:00:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:00:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:00:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:00:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:00:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:00:01 INFO - Intel Iris: 15:00:01 INFO - Chipset Model: Intel Iris 15:00:01 INFO - Type: GPU 15:00:01 INFO - Bus: Built-In 15:00:01 INFO - VRAM (Dynamic, Max): 1536 MB 15:00:01 INFO - Vendor: Intel (0x8086) 15:00:01 INFO - Device ID: 0x0a2e 15:00:01 INFO - Revision ID: 0x0009 15:00:01 INFO - Displays: 15:00:01 INFO - Display: 15:00:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:00:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:00:01 INFO - Display Serial Number: 1600x1200 60 15:00:01 INFO - Main Display: Yes 15:00:01 INFO - Mirror: Off 15:00:01 INFO - Online: Yes 15:00:01 INFO - Rotation: Supported 15:00:01 INFO - Return code: 0 15:00:01 INFO - Running post-action listener: _resource_record_post_action 15:00:01 INFO - Running post-run listener: _resource_record_post_run 15:00:02 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 32726528; Write bytes: 510173184; Read time: 328; Write time: 1794 15:00:02 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198568448; Write bytes: 196104192; Read time: 17941; Write time: 338 15:00:02 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30961152; Write bytes: 303276032; Read time: 309; Write time: 1422 15:00:02 INFO - Running post-run listener: _upload_blobber_files 15:00:02 INFO - Blob upload gear active. 15:00:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:02 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 15:00:02 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'] 15:00:02 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 15:00:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:04 INFO - (blobuploader) - INFO - Done attempting. 15:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:05 INFO - (blobuploader) - INFO - Done attempting. 15:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:05 INFO - Return code: 0 15:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12c06c266cea50c3d79ae0a630870b2cfeffceaa54808c9b36f8be8f008ff1f88e74475e5d74db49194a2e9149482e780b16d7420a03a76cc5a87f0958e5134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6276c0c44dd0b5630f0d9368e8ec4154eceb1f6323c7b3e65ebf8f927e0d445cd1d6f6b514f81ad4d39847f46e7862fce77294a01840abfd8ce51f1198860e1"} 15:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:05 INFO - Contents: 15:00:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12c06c266cea50c3d79ae0a630870b2cfeffceaa54808c9b36f8be8f008ff1f88e74475e5d74db49194a2e9149482e780b16d7420a03a76cc5a87f0958e5134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6276c0c44dd0b5630f0d9368e8ec4154eceb1f6323c7b3e65ebf8f927e0d445cd1d6f6b514f81ad4d39847f46e7862fce77294a01840abfd8ce51f1198860e1"} 15:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:05 INFO - Copying logs to upload dir... 15:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.501995 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-16 15:00:05.530305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 15:00:05.534665) ========= 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.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12c06c266cea50c3d79ae0a630870b2cfeffceaa54808c9b36f8be8f008ff1f88e74475e5d74db49194a2e9149482e780b16d7420a03a76cc5a87f0958e5134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6276c0c44dd0b5630f0d9368e8ec4154eceb1f6323c7b3e65ebf8f927e0d445cd1d6f6b514f81ad4d39847f46e7862fce77294a01840abfd8ce51f1198860e1"} build_url:https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/BfPopITTSVKStSB17yMgMg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f12c06c266cea50c3d79ae0a630870b2cfeffceaa54808c9b36f8be8f008ff1f88e74475e5d74db49194a2e9149482e780b16d7420a03a76cc5a87f0958e5134", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6276c0c44dd0b5630f0d9368e8ec4154eceb1f6323c7b3e65ebf8f927e0d445cd1d6f6b514f81ad4d39847f46e7862fce77294a01840abfd8ce51f1198860e1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 15:00:05.573752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 15:00:05.574195) ========= 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.6YdmJeXawk/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.YgxGpwXxLP/Listeners TMPDIR=/var/folders/vl/13zsdy5s2c70rd9lzswz9gd000000w/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.005097 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 15:00:05.638164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 15:00:05.639335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 15:00:05.640912) ========= ========= Total master_lag: 0.23 =========