builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1467943352.08 results: success (0) buildid: 20160706073558 builduid: a15f864cd7e24085b4dd36d56cf0d119 revision: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.081845) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.082291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.082566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.105958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.106372) ========= 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.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-07-07 19:02:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2016-07-07 19:02:32 (8.26 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.240652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.240995) ========= 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.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.020886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:32.289574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 19:02:32.289950) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 --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 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-07-07 19:02:32,367 truncating revision to first 12 chars 2016-07-07 19:02:32,367 Setting DEBUG logging. 2016-07-07 19:02:32,368 attempt 1/10 2016-07-07 19:02:32,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/85f50dde3d35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 19:02:34,283 unpacking tar archive at: mozilla-beta-85f50dde3d35/testing/mozharness/ program finished with exit code 0 elapsedTime=2.185790 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 19:02:34.501447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:34.502332) ========= script_repo_revision: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:34.503321) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:34.504030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:02:34.523326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-07 19:02:34.523732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:02:34 INFO - MultiFileLogger online at 20160707 19:02:34 in /builds/slave/test 19:02:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:02:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:34 INFO - {'append_to_log': False, 19:02:34 INFO - 'base_work_dir': '/builds/slave/test', 19:02:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:02:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:34 INFO - 'branch': 'Mozilla-Beta', 19:02:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:34 INFO - 'config_files': ('talos/mac_config.py',), 19:02:34 INFO - 'default_actions': ('clobber', 19:02:34 INFO - 'read-buildbot-config', 19:02:34 INFO - 'download-and-extract', 19:02:34 INFO - 'populate-webroot', 19:02:34 INFO - 'create-virtualenv', 19:02:34 INFO - 'install', 19:02:34 INFO - 'run-tests'), 19:02:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:34 INFO - 'download_minidump_stackwalk': True, 19:02:34 INFO - 'download_symbols': 'ondemand', 19:02:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:34 INFO - 'installer_path': 'installer.exe', 19:02:34 INFO - 'log_level': 'info', 19:02:34 INFO - 'log_name': 'talos', 19:02:34 INFO - 'log_to_console': True, 19:02:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:02:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:02:34 INFO - 'opt_config_files': (), 19:02:34 INFO - 'pip_index': False, 19:02:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:34 INFO - 'cmd': ('bash', 19:02:34 INFO - '-c', 19:02:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:34 INFO - 'enabled': True, 19:02:34 INFO - 'halt_on_failure': False, 19:02:34 INFO - 'name': 'check_screen_resolution'},), 19:02:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:34 INFO - 'cmd': ('bash', 19:02:34 INFO - '-c', 19:02:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:34 INFO - 'enabled': True, 19:02:34 INFO - 'halt_on_failure': False, 19:02:34 INFO - 'name': 'check_screen_resolution'},), 19:02:34 INFO - 'run_cmd_checks_enabled': True, 19:02:34 INFO - 'sps_profile': False, 19:02:34 INFO - 'sps_profile_interval': 0, 19:02:34 INFO - 'suite': 'dromaeojs', 19:02:34 INFO - 'system_bits': '32', 19:02:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:34 INFO - 'title': 't-yosemite-r7-0387', 19:02:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:34 INFO - 'use_talos_json': True, 19:02:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:34 INFO - 'work_dir': 'build'} 19:02:34 INFO - ##### 19:02:34 INFO - ##### Running clobber step. 19:02:34 INFO - ##### 19:02:34 INFO - Running pre-action listener: _resource_record_pre_action 19:02:34 INFO - Running main action method: clobber 19:02:34 INFO - rmtree: /builds/slave/test/build 19:02:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:36 INFO - Running post-action listener: _resource_record_post_action 19:02:36 INFO - ##### 19:02:36 INFO - ##### Running read-buildbot-config step. 19:02:36 INFO - ##### 19:02:36 INFO - Running pre-action listener: _resource_record_pre_action 19:02:36 INFO - Running main action method: read_buildbot_config 19:02:36 INFO - Using buildbot properties: 19:02:36 INFO - { 19:02:36 INFO - "project": "", 19:02:36 INFO - "product": "firefox", 19:02:36 INFO - "script_repo_revision": "production", 19:02:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:02:36 INFO - "repository": "", 19:02:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:02:36 INFO - "buildid": "20160706073558", 19:02:36 INFO - "pgo_build": "False", 19:02:36 INFO - "basedir": "/builds/slave/test", 19:02:36 INFO - "buildnumber": 33, 19:02:36 INFO - "slavename": "t-yosemite-r7-0387", 19:02:36 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:02:36 INFO - "platform": "yosemite_r7", 19:02:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:02:36 INFO - "branch": "mozilla-beta", 19:02:36 INFO - "repo_path": "releases/mozilla-beta", 19:02:36 INFO - "revision": "85f50dde3d351d93b571ac49ff71cf5140a2a3a7", 19:02:36 INFO - "stage_platform": "macosx64", 19:02:36 INFO - "builduid": "a15f864cd7e24085b4dd36d56cf0d119", 19:02:36 INFO - "slavebuilddir": "test" 19:02:36 INFO - } 19:02:36 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg. 19:02:36 INFO - Running post-action listener: _resource_record_post_action 19:02:36 INFO - ##### 19:02:36 INFO - ##### Running download-and-extract step. 19:02:36 INFO - ##### 19:02:36 INFO - Running pre-action listener: _resource_record_pre_action 19:02:36 INFO - Running main action method: download_and_extract 19:02:36 INFO - mkdir: /builds/slave/test/build/tests 19:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.test_packages.json 19:02:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 19:02:36 INFO - Downloaded 1165 bytes. 19:02:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 19:02:36 INFO - Using the following test package requirements: 19:02:36 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:02:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 19:02:36 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 19:02:36 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:02:36 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 19:02:36 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 19:02:36 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 19:02:36 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 19:02:36 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 19:02:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 19:02:36 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 19:02:36 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 19:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:02:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip 19:02:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 19:02:36 INFO - Downloaded 18351403 bytes. 19:02:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:02:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:02:39 INFO - Return code: 0 19:02:39 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 19:02:39 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')]} 19:02:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip 19:02:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 19:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 19:02:40 INFO - Downloaded 18351403 bytes. 19:02:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:02:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:02:43 INFO - Return code: 0 19:02: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')]} 19:02:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.talos.tests.zip 19:02:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 19:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 19:02:43 INFO - Downloaded 10840145 bytes. 19:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:02:44 INFO - Return code: 0 19:02:44 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')]} 19:02:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 19:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 19:02:47 INFO - Downloaded 86190145 bytes. 19:02:47 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:47 INFO - mkdir: /builds/slave/test/properties 19:02:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:47 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:47 INFO - Contents: 19:02:47 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg 19:02:48 INFO - Running post-action listener: _resource_record_post_action 19:02:48 INFO - Running post-action listener: set_extra_try_arguments 19:02:48 INFO - ##### 19:02:48 INFO - ##### Running populate-webroot step. 19:02:48 INFO - ##### 19:02:48 INFO - Running pre-action listener: _resource_record_pre_action 19:02:48 INFO - Running main action method: populate_webroot 19:02:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:48 INFO - '--tppagecycles', 19:02:48 INFO - '7'], 19:02:48 INFO - 'tests': ['tsvgm']}}, 19:02:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:02:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:02:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['damp', 'tps']}, 19:02:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['damp', 'tps']}, 19:02:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['dromaeo_dom']}, 19:02:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['a11yr', 19:02:48 INFO - 'ts_paint', 19:02:48 INFO - 'tpaint', 19:02:48 INFO - 'sessionrestore', 19:02:48 INFO - 'sessionrestore_no_auto_restore', 19:02:48 INFO - 'tabpaint']}, 19:02:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tsvgx', 19:02:48 INFO - 'tsvgr_opacity', 19:02:48 INFO - 'tart', 19:02:48 INFO - 'tscrollx', 19:02:48 INFO - 'cart']}, 19:02:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:02:48 INFO - 'tsvgr_opacity', 19:02:48 INFO - 'tart', 19:02:48 INFO - 'tscrollx', 19:02:48 INFO - 'cart']}, 19:02:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s'], 19:02:48 INFO - 'tests': ['tp5o']}, 19:02:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'tests': ['tp5o']}, 19:02:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--disable-e10s', 19:02:48 INFO - '--xperf_path', 19:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:48 INFO - 'tests': ['tp5n']}, 19:02:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:02:48 INFO - 'talos_options': ['--xperf_path', 19:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:48 INFO - 'tests': ['tp5n']}}, 19:02:48 INFO - 'talos.zip': {'path': '', 19:02:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:48 INFO - Running post-action listener: _resource_record_post_action 19:02:48 INFO - ##### 19:02:48 INFO - ##### Running create-virtualenv step. 19:02:48 INFO - ##### 19:02:48 INFO - Running pre-action listener: _resource_record_pre_action 19:02:48 INFO - Running main action method: create_virtualenv 19:02:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:48 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 19:02:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:48 INFO - Using real prefix '/tools/python27' 19:02:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:51 INFO - Installing pip.................done. 19:02:51 INFO - Return code: 0 19:02:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02: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')]} 19:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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')]} 19:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:51 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:02:51 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 19:02:51 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 19:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:51 INFO - 'HOME': '/Users/cltbld', 19:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:51 INFO - 'LOGNAME': 'cltbld', 19:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:51 INFO - 'MOZ_NO_REMOTE': '1', 19:02:51 INFO - 'NO_EM_RESTART': '1', 19:02:51 INFO - 'PAGER': '/bin/cat', 19:02:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:51 INFO - 'PWD': '/builds/slave/test', 19:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:51 INFO - 'SHELL': '/bin/bash', 19:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:02:51 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:51 INFO - 'USER': 'cltbld', 19:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:51 INFO - 'XPC_FLAGS': '0x0', 19:02:51 INFO - 'XPC_SERVICE_NAME': '0', 19:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 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 19:02:52 INFO - Cleaning up... 19:02:52 INFO - Return code: 0 19:02:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:02:52 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')]} 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:52 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')]} 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:52 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:02:52 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 19:02:52 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 19:02:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:02:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:52 INFO - 'HOME': '/Users/cltbld', 19:02:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:52 INFO - 'LOGNAME': 'cltbld', 19:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:52 INFO - 'MOZ_NO_REMOTE': '1', 19:02:52 INFO - 'NO_EM_RESTART': '1', 19:02:52 INFO - 'PAGER': '/bin/cat', 19:02:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:52 INFO - 'PWD': '/builds/slave/test', 19:02:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:52 INFO - 'SHELL': '/bin/bash', 19:02:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:02:52 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:02:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:52 INFO - 'USER': 'cltbld', 19:02:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:52 INFO - 'XPC_FLAGS': '0x0', 19:02:52 INFO - 'XPC_SERVICE_NAME': '0', 19:02:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:52 INFO - Downloading/unpacking psutil>=0.7.1 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:55 INFO - Installing collected packages: psutil 19:02:55 INFO - Running setup.py install for psutil 19:02:55 INFO - building 'psutil._psutil_osx' extension 19:02:55 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 19:02:55 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 19:02:56 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 19:02:56 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 19:02:56 INFO - building 'psutil._psutil_posix' extension 19:02:56 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 19:02:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:02:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:02:56 INFO - ^ 19:02:56 INFO - 1 warning generated. 19:02:56 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 19:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:56 INFO - Successfully installed psutil 19:02:56 INFO - Cleaning up... 19:02:56 INFO - Return code: 0 19:02:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:02:56 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')]} 19:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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')]} 19:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:56 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:02:56 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 19:02:56 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 19:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:56 INFO - 'HOME': '/Users/cltbld', 19:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:56 INFO - 'LOGNAME': 'cltbld', 19:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:56 INFO - 'MOZ_NO_REMOTE': '1', 19:02:56 INFO - 'NO_EM_RESTART': '1', 19:02:56 INFO - 'PAGER': '/bin/cat', 19:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:56 INFO - 'PWD': '/builds/slave/test', 19:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:56 INFO - 'SHELL': '/bin/bash', 19:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:02:56 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:56 INFO - 'USER': 'cltbld', 19:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:56 INFO - 'XPC_FLAGS': '0x0', 19:02:56 INFO - 'XPC_SERVICE_NAME': '0', 19:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:56 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 19:02:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:02:59 INFO - Installing collected packages: mozsystemmonitor 19:02:59 INFO - Running setup.py install for mozsystemmonitor 19:02:59 INFO - Successfully installed mozsystemmonitor 19:02:59 INFO - Cleaning up... 19:02:59 INFO - Return code: 0 19:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:59 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')]} 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 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')]} 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:59 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:02:59 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 19:02:59 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 19:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:59 INFO - 'HOME': '/Users/cltbld', 19:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:59 INFO - 'LOGNAME': 'cltbld', 19:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:59 INFO - 'MOZ_NO_REMOTE': '1', 19:02:59 INFO - 'NO_EM_RESTART': '1', 19:02:59 INFO - 'PAGER': '/bin/cat', 19:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:59 INFO - 'PWD': '/builds/slave/test', 19:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:59 INFO - 'SHELL': '/bin/bash', 19:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:02:59 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:59 INFO - 'USER': 'cltbld', 19:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:59 INFO - 'XPC_FLAGS': '0x0', 19:02:59 INFO - 'XPC_SERVICE_NAME': '0', 19:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:03 INFO - Downloading docopt-0.6.1.tar.gz 19:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:03 INFO - Running setup.py install for blobuploader 19:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:03 INFO - Running setup.py install for requests 19:03:04 INFO - Running setup.py install for docopt 19:03:04 INFO - Successfully installed blobuploader requests docopt 19:03:04 INFO - Cleaning up... 19:03:04 INFO - Return code: 0 19:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03: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')]} 19:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:04 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:03:04 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 19:03:04 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 19:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:04 INFO - 'HOME': '/Users/cltbld', 19:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:04 INFO - 'LOGNAME': 'cltbld', 19:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:04 INFO - 'MOZ_NO_REMOTE': '1', 19:03:04 INFO - 'NO_EM_RESTART': '1', 19:03:04 INFO - 'PAGER': '/bin/cat', 19:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:04 INFO - 'PWD': '/builds/slave/test', 19:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:04 INFO - 'SHELL': '/bin/bash', 19:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:04 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:04 INFO - 'USER': 'cltbld', 19:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:04 INFO - 'XPC_FLAGS': '0x0', 19:03:04 INFO - 'XPC_SERVICE_NAME': '0', 19:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8oru8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ymtQ1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ZphP9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-imfh8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:04 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QBYIfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-4wSnzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Rl7pin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-AxazDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OatYcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-w9QeY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-DhYnzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XKJCJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-5KrW62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UWkQkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ovnZH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zUUHW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MNhliB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:06 INFO - Running setup.py install for manifestparser 19:03:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:06 INFO - Running setup.py install for mozcrash 19:03:06 INFO - Running setup.py install for mozdebug 19:03:06 INFO - Running setup.py install for mozdevice 19:03:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:03:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:06 INFO - Running setup.py install for mozfile 19:03:07 INFO - Running setup.py install for mozhttpd 19:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozinfo 19:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozInstall 19:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozleak 19:03:07 INFO - Running setup.py install for mozlog 19:03:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for moznetwork 19:03:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:07 INFO - Running setup.py install for mozprocess 19:03:08 INFO - Running setup.py install for mozprofile 19:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Running setup.py install for mozrunner 19:03:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Running setup.py install for mozscreenshot 19:03:08 INFO - Running setup.py install for moztest 19:03:08 INFO - Running setup.py install for mozversion 19:03:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:08 INFO - Cleaning up... 19:03:08 INFO - Return code: 0 19:03:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:08 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')]} 19:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:08 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')]} 19:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:08 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:03:08 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 19:03:08 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 19:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:08 INFO - 'HOME': '/Users/cltbld', 19:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:08 INFO - 'LOGNAME': 'cltbld', 19:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:08 INFO - 'MOZ_NO_REMOTE': '1', 19:03:08 INFO - 'NO_EM_RESTART': '1', 19:03:08 INFO - 'PAGER': '/bin/cat', 19:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:08 INFO - 'PWD': '/builds/slave/test', 19:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:08 INFO - 'SHELL': '/bin/bash', 19:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:08 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:08 INFO - 'USER': 'cltbld', 19:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:08 INFO - 'XPC_FLAGS': '0x0', 19:03:08 INFO - 'XPC_SERVICE_NAME': '0', 19:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-TBFumf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ve7RSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-eu9o1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-4RN538-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ttdJeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nkxAde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-m_qun5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:09 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)) 19:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Ra3OuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8a9FiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-VnzoSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nkavzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Qj28QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-WJ6HW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-S7mAuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zspwia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-o0YvIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:10 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)) 19:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nzkrE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:10 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)) 19:03:10 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)) 19:03:10 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)) 19:03:10 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)) 19:03:10 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)) 19:03:10 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)) 19:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:11 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 19:03:11 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 19:03:13 INFO - Downloading blessings-1.6.tar.gz 19:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:03:13 INFO - Installing collected packages: blessings 19:03:13 INFO - Running setup.py install for blessings 19:03:13 INFO - Successfully installed blessings 19:03:13 INFO - Cleaning up... 19:03:13 INFO - Return code: 0 19:03:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:14 INFO - Reading from file tmpfile_stdout 19:03:14 INFO - Current package versions: 19:03:14 INFO - blessings == 1.6 19:03:14 INFO - blobuploader == 1.2.4 19:03:14 INFO - docopt == 0.6.1 19:03:14 INFO - manifestparser == 1.1 19:03:14 INFO - mozInstall == 1.12 19:03:14 INFO - mozcrash == 0.17 19:03:14 INFO - mozdebug == 0.1 19:03:14 INFO - mozdevice == 0.48 19:03:14 INFO - mozfile == 1.2 19:03:14 INFO - mozhttpd == 0.7 19:03:14 INFO - mozinfo == 0.9 19:03:14 INFO - mozleak == 0.1 19:03:14 INFO - mozlog == 3.1 19:03:14 INFO - moznetwork == 0.27 19:03:14 INFO - mozprocess == 0.22 19:03:14 INFO - mozprofile == 0.28 19:03:14 INFO - mozrunner == 6.11 19:03:14 INFO - mozscreenshot == 0.1 19:03:14 INFO - mozsystemmonitor == 0.0 19:03:14 INFO - moztest == 0.7 19:03:14 INFO - mozversion == 1.4 19:03:14 INFO - psutil == 3.1.1 19:03:14 INFO - requests == 1.2.3 19:03:14 INFO - wsgiref == 0.1.2 19:03:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:14 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')]} 19:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 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')]} 19:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:03:14 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 19:03:14 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 19:03:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:14 INFO - 'HOME': '/Users/cltbld', 19:03:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:14 INFO - 'LOGNAME': 'cltbld', 19:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:14 INFO - 'MOZ_NO_REMOTE': '1', 19:03:14 INFO - 'NO_EM_RESTART': '1', 19:03:14 INFO - 'PAGER': '/bin/cat', 19:03:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:14 INFO - 'PWD': '/builds/slave/test', 19:03:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:14 INFO - 'SHELL': '/bin/bash', 19:03:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:14 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:14 INFO - 'USER': 'cltbld', 19:03:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:14 INFO - 'XPC_FLAGS': '0x0', 19:03:14 INFO - 'XPC_SERVICE_NAME': '0', 19:03:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 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)) 19:03:14 INFO - Cleaning up... 19:03:14 INFO - Return code: 0 19:03:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:03:14 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')]} 19:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 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')]} 19:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:14 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:03:14 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 19:03:14 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 19:03:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:14 INFO - 'HOME': '/Users/cltbld', 19:03:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:14 INFO - 'LOGNAME': 'cltbld', 19:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:14 INFO - 'MOZ_NO_REMOTE': '1', 19:03:14 INFO - 'NO_EM_RESTART': '1', 19:03:14 INFO - 'PAGER': '/bin/cat', 19:03:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:14 INFO - 'PWD': '/builds/slave/test', 19:03:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:14 INFO - 'SHELL': '/bin/bash', 19:03:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:14 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:14 INFO - 'USER': 'cltbld', 19:03:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:14 INFO - 'XPC_FLAGS': '0x0', 19:03:14 INFO - 'XPC_SERVICE_NAME': '0', 19:03:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:14 INFO - Downloading/unpacking jsonschema 19:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:16 INFO - Downloading/unpacking functools32 (from jsonschema) 19:03:16 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 19:03:16 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 19:03:16 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 19:03:16 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 19:03:16 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 19:03:16 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 19:03:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:17 INFO - warning: no files found matching '*.txt' 19:03:17 INFO - no previously-included directories found matching 'build' 19:03:17 INFO - no previously-included directories found matching 'dist' 19:03:17 INFO - no previously-included directories found matching '.git*' 19:03:17 INFO - Installing collected packages: jsonschema, functools32 19:03:17 INFO - Running setup.py install for functools32 19:03:17 INFO - warning: no files found matching '*.txt' 19:03:17 INFO - no previously-included directories found matching 'build' 19:03:17 INFO - no previously-included directories found matching 'dist' 19:03:17 INFO - no previously-included directories found matching '.git*' 19:03:17 INFO - Successfully installed jsonschema functools32 19:03:17 INFO - Cleaning up... 19:03:17 INFO - Return code: 0 19:03:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:17 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 0x107d81a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d91420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6605929f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, '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.J118oNgt4Q/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.ZKBvI6quWK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 19:03:17 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 19:03:17 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 19:03:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:17 INFO - 'HOME': '/Users/cltbld', 19:03:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:17 INFO - 'LOGNAME': 'cltbld', 19:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:17 INFO - 'MOZ_NO_REMOTE': '1', 19:03:17 INFO - 'NO_EM_RESTART': '1', 19:03:17 INFO - 'PAGER': '/bin/cat', 19:03:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:17 INFO - 'PWD': '/builds/slave/test', 19:03:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:17 INFO - 'SHELL': '/bin/bash', 19:03:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:17 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:17 INFO - 'USER': 'cltbld', 19:03:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:17 INFO - 'XPC_FLAGS': '0x0', 19:03:17 INFO - 'XPC_SERVICE_NAME': '0', 19:03:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:17 INFO - Downloading/unpacking flake8 19:03:17 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 19:03:17 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 19:03:17 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 19:03:17 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 19:03:17 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 19:03:17 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 19:03:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:03:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:03:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:20 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 19:03:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:03:21 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 19:03:21 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 19:03:21 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 19:03:21 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 19:03:21 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 19:03:21 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 19:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:21 INFO - no previously-included directories found matching 'docs/_build' 19:03:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:03:21 INFO - Running setup.py install for pep8 19:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:03:21 INFO - no previously-included directories found matching 'docs/_build' 19:03:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:03:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:03:21 INFO - Cleaning up... 19:03:22 INFO - Return code: 0 19:03:22 INFO - Running post-action listener: _resource_record_post_action 19:03:22 INFO - Running post-action listener: _start_resource_monitoring 19:03:22 INFO - Starting resource monitoring. 19:03:22 INFO - ##### 19:03:22 INFO - ##### Running install step. 19:03:22 INFO - ##### 19:03:22 INFO - Running pre-action listener: _resource_record_pre_action 19:03:22 INFO - Running main action method: install 19:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:22 INFO - Reading from file tmpfile_stdout 19:03:22 INFO - Detecting whether we're running mozinstall >=1.0... 19:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:03:22 INFO - Reading from file tmpfile_stdout 19:03:22 INFO - Output received: 19:03:22 INFO - Usage: mozinstall [options] installer 19:03:22 INFO - Options: 19:03:22 INFO - -h, --help show this help message and exit 19:03:22 INFO - -d DEST, --destination=DEST 19:03:22 INFO - Directory to install application into. [default: 19:03:22 INFO - "/builds/slave/test"] 19:03:22 INFO - --app=APP Application being installed. [default: firefox] 19:03:22 INFO - mkdir: /builds/slave/test/build/application 19:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 19:03:44 INFO - Reading from file tmpfile_stdout 19:03:44 INFO - Output received: 19:03:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:03:44 INFO - Running post-action listener: _resource_record_post_action 19:03:44 INFO - ##### 19:03:44 INFO - ##### Running run-tests step. 19:03:44 INFO - ##### 19:03:44 INFO - Running pre-action listener: _resource_record_pre_action 19:03:44 INFO - Running main action method: run_tests 19:03:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:03:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:03:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:03:44 INFO - 2016-07-07 19:03:44.343 screenresolution[2212:16787] starting screenresolution argv=screenresolution get 19:03:44 INFO - 2016-07-07 19:03:44.345 screenresolution[2212:16787] Display 0: 1600x1200x32@60 19:03:44 INFO - 2016-07-07 19:03:44.351 screenresolution[2213:16789] starting screenresolution argv=screenresolution list 19:03:44 INFO - Available Modes on Display 0 19:03:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:03:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:03:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:03:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:03:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:03:44 INFO - Intel Iris: 19:03:44 INFO - Chipset Model: Intel Iris 19:03:44 INFO - Type: GPU 19:03:44 INFO - Bus: Built-In 19:03:44 INFO - VRAM (Dynamic, Max): 1536 MB 19:03:44 INFO - Vendor: Intel (0x8086) 19:03:44 INFO - Device ID: 0x0a2e 19:03:44 INFO - Revision ID: 0x0009 19:03:44 INFO - Displays: 19:03:44 INFO - Display: 19:03:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:03:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:03:44 INFO - Display Serial Number: 1600x1200 60 19:03:44 INFO - Main Display: Yes 19:03:44 INFO - Mirror: Off 19:03:44 INFO - Online: Yes 19:03:44 INFO - Rotation: Supported 19:03:44 INFO - Return code: 0 19:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:44 INFO - Python 2.7.3 19:03:44 INFO - Return code: 0 19:03:44 INFO - grabbing minidump binary from tooltool 19:03:44 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')]} 19:03:44 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 0x107c20e00>, '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 0x107a89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c1bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:44 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 19:03:44 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 19:03:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:44 INFO - Return code: 0 19:03:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:03:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:03:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:03:45 INFO - Return code: 0 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J118oNgt4Q/Render', 19:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:45 INFO - 'HOME': '/Users/cltbld', 19:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PAGER': '/bin/cat', 19:03:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZKBvI6quWK/Listeners', 19:03:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 19:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - 'XPC_FLAGS': '0x0', 19:03:45 INFO - 'XPC_SERVICE_NAME': '0', 19:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:03:45 INFO - mozversion application_buildid: 20160706073558 19:03:45 INFO - mozversion application_changeset: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 19:03:45 INFO - mozversion application_display_name: Firefox 19:03:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:45 INFO - mozversion application_name: Firefox 19:03:45 INFO - mozversion application_remotingname: firefox 19:03:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:03:45 INFO - mozversion application_vendor: Mozilla 19:03:45 INFO - mozversion application_version: 48.0 19:03:45 INFO - mozversion platform_buildid: 20160706073558 19:03:45 INFO - mozversion platform_changeset: 85f50dde3d351d93b571ac49ff71cf5140a2a3a7 19:03:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:03:45 INFO - mozversion platform_version: 48.0 19:03:45 INFO - using testdate: 1467943425 19:03:45 INFO - actual date: 1467943425 19:03:45 INFO - starting webserver on 'localhost:51398' 19:03:45 INFO - SUITE-START | Running 2 tests 19:03:45 INFO - TEST-START | dromaeo_css 19:03:45 INFO - operating with platform_type : mac_ 19:03:45 INFO - Initialising browser for dromaeo_css test... 19:03:46 INFO - TEST-INFO | started process 2231 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmps5ZSXj/profile http://localhost:51398/getInfo.html) 19:03:48 INFO - PROCESS | 2231 | __metrics Screen width/height:1600/1200 19:03:48 INFO - PROCESS | 2231 | colorDepth:24 19:03:48 INFO - PROCESS | 2231 | Browser inner width/height: 1024/689 19:03:48 INFO - PROCESS | 2231 | __metrics 19:03:48 INFO - PROCESS | 2231 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:03:48 ERROR - PROCESS | 2231 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:03:49 INFO - TEST-INFO | 2231: exit 0 19:03:49 INFO - Browser initialized. 19:03:49 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:49 INFO - TEST-INFO | started process 2234 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmps5ZSXj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:00 INFO - PROCESS | 2234 | RSS: Main: 162091008 19:04:00 INFO - PROCESS | 2234 | 19:04:52 INFO - PROCESS | 2234 | 1467943492156 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] 19:07:02 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51398/tests/dromaeo/cssquery-ext.html) 19:07:03 INFO - PROCESS | 2234 | RSS: Main: 272019456 19:07:03 INFO - PROCESS | 2234 | 19:10:05 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-ext.html (next: http://localhost:51398/tests/dromaeo/cssquery-jquery.html) 19:10:06 INFO - PROCESS | 2234 | RSS: Main: 303063040 19:10:06 INFO - PROCESS | 2234 | 19:13:08 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51398/tests/dromaeo/cssquery-mootools.html) 19:13:08 INFO - PROCESS | 2234 | RSS: Main: 313257984 19:13:08 INFO - PROCESS | 2234 | 19:16:11 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51398/tests/dromaeo/cssquery-prototype.html) 19:16:11 INFO - PROCESS | 2234 | RSS: Main: 302886912 19:16:11 INFO - PROCESS | 2234 | 19:19:14 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51398/tests/dromaeo/cssquery-yui.html) 19:19:15 INFO - PROCESS | 2234 | RSS: Main: 267485184 19:19:15 INFO - PROCESS | 2234 | 19:22:17 INFO - PROCESS | 2234 | Cycle 1(1): loaded http://localhost:51398/tests/dromaeo/cssquery-yui.html (next: http://localhost:51398/tests/dromaeo/cssquery-dojo.html) 19:22:18 INFO - PROCESS | 2234 | RSS: Main: 316985344 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | __start_tp_report 19:22:18 INFO - PROCESS | 2234 | _x_x_mozilla_page_load 19:22:18 INFO - PROCESS | 2234 | _x_x_mozilla_page_load_details 19:22:18 INFO - PROCESS | 2234 | |i|pagename|runs| 19:22:18 INFO - PROCESS | 2234 | |0;dojo.html;2979.6126503554533;3593.9101522461933;3630.1469154748647;3632.255387645533;3692.7784332940028;5919.467247947684;5936.376680448545;5947.494462970647;5964.105384192368;5966.5226781857455;5965.970170149154;6006.729697163627;6012.338642749294;6024.397560243984;6028.517718582514;5260.132078207092;5297.708626025567;5361.758720857571;5395.514403703666;5440.782368705247;5388.676679399248;5420.051490989081;5427.375851777057;5427.592930530206;5438.293021907147;5342.1452567589195;5351.759170837322;5379.220013098098;5403.891922161554;5406.189071639246;5409.675419474825;5425.782968681248;5436.565074794046;5448.482394172547;5497.340319161686;5201.505856943584;5261.342332208474;5350.35795704514;5360.892782144335;5362.410134885159;5736.713164341766;5805.477507024388;5807.157962095514;5843.561732870009;5854.2096816930025;6265.9610089106745;6269.467095296905;6293.905591416133;6294.024426213944;6305.4009869062365;6234.594751341148;6251.218597675291;6305.527085468562;6312.589681670723;6327.683615819191;5945.671944419593;6041.093835924603;6044.335123136451;6084.391560843968;6094.817155485387;6412.23053233615;6422.357764223634;6423.454006409414;6436.549441539141;6443.613383197023;6261.5616906816995;6270.404311590391;6366.045093235959;6377.23473183221;6379;6125.326214116443;6308.747650093945;6321.683915804191;6342.746290148435;6344.936550634435;5555.694436806015;6254.499640028786;6311.053341998645;6319.957207060876;6335.968320158462;6241.251049874044;6254.249490061222;6308.779192728232;6313.958196897461;6345.746170153235;5021.72380519075;5082.542571168613;5085.821996230188;5092.439831618519;5098.566621837112;4569.840055598038;4573.725576465423;4579.771011449414;4581.221192397301;4608.354830323758;6046.969765151146;6108.72510737009;6169.043798211284;6185.103160041769;6194.256689197326;6306.716197771111;6309.053641953652;6309.211348581427;6329.715162817684;6330.8100756977365;5454.809081682122;6003.3996600339615;6151.815445536641;6171.13604095427;6172.722227499773;5414.242006119146;5508.6970216637665;5544.833654990276;5587.3015873015875;5609.326880774252;6504.5121615879;6524.934750652527;6558.770443034662;6569.211694596488;6583.341665833378;6234.220722409699;6297.622142671455;6316.336784637547;6319.020551814476;6320.462760665395;6495.935040649533;6569.310222426577;6570.967145164243;6586.769463068769;6599.571027883172;6265.154204182377;6273.466755325666;6278.780242691484;6284.780032698834;6299.275583307795;6195.597286176384;6233.158523599437;6244.313125556276;6246.968765156145;6316.842078948063;6278.0896769967185;6317.305096439296;6328.746850125944;6339.2392912850755;6346.174997250328;6327.588706734047;6328.7152078157515;6335.778247761306;6336.334684858208;6338.239411270677;5987.43119403656;6065.272167339947;6143.082036032849;6176.4441200292185;6193.256809182927;6316.242050953915;6325.810225693236;6331.651759153291;6339.778107766206;6350.301466838737;6153.5692501526255;6187.133801267916;6236.719347629459;6240.188775459162;6245.843853903689 19:22:18 INFO - PROCESS | 2234 | |1;ext.html;527.061829942702;540.0441219042295;593.7387549478226;594.0435898203891;619.2352444730759;31399.058028259133;31983.52024719631;32008.199795005108;32092.67907320926;32135;33149;33657.83171084141;33677.831610841975;39941.400878986766;40787.980300492505;9484.905150948505;9652.565634546463;9678.080582344666;9689.854652180187;9707.660231891885;9525.142737153656;9651.179649729782;9652.806943861118;9653.131218190361;9669.95165024174;9215.723528294162;9652.227821774277;10136.13842823361;11740.823887641693;11974;11550.191486595899;11652.242604230698;11660.650180494598;11682.532698692043;11693.473793679219;11506.252093613888;11630.825537616942;11633.6509904703;11636.301821890713;11638.70903227426;38518.42222366667;38833;38862;38927.805360973296;39021;3243.7405007599336;3323.7839540429795;3334.3831391192466;3536.929261414783;3628.3650361186687;28116.718832811614;29006.984755533667;29191.124266272047;29309.12072637824;29456.410871782446;2758.1449750577185;2766.806323557352;2772.2989261450784;2818.957715634267;2824.61867647867;491025;492779.53610232077;492819;493751;494430;37204.44193337102;63977;64294;64388;64467.48727589117;36400.27199456049;36435.453468198;36456.27087458289;36488.635113648525;36566;15924.044557326366;15937.521874343789;16052.197390130446;16054.956427832154;16076.75884861728;13597.932010339884;13674.726505469835;13679.658008549866;13680.31598420075;13712.794308085387;7957.8408431832195;8316;8374.748757537283;8402.789930251793;8490.004848860513;3130.7651926105177;3421.3328400962073;3558.626344233818;3561.8753343632848;3595.6044835068124;1009.2733232072895;1038.9636362727267;1062.3519653011656;1102.3330884814732;1235.7960936445565;22534.32397028092;26281.948722050904;28116.71883281182;28758.281042974093;30091;1133.4162906103363;1135.2110283353156;1146.696125526736;1155.9884401156048;1166.8658104318113;15649.765253521206;15726;15764.76352854708;15816.52550423489;16190.190490475428;480927;624311;631199;632058;633740;54819.17771233435;55580.88838223294;62738.686306568175;62842.68578657077;63831.680841595495;1542.367629271993;1550.7906432631676;1564.8904576679522;1568.05916450129;1569.709603723292;28018.71981280161;29298.853505732335;29501.96743113981;30090.699093009665;30155.09534713962;39545;48724;48757;48798.268025980346;48859.778505537644;801921;818086;818163;819967;821052;27283.863580682762;28032.29919252035;28090;42933.92665183396;44355.55644443514;44176;44413.33379999238;44447.777761110985;44554;45377.63867083993;34577;35492.645073548934;36488.27023459569;37096.629033709316;37169;35811.64188358083;36064.45903311505;36201.81899090593;36923.261534768615;36954.44568331423;31854.36291274115;37030.44454333241;38018.61981380151;38152.61847381491;39097;31846.68153318437;33844;34004.65995340015;34036.82981585076;34060.637574496744;24973.250802475955;25152.24543263705;25165.748342517072;25231.11691090803;25237.611931343217 19:22:18 INFO - PROCESS | 2234 | |2;jquery.html;414.37636357282304;415.4059694636672;416.81451753969475;419.63701398290476;427.9572042795719;20185.394438166877;20444.08001639926;21087.683684744723;21146.471338216554;21867.781322186773;21146.048427820748;21196.25813096542;22814.429639259026;22823.771762282373;22901.541969160608;5433.510984011438;5768.740406681688;5770.971145144289;5778.219940308068;5779.682117483537;5647.09646456567;5709.74306156224;5728.16941543476;5737.741801618937;5739.225204597367;6047.183630209909;6113.296970848342;6249.3438188990185;6251.343608921066;6263.373662633746;5639.436056394369;6164.4143806338325;6212.9068063979075;6218.098375735538;6224.221972253491;5580.91628625571;5601.635893666939;5601.803936862231;5611.382747897728;5615.410381909923;13857.653558661013;14051.64870878226;14315.78526322106;14318.642033949234;14339.354729037219;2071.3164655663745;2197.2748992832326;2319.4085508195303;2381.8570885746913;2389.223502361722;9975.351602145909;10028.849567256497;10296.382217066925;10353.01646343596;10616.203784716177;1723.9053201217191;1792.7131658934509;1817.972730409045;1847.7413162157309;1848.9445316640522;90324.54837725835;99312;108732.82534349347;111543.44228278888;114212.85787142106;9815.509224538744;11569.537218511334;11913.702157446132;11936.880631193751;11996.340201288838;15348.539543813704;15464.072155670696;15536.844631553766;15580;15585.986910850985;9240.491772952551;9289.90710092904;9290.303227257982;9310.0224476429;9422.387544809566;9272.536373181314;9280.767980800534;9289.581968811419;9359.953200233955;9374.343795934356;4821.083994041121;4845.53967373099;4849.975750121227;4856.465788763233;4884.755762211947;1992.4819546917906;2033.4916270932267;2041.1529215375454;2053.2342185720267;2061.1137210999414;900.5407242306339;940.2618944128963;1001.8547310639916;1054.847047178155;1098.0995583621514;17264.74102888458;20712.171513139307;21517.67723484149;21519.67720484194;21763.020664069838;990.3958585262984;1036.300497164411;1045.1012129568717;1057.318029870729;1060.867391576053;10896.891031089588;11194.552217911356;11420.600278990196;11450.484728187252;11456.713582160513;636446;650938;656346;663390;668511;113879;118080;124797;127466.36266818793;128542;1031.8297480915714;1036.2538971940191;1052.2371280821496;1054.3463052907246;1054.8206804843196;18089.909550452165;18832.52918677044;18869.962152081767;18918.243270269584;19299.938503381887;43489.34765978449;49780;51864.74067629638;55104.89790204093;55679;58597;74948;76579.23420765944;78375.60812195903;78737.60631196808;6960.234374218933;8218.465799722999;8252.33981281484;8491.532965686947;8584.356173286904;9198.586063627286;12145.514179433078;12628.936855315664;12960.092793504742;13023.413946372626;10907.727306817393;11168.497417616389;11198.88801112011;11327.716807079889;11342.97913187817;10960.945195273973;10984.505697243483;11030.393328367018;11273.379964102052;11273.887261127611;11240.606578769704;11468;11519.94240028828;11583.478743456733;11807.704807379885;8336.416450848383;8383.706570270011;8452.239298463168;8473.788155296166;8607.526586037828;10657.946710266398;11246.718832029264;11516.712082198012;11540.019098376732;11552.537898483966 19:22:18 INFO - PROCESS | 2234 | |3;mootools.html;1492.4030387844855;1519.7492413751731;1638.7869576954997;1868.4581471373303;1999.4801351648566;8393.664253429863;9157.267418606512;9319.301052421079;9342.532873356331;9343.719688409341;7331.816704582388;9236.815263694722;9248.630054797817;9301.720948371543;9317.06829317068;2298.747137814839;2454.600877499826;2592.675915510561;2592.7277635848245;2595.8572278524675;2525.3434107132093;2587.4695687384137;2589.948201035978;2592.44262483566;2594.1050337633583;2537.8731063446753;2575.446279050004;2581.3933725574475;2582.6771653543306;2584.6639936808187;2554.757298056691;2573.691157061146;2580.148550978182;2588.0682954136496;2595.0268649256527;2530.430653103037;2570.6144078388206;2577.3298942274955;2581.4062765563835;2583.044273618773;8995.55022248885;9251.814963700755;9288.628454861797;9305.395149315273;9311.860322095106;5723.313202415695;5898.085796701518;5964.701764911737;5981.043033114681;5981.611195272337;3677.3380791457525;3742.2141350316465;3804.733668643196;3815.4467602197524;3819.0452386903276;1053.8208504554243;1065.1053115383115;1065.8880817514205;1081.9242653014292;1110.8722496912878;12686.619401417973;12755;12771.297578633079;12775.552855650101;12831.422585983653;4821.373221481185;4835.588974937099;4849.102915960559;4854.441739199967;4916.877078073006;9839.508024598885;9840;9848.704538863845;9865.457399842933;9881.357711748713;5687.857803554944;5692.37383887772;5694.202811606378;5694.544436445074;5696.430356964271;3619.8371073301764;4715.481297057321;4773.403324584427;4773.880652983703;5266.7366631668265;3764.1906989997283;3999.440078389028;4009.6391324780325;4100.630943215066;4109.075458021981;1270.244204698203;1271.8982481401465;1276.610633756713;1286.852012018611;1288.3171918883006;773.307889438949;824.7072289337319;893.145431695231;928.4846909964899;975.48299401316;6095.110515740134;6237.875242495215;6268;6278.874422511524;6283.8114856554375;976.6337623391229;982.111189373618;996.0338471682456;1032.550840384435;1058.5659879449388;3252.3332716793;3337.8831740889436;4095.1809638072505;4108.753474791522;4124.340105583153;11264.831027534594;11754.177207595387;11769.941150294193;11778.823317650242;11782.764344713058;11574.88425115755;11611.303321800719;11625.534978600761;11715.472803723853;11743.47154378055;8749.956250218707;8895.777605559913;8973.50645714479;8977.865332020025;8986.685466008788;5772.5959182856795;5951.434613711691;6046.032634778414;6135.417135372132;6217;10129.189664826943;10307;10463.94768026155;10476.161907047266;10512.632057877938;10458.633947812094;10547.103496202908;10942;10955.890441095487;10981.890181098086;6771.3905748482875;7372.520786148883;7507.737229196952;7515.699372025277;7542.698292068256;8145.714899978472;8504.192101750325;8716.825663486821;8733.039365669898;8797;7624.313811756969;7684.500507466997;7725.768226953201;7819.452638315263;7838.176991415819;7585.087215633372;7695.961520192363;7722.922770772445;7763.922360776546;7906.604669766603;7273.818154545967;7278.308560686726;7330.743423980135;7342.265773422615;7342.632868356668;5009.448960614257;5038.445770965118;5147.150720131136;5179.92230116541;5237.502437268454;5120.667156634807;5125.308083408841;5132.8460146195675;5148.43367229612;5241.737913104405 19:22:18 INFO - PROCESS | 2234 | |4;prototype.html;328.89310973933476;332.678964798969;342.45720532955266;344.0401280427607;345.77697385186553;6018.518518518519;6600.669966501674;6697;6700.229473610536;6705.832354191148;6295.338989406104;6461.547691661585;6466.224053113633;6585.802425927218;6612.900806487906;4934.358533390654;4982.202847544394;4995.100881841286;4998.750062496861;5017.623678224129;5001.424836143854;5003.874903127433;5009.398872135349;5018.09312461266;5035.194368900977;4715.174844402233;4824.348712923763;4915.975420122894;4966.528179822929;4972.925406118911;4081.7142800004012;4946.604271658259;4974.452810190913;4976.502349765031;4984.750762461898;4286.228478873802;4291.291936830419;4294.849680261207;4304.720193187432;4304.849330273425;6340.587861788969;6340.587861789015;6343.27052388972;6346.682665866688;6366.299707032223;5783.884322313572;5861.296644402656;5862.091375836752;5873.823785286406;5879.059350503899;6789.219239787439;7018.33325834045;7026.508144429892;7040.507164498487;7050.259722729091;4737.502562230985;4775.331453596499;4776.689515181537;4776.737279449629;4780.737059461728;6806.523543351967;7452.254774522558;7458.6270686466005;7464.365528930048;7476.25237476248;4857.052874689472;4860.3195552622665;4870.732109733928;4876.414830220397;4881.755912204376;4131.793410329472;4945.554900059012;4948.455669876311;4971.825986090542;5000.374953130859;5599.160125981135;5821.155932389865;5834.766609335664;5834.912476312858;5838.2702162229725;5689.288838895138;7064.540804847668;7064.7527336544;7088.539244949062;7089.432845372357;1613.532075698058;1699.6855581717423;1726.507945235627;1728.4037007232484;1728.9049102299243;1046.785408991155;1099.961501347449;1121.159130652011;1125.8986691197667;1128.7686024364984;6682.465402767767;6701.865962680719;6781.694823732944;6788.151481064867;6788.389044985975;7321.63391830417;7323.853522929511;7340.779776606711;7349.7060117595765;7352.669129889167;6695.698693558801;6769.356911093439;6777.390034896883;6779.35596118368;6780.457563394916;3726.1988672435014;3813.828377723009;3867.3812190049457;3875.6511913927884;3893.5717071122153;7644.464887457936;7669.501482403737;7675.884861727079;7684;7684.923150768421;6044.818655440344;7460.962695186489;7500.624968751541;7507.549547027196;7512;6146.7233974471255;6210.378962103844;7635.42734294919;7660.5020673657145;7673.117591477052;7022.473314501331;7254.129504459499;7279.235680253497;7313.341799238094;7315.268473152855;5738.942610573841;7091.503594748318;7102.325279098477;7153.213146553979;7159.355657990805;6236.594621349598;7653.9234607655435;7657.6554055066545;7692.9615351922885;7701.614919254127;4915.5330243626795;4916.803327866845;4918.360613120271;4919.680220785637;4923.852284431473;6906.93093069083;7246.166690830411;7249.710011599477;7255.238199988925;7271.091113610799;6964.268751781193;6985.685644146127;6990.126234220723;6999.020137180901;7007.7196912122945;6965;6999.930000700131;7004.474664400089;7004.649767511502;7017.543859649107;5612.540739407702;6819.874720671034;6833.180018397626;6859.348361905611;6880.449564034765;6795.524313298021;6805.183377994672;7000.61496617691;7049.929500705132;7057.752978645723;5474.671519708831;6811.421029212374;6894.13823272091;6896.517243792886;6904.344087311697 19:22:18 INFO - PROCESS | 2234 | |5;yui.html;702.3959394920367;713.664577648505;751.3650964934632;765;790.6679194738213;15525.534233972985;15749.897507174503;15784.36862525499;15787.28957196926;15791.684166316667;14297.428102875872;14464.349104290306;14467.204303763288;14484.493042743507;14506;768.2317682317696;792.8810678398257;792.9603519824014;793.0681449297082;793.2820797178534;931.8136372725448;966.9806603867919;973.737090985437;974.1476208317722;974.3277138774223;1021.6883850425618;1033.607229252883;1035.099463466785;1035.6116456328878;1036.5801850250662;819.7212947597786;1016.9745756356076;1041.234692501011;1044.3264094658978;1045.675840489447;780.8399278147966;781.5584194929903;782.2568559868091;783.506390973683;786.626352482572;15588.92205538965;15621.218939053115;15696.843031569651;15703.780724951357;15711.764323535157;13026.478940842355;13028.41372138256;13183.209007459584;13274.867251327556;13381.464741410331;10227.442541618133;10301.639442619547;10349.327293725884;10692.358458492516;10715.678529644123;3544.131687736521;3554.2180720241504;3602.963970360289;3655.707543396522;3851.229754049173;85132.72300915491;85785.57107214487;86690.56654716749;87951;88152.23695526118;9701.417914925127;9868.80262394748;9876.851847222297;9887;10117.241206909512;19203.711944320847;23094;23106.844657767044;23155.768442315697;23188.536229275658;7643.312101910855;7684.577348245788;7740.3420709240345;7742.225777422213;7926.564038977912;4185.455890734185;4284.507281662586;4313.61177494027;4332.068605249887;4591.931121033187;3835.5780864104927;3889.766614003169;3895.435161901565;3907.2185562887535;3923.3330333843314;682.689376333767;702.1574111066741;702.8613645893685;713.4043074033136;734.5592644413416;510.88505086356014;613.3988691082675;617.6818938246806;623.3019018699086;627.0155855307215;7615.466917315845;7845.882311765214;7951.840963180704;8046.919530804734;8298.377621678399;517.7618295583998;524.4414698346249;590.1973316289842;594.7977687586241;599.1851082527759;3639.161454065833;3829.2532956073296;3879.495665563515;3917.373220284741;3948.230095131479;89366.55316723375;89712;91013.54493227624;91101.17797644142;91120.08879911117;74253.62873185599;76829.23170768221;77446.61276693581;77769.83345249826;78886;65813.67093164503;65907.34092659107;65917.34082659207;66563;66863.32841678997;7486.775396738107;7729.536227826124;7843;7934.365250780039;8102.83794324122;47333;47922.5207747932;48113.75943120262;48166;48258.03483930372;59942;64620.35379646144;64781;65090.674546626964;65817.67091164514;10588.947055264674;10590.258681892194;10816.972387623164;11372.715682108013;11541.902624568493;11858.584949526725;11963.880361196276;12155.088368372231;12173.634790956285;12453.750924981268;11526.135539834379;11602.593909213138;11708.590199342982;11906.821397679216;12199.512019519474;11539.134564907497;11716.414179291172;11834.881651183723;11887.227330223508;12190.51237950472;10933.890661093288;11062.225644205151;11117.555297787998;11264.436778161224;11984.880151198377;9366.297527685314;9569.856452153363;9649.228061755182;9932.553035113293;10017.899821001696;9451.432914025181;9596.23230141601;9604.85592716096;9635.518224088628;9707.369021013612 19:22:18 INFO - PROCESS | 2234 | __end_tp_report 19:22:18 INFO - PROCESS | 2234 | __start_cc_report 19:22:18 INFO - PROCESS | 2234 | _x_x_mozilla_cycle_collect,1067 19:22:18 INFO - PROCESS | 2234 | __end_cc_report 19:22:18 INFO - PROCESS | 2234 | __startTimestamp1467944538101__endTimestamp 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | ------- Summary: start ------- 19:22:18 INFO - PROCESS | 2234 | Number of tests: 6 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#0] dojo.html Cycles:165 Average:5914.25 Median:6193.26 stddev:637.32 (10.3%) stddev-sans-first:596.25 19:22:18 INFO - PROCESS | 2234 | Values: 2979.6 3593.9 3630.1 3632.3 3692.8 5919.5 5936.4 5947.5 5964.1 5966.5 5966.0 6006.7 6012.3 6024.4 6028.5 5260.1 5297.7 5361.8 5395.5 5440.8 5388.7 5420.1 5427.4 5427.6 5438.3 5342.1 5351.8 5379.2 5403.9 5406.2 5409.7 5425.8 5436.6 5448.5 5497.3 5201.5 5261.3 5350.4 5360.9 5362.4 5736.7 5805.5 5807.2 5843.6 5854.2 6266.0 6269.5 6293.9 6294.0 6305.4 6234.6 6251.2 6305.5 6312.6 6327.7 5945.7 6041.1 6044.3 6084.4 6094.8 6412.2 6422.4 6423.5 6436.5 6443.6 6261.6 6270.4 6366.0 6377.2 6379.0 6125.3 6308.7 6321.7 6342.7 6344.9 5555.7 6254.5 6311.1 6320.0 6336.0 6241.3 6254.2 6308.8 6314.0 6345.7 5021.7 5082.5 5085.8 5092.4 5098.6 4569.8 4573.7 4579.8 4581.2 4608.4 6047.0 6108.7 6169.0 6185.1 6194.3 6306.7 6309.1 6309.2 6329.7 6330.8 5454.8 6003.4 6151.8 6171.1 6172.7 5414.2 5508.7 5544.8 5587.3 5609.3 6504.5 6524.9 6558.8 6569.2 6583.3 6234.2 6297.6 6316.3 6319.0 6320.5 6495.9 6569.3 6571.0 6586.8 6599.6 6265.2 6273.5 6278.8 6284.8 6299.3 6195.6 6233.2 6244.3 6247.0 6316.8 6278.1 6317.3 6328.7 6339.2 6346.2 6327.6 6328.7 6335.8 6336.3 6338.2 5987.4 6065.3 6143.1 6176.4 6193.3 6316.2 6325.8 6331.7 6339.8 6350.3 6153.6 6187.1 6236.7 6240.2 6245.8 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#1] ext.html Cycles:180 Average:74216.98 Median:19056.96 stddev:175437.25 (920.6%) stddev-sans-first:175842.15 19:22:18 INFO - PROCESS | 2234 | Values: 527.1 540.0 593.7 594.0 619.2 31399.1 31983.5 32008.2 32092.7 32135.0 33149.0 33657.8 33677.8 39941.4 40788.0 9484.9 9652.6 9678.1 9689.9 9707.7 9525.1 9651.2 9652.8 9653.1 9670.0 9215.7 9652.2 10136.1 11740.8 11974.0 11550.2 11652.2 11660.7 11682.5 11693.5 11506.3 11630.8 11633.7 11636.3 11638.7 38518.4 38833.0 38862.0 38927.8 39021.0 3243.7 3323.8 3334.4 3536.9 3628.4 28116.7 29007.0 29191.1 29309.1 29456.4 2758.1 2766.8 2772.3 2819.0 2824.6 491025.0 492779.5 492819.0 493751.0 494430.0 37204.4 63977.0 64294.0 64388.0 64467.5 36400.3 36435.5 36456.3 36488.6 36566.0 15924.0 15937.5 16052.2 16055.0 16076.8 13597.9 13674.7 13679.7 13680.3 13712.8 7957.8 8316.0 8374.7 8402.8 8490.0 3130.8 3421.3 3558.6 3561.9 3595.6 1009.3 1039.0 1062.4 1102.3 1235.8 22534.3 26281.9 28116.7 28758.3 30091.0 1133.4 1135.2 1146.7 1156.0 1166.9 15649.8 15726.0 15764.8 15816.5 16190.2 480927.0 624311.0 631199.0 632058.0 633740.0 54819.2 55580.9 62738.7 62842.7 63831.7 1542.4 1550.8 1564.9 1568.1 1569.7 28018.7 29298.9 29502.0 30090.7 30155.1 39545.0 48724.0 48757.0 48798.3 48859.8 801921.0 818086.0 818163.0 819967.0 821052.0 27283.9 28032.3 28090.0 42933.9 44355.6 44176.0 44413.3 44447.8 44554.0 45377.6 34577.0 35492.6 36488.3 37096.6 37169.0 35811.6 36064.5 36201.8 36923.3 36954.4 31854.4 37030.4 38018.6 38152.6 39097.0 31846.7 33844.0 34004.7 34036.8 34060.6 24973.3 25152.2 25165.7 25231.1 25237.6 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#2] jquery.html Cycles:180 Average:35787.08 Median:21356.97 stddev:108456.61 (507.8%) stddev-sans-first:108728.33 19:22:18 INFO - PROCESS | 2234 | Values: 414.4 415.4 416.8 419.6 428.0 20185.4 20444.1 21087.7 21146.5 21867.8 21146.0 21196.3 22814.4 22823.8 22901.5 5433.5 5768.7 5771.0 5778.2 5779.7 5647.1 5709.7 5728.2 5737.7 5739.2 6047.2 6113.3 6249.3 6251.3 6263.4 5639.4 6164.4 6212.9 6218.1 6224.2 5580.9 5601.6 5601.8 5611.4 5615.4 13857.7 14051.6 14315.8 14318.6 14339.4 2071.3 2197.3 2319.4 2381.9 2389.2 9975.4 10028.8 10296.4 10353.0 10616.2 1723.9 1792.7 1818.0 1847.7 1848.9 90324.5 99312.0 108732.8 111543.4 114212.9 9815.5 11569.5 11913.7 11936.9 11996.3 15348.5 15464.1 15536.8 15580.0 15586.0 9240.5 9289.9 9290.3 9310.0 9422.4 9272.5 9280.8 9289.6 9360.0 9374.3 4821.1 4845.5 4850.0 4856.5 4884.8 1992.5 2033.5 2041.2 2053.2 2061.1 900.5 940.3 1001.9 1054.8 1098.1 17264.7 20712.2 21517.7 21519.7 21763.0 990.4 1036.3 1045.1 1057.3 1060.9 10896.9 11194.6 11420.6 11450.5 11456.7 636446.0 650938.0 656346.0 663390.0 668511.0 113879.0 118080.0 124797.0 127466.4 128542.0 1031.8 1036.3 1052.2 1054.3 1054.8 18089.9 18832.5 18870.0 18918.2 19299.9 43489.3 49780.0 51864.7 55104.9 55679.0 58597.0 74948.0 76579.2 78375.6 78737.6 6960.2 8218.5 8252.3 8491.5 8584.4 9198.6 12145.5 12628.9 12960.1 13023.4 10907.7 11168.5 11198.9 11327.7 11343.0 10960.9 10984.5 11030.4 11273.4 11273.9 11240.6 11468.0 11519.9 11583.5 11807.7 8336.4 8383.7 8452.2 8473.8 8607.5 10657.9 11246.7 11516.7 11540.0 11552.5 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#3] mootools.html Cycles:180 Average:5996.57 Median:4963.16 stddev:3406.82 (68.6%) stddev-sans-first:3399.56 19:22:18 INFO - PROCESS | 2234 | Values: 1492.4 1519.7 1638.8 1868.5 1999.5 8393.7 9157.3 9319.3 9342.5 9343.7 7331.8 9236.8 9248.6 9301.7 9317.1 2298.7 2454.6 2592.7 2592.7 2595.9 2525.3 2587.5 2589.9 2592.4 2594.1 2537.9 2575.4 2581.4 2582.7 2584.7 2554.8 2573.7 2580.1 2588.1 2595.0 2530.4 2570.6 2577.3 2581.4 2583.0 8995.6 9251.8 9288.6 9305.4 9311.9 5723.3 5898.1 5964.7 5981.0 5981.6 3677.3 3742.2 3804.7 3815.4 3819.0 1053.8 1065.1 1065.9 1081.9 1110.9 12686.6 12755.0 12771.3 12775.6 12831.4 4821.4 4835.6 4849.1 4854.4 4916.9 9839.5 9840.0 9848.7 9865.5 9881.4 5687.9 5692.4 5694.2 5694.5 5696.4 3619.8 4715.5 4773.4 4773.9 5266.7 3764.2 3999.4 4009.6 4100.6 4109.1 1270.2 1271.9 1276.6 1286.9 1288.3 773.3 824.7 893.1 928.5 975.5 6095.1 6237.9 6268.0 6278.9 6283.8 976.6 982.1 996.0 1032.6 1058.6 3252.3 3337.9 4095.2 4108.8 4124.3 11264.8 11754.2 11769.9 11778.8 11782.8 11574.9 11611.3 11625.5 11715.5 11743.5 8750.0 8895.8 8973.5 8977.9 8986.7 5772.6 5951.4 6046.0 6135.4 6217.0 10129.2 10307.0 10463.9 10476.2 10512.6 10458.6 10547.1 10942.0 10955.9 10981.9 6771.4 7372.5 7507.7 7515.7 7542.7 8145.7 8504.2 8716.8 8733.0 8797.0 7624.3 7684.5 7725.8 7819.5 7838.2 7585.1 7696.0 7722.9 7763.9 7906.6 7273.8 7278.3 7330.7 7342.3 7342.6 5009.4 5038.4 5147.2 5179.9 5237.5 5120.7 5125.3 5132.8 5148.4 5241.7 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#4] prototype.html Cycles:180 Average:5778.01 Median:6463.89 stddev:1791.26 (27.7%) stddev-sans-first:1748.97 19:22:18 INFO - PROCESS | 2234 | Values: 328.9 332.7 342.5 344.0 345.8 6018.5 6600.7 6697.0 6700.2 6705.8 6295.3 6461.5 6466.2 6585.8 6612.9 4934.4 4982.2 4995.1 4998.8 5017.6 5001.4 5003.9 5009.4 5018.1 5035.2 4715.2 4824.3 4916.0 4966.5 4972.9 4081.7 4946.6 4974.5 4976.5 4984.8 4286.2 4291.3 4294.8 4304.7 4304.8 6340.6 6340.6 6343.3 6346.7 6366.3 5783.9 5861.3 5862.1 5873.8 5879.1 6789.2 7018.3 7026.5 7040.5 7050.3 4737.5 4775.3 4776.7 4776.7 4780.7 6806.5 7452.3 7458.6 7464.4 7476.3 4857.1 4860.3 4870.7 4876.4 4881.8 4131.8 4945.6 4948.5 4971.8 5000.4 5599.2 5821.2 5834.8 5834.9 5838.3 5689.3 7064.5 7064.8 7088.5 7089.4 1613.5 1699.7 1726.5 1728.4 1728.9 1046.8 1100.0 1121.2 1125.9 1128.8 6682.5 6701.9 6781.7 6788.2 6788.4 7321.6 7323.9 7340.8 7349.7 7352.7 6695.7 6769.4 6777.4 6779.4 6780.5 3726.2 3813.8 3867.4 3875.7 3893.6 7644.5 7669.5 7675.9 7684.0 7684.9 6044.8 7461.0 7500.6 7507.5 7512.0 6146.7 6210.4 7635.4 7660.5 7673.1 7022.5 7254.1 7279.2 7313.3 7315.3 5738.9 7091.5 7102.3 7153.2 7159.4 6236.6 7653.9 7657.7 7693.0 7701.6 4915.5 4916.8 4918.4 4919.7 4923.9 6906.9 7246.2 7249.7 7255.2 7271.1 6964.3 6985.7 6990.1 6999.0 7007.7 6965.0 6999.9 7004.5 7004.6 7017.5 5612.5 6819.9 6833.2 6859.3 6880.4 6795.5 6805.2 7000.6 7049.9 7057.8 5474.7 6811.4 6894.1 6896.5 6904.3 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - PROCESS | 2234 | [#5] yui.html Cycles:180 Average:18274.78 Median:24384.46 stddev:25408.72 (104.2%) stddev-sans-first:25445.73 19:22:18 INFO - PROCESS | 2234 | Values: 702.4 713.7 751.4 765.0 790.7 15525.5 15749.9 15784.4 15787.3 15791.7 14297.4 14464.3 14467.2 14484.5 14506.0 768.2 792.9 793.0 793.1 793.3 931.8 967.0 973.7 974.1 974.3 1021.7 1033.6 1035.1 1035.6 1036.6 819.7 1017.0 1041.2 1044.3 1045.7 780.8 781.6 782.3 783.5 786.6 15588.9 15621.2 15696.8 15703.8 15711.8 13026.5 13028.4 13183.2 13274.9 13381.5 10227.4 10301.6 10349.3 10692.4 10715.7 3544.1 3554.2 3603.0 3655.7 3851.2 85132.7 85785.6 86690.6 87951.0 88152.2 9701.4 9868.8 9876.9 9887.0 10117.2 19203.7 23094.0 23106.8 23155.8 23188.5 7643.3 7684.6 7740.3 7742.2 7926.6 4185.5 4284.5 4313.6 4332.1 4591.9 3835.6 3889.8 3895.4 3907.2 3923.3 682.7 702.2 702.9 713.4 734.6 510.9 613.4 617.7 623.3 627.0 7615.5 7845.9 7951.8 8046.9 8298.4 517.8 524.4 590.2 594.8 599.2 3639.2 3829.3 3879.5 3917.4 3948.2 89366.6 89712.0 91013.5 91101.2 91120.1 74253.6 76829.2 77446.6 77769.8 78886.0 65813.7 65907.3 65917.3 66563.0 66863.3 7486.8 7729.5 7843.0 7934.4 8102.8 47333.0 47922.5 48113.8 48166.0 48258.0 59942.0 64620.4 64781.0 65090.7 65817.7 10588.9 10590.3 10817.0 11372.7 11541.9 11858.6 11963.9 12155.1 12173.6 12453.8 11526.1 11602.6 11708.6 11906.8 12199.5 11539.1 11716.4 11834.9 11887.2 12190.5 10933.9 11062.2 11117.6 11264.4 11984.9 9366.3 9569.9 9649.2 9932.6 10017.9 9451.4 9596.2 9604.9 9635.5 9707.4 19:22:18 INFO - PROCESS | 2234 | -------- Summary: end -------- 19:22:18 INFO - PROCESS | 2234 | 19:22:18 INFO - TEST-INFO | 2234: exit 0 19:22:18 INFO - TEST-OK | dromaeo_css | took 1112669ms 19:22:18 INFO - TEST-START | kraken 19:22:18 INFO - operating with platform_type : mac_ 19:22:18 INFO - Initialising browser for kraken test... 19:22:18 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp_zcjEK/profile http://localhost:51398/getInfo.html) 19:22:20 INFO - PROCESS | 2236 | __metrics Screen width/height:1600/1200 19:22:20 INFO - PROCESS | 2236 | colorDepth:24 19:22:20 INFO - PROCESS | 2236 | Browser inner width/height: 1024/689 19:22:20 INFO - PROCESS | 2236 | __metrics 19:22:20 INFO - PROCESS | 2236 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:22:20 ERROR - PROCESS | 2236 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:22:21 INFO - TEST-INFO | 2236: exit 0 19:22:21 INFO - Browser initialized. 19:22:21 INFO - Running cycle 1/1 for kraken test... 19:22:21 INFO - TEST-INFO | started process 2239 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp_zcjEK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:33 INFO - PROCESS | 2239 | RSS: Main: 161603584 19:22:33 INFO - PROCESS | 2239 | 19:22:36 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:36 INFO - PROCESS | 2239 | RSS: Main: 223875072 19:22:36 INFO - PROCESS | 2239 | 19:22:39 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-dft) 19:22:40 INFO - PROCESS | 2239 | RSS: Main: 239800320 19:22:40 INFO - PROCESS | 2239 | 19:22:43 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-fft) 19:22:43 INFO - PROCESS | 2239 | RSS: Main: 324198400 19:22:43 INFO - PROCESS | 2239 | 19:22:46 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51398/tests/kraken/driver.html?testName=audio-oscillator) 19:22:46 INFO - PROCESS | 2239 | RSS: Main: 231542784 19:22:46 INFO - PROCESS | 2239 | 19:22:48 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:49 INFO - PROCESS | 2239 | RSS: Main: 231731200 19:22:49 INFO - PROCESS | 2239 | 19:22:52 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:52 INFO - PROCESS | 2239 | RSS: Main: 269336576 19:22:52 INFO - PROCESS | 2239 | 19:22:55 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51398/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:56 INFO - PROCESS | 2239 | RSS: Main: 270381056 19:22:56 INFO - PROCESS | 2239 | 19:22:58 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51398/tests/kraken/driver.html?testName=json-parse-financial) 19:22:59 INFO - PROCESS | 2239 | RSS: Main: 269463552 19:22:59 INFO - PROCESS | 2239 | 19:23:01 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51398/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:01 INFO - PROCESS | 2239 | RSS: Main: 260579328 19:23:01 INFO - PROCESS | 2239 | 19:23:03 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:04 INFO - PROCESS | 2239 | RSS: Main: 266448896 19:23:04 INFO - PROCESS | 2239 | 19:23:06 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:07 INFO - PROCESS | 2239 | RSS: Main: 270684160 19:23:07 INFO - PROCESS | 2239 | 19:23:09 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:10 INFO - PROCESS | 2239 | RSS: Main: 278196224 19:23:10 INFO - PROCESS | 2239 | 19:23:13 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:14 INFO - PROCESS | 2239 | RSS: Main: 275124224 19:23:14 INFO - PROCESS | 2239 | 19:23:15 INFO - PROCESS | 2239 | Cycle 1(1): loaded http://localhost:51398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51398/tests/kraken/driver.html?testName=ai-astar) 19:23:16 INFO - PROCESS | 2239 | RSS: Main: 336736256 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | __start_tp_report 19:23:16 INFO - PROCESS | 2239 | _x_x_mozilla_page_load 19:23:16 INFO - PROCESS | 2239 | _x_x_mozilla_page_load_details 19:23:16 INFO - PROCESS | 2239 | |i|pagename|runs| 19:23:16 INFO - PROCESS | 2239 | |0;ai-astar;113;113;120;114;112;113;113;114;115;133 19:23:16 INFO - PROCESS | 2239 | |1;audio-beat-detection;181;151;144;163;119;142;137;118;171;116 19:23:16 INFO - PROCESS | 2239 | |2;audio-dft;185;187;187;187;187;185;185;187;187;185 19:23:16 INFO - PROCESS | 2239 | |3;audio-fft;71;79;75;150;56;74;85;89;147;56 19:23:16 INFO - PROCESS | 2239 | |4;audio-oscillator;90;89;139;78;86;90;129;81;77;127 19:23:16 INFO - PROCESS | 2239 | |5;imaging-gaussian-blur;90;87;90;88;90;86;91;88;90;86 19:23:16 INFO - PROCESS | 2239 | |6;imaging-darkroom;95;104;147;94;94;95;95;95;94;95 19:23:16 INFO - PROCESS | 2239 | |7;imaging-desaturate;83;84;86;84;86;85;85;84;84;83 19:23:16 INFO - PROCESS | 2239 | |8;json-parse-financial;60;63;64;62;63;63;64;81;58;56 19:23:16 INFO - PROCESS | 2239 | |9;json-stringify-tinderbox;63;63;61;76;73;70;64;65;66;67 19:23:16 INFO - PROCESS | 2239 | |10;stanford-crypto-aes;90;96;81;79;78;93;101;100;80;84 19:23:16 INFO - PROCESS | 2239 | |11;stanford-crypto-ccm;131;138;121;137;146;134;135;123;146;151 19:23:16 INFO - PROCESS | 2239 | |12;stanford-crypto-pbkdf2;165;165;165;162;166;168;210;157;163;162 19:23:16 INFO - PROCESS | 2239 | |13;stanford-crypto-sha256-iterative;66;67;68;67;67;65;68;68;67;65 19:23:16 INFO - PROCESS | 2239 | __end_tp_report 19:23:16 INFO - PROCESS | 2239 | __start_cc_report 19:23:16 INFO - PROCESS | 2239 | _x_x_mozilla_cycle_collect,1992 19:23:16 INFO - PROCESS | 2239 | __end_cc_report 19:23:16 INFO - PROCESS | 2239 | __startTimestamp1467944596007__endTimestamp 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | ------- Summary: start ------- 19:23:16 INFO - PROCESS | 2239 | Number of tests: 14 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#0] ai-astar Cycles:10 Average:116.00 Median:114.00 stddev:6.38 (5.6%) stddev-sans-first:6.67 19:23:16 INFO - PROCESS | 2239 | Values: 113.0 113.0 120.0 114.0 112.0 113.0 113.0 114.0 115.0 133.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:147.50 stddev:22.72 (15.4%) stddev-sans-first:19.81 19:23:16 INFO - PROCESS | 2239 | Values: 181.0 151.0 144.0 163.0 119.0 142.0 137.0 118.0 171.0 116.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#2] audio-dft Cycles:10 Average:186.20 Median:187.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 19:23:16 INFO - PROCESS | 2239 | Values: 185.0 187.0 187.0 187.0 187.0 185.0 185.0 187.0 187.0 185.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#3] audio-fft Cycles:10 Average:88.20 Median:74.50 stddev:33.53 (45.0%) stddev-sans-first:34.98 19:23:16 INFO - PROCESS | 2239 | Values: 71.0 79.0 75.0 150.0 56.0 74.0 85.0 89.0 147.0 56.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:83.50 stddev:23.48 (28.1%) stddev-sans-first:24.70 19:23:16 INFO - PROCESS | 2239 | Values: 90.0 89.0 139.0 78.0 86.0 90.0 129.0 81.0 77.0 127.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:1.84 (2.0%) stddev-sans-first:1.88 19:23:16 INFO - PROCESS | 2239 | Values: 90.0 87.0 90.0 88.0 90.0 86.0 91.0 88.0 90.0 86.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:95.00 stddev:16.50 (17.4%) stddev-sans-first:17.37 19:23:16 INFO - PROCESS | 2239 | Values: 95.0 104.0 147.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:1.07 (1.3%) stddev-sans-first:1.01 19:23:16 INFO - PROCESS | 2239 | Values: 83.0 84.0 86.0 84.0 86.0 85.0 85.0 84.0 84.0 83.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:6.74 (10.7%) stddev-sans-first:7.03 19:23:16 INFO - PROCESS | 2239 | Values: 60.0 63.0 64.0 62.0 63.0 63.0 64.0 81.0 58.0 56.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:4.80 (7.2%) stddev-sans-first:4.89 19:23:16 INFO - PROCESS | 2239 | Values: 63.0 63.0 61.0 76.0 73.0 70.0 64.0 65.0 66.0 67.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:82.50 stddev:8.92 (10.8%) stddev-sans-first:9.43 19:23:16 INFO - PROCESS | 2239 | Values: 90.0 96.0 81.0 79.0 78.0 93.0 101.0 100.0 80.0 84.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:137.50 stddev:9.74 (7.1%) stddev-sans-first:10.15 19:23:16 INFO - PROCESS | 2239 | Values: 131.0 138.0 121.0 137.0 146.0 134.0 135.0 123.0 146.0 151.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:165.00 stddev:14.95 (9.1%) stddev-sans-first:15.81 19:23:16 INFO - PROCESS | 2239 | Values: 165.0 165.0 165.0 162.0 166.0 168.0 210.0 157.0 163.0 162.0 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - PROCESS | 2239 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.17 19:23:16 INFO - PROCESS | 2239 | Values: 66.0 67.0 68.0 67.0 67.0 65.0 68.0 68.0 67.0 65.0 19:23:16 INFO - PROCESS | 2239 | -------- Summary: end -------- 19:23:16 INFO - PROCESS | 2239 | 19:23:16 INFO - TEST-INFO | 2239: exit 0 19:23:16 INFO - TEST-OK | kraken | took 58164ms 19:23:16 INFO - SUITE-END | took 1170s 19:23:17 INFO - Completed test suite (00:19:31) 19:23:17 INFO - javascript benchmark 19:23:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.6126503554533, 3593.9101522461933, 3630.1469154748647, 3632.255387645533, 3692.7784332940028, 5919.467247947684, 5936.376680448545, 5947.494462970647, 5964.105384192368, 5966.5226781857455, 5965.970170149154, 6006.729697163627, 6012.338642749294, 6024.397560243984, 6028.517718582514, 5260.132078207092, 5297.708626025567, 5361.758720857571, 5395.514403703666, 5440.782368705247, 5388.676679399248, 5420.051490989081, 5427.375851777057, 5427.592930530206, 5438.293021907147, 5342.1452567589195, 5351.759170837322, 5379.220013098098, 5403.891922161554, 5406.189071639246, 5409.675419474825, 5425.782968681248, 5436.565074794046, 5448.482394172547, 5497.340319161686, 5201.505856943584, 5261.342332208474, 5350.35795704514, 5360.892782144335, 5362.410134885159, 5736.713164341766, 5805.477507024388, 5807.157962095514, 5843.561732870009, 5854.2096816930025, 6265.9610089106745, 6269.467095296905, 6293.905591416133, 6294.024426213944, 6305.4009869062365, 6234.594751341148, 6251.218597675291, 6305.527085468562, 6312.589681670723, 6327.683615819191, 5945.671944419593, 6041.093835924603, 6044.335123136451, 6084.391560843968, 6094.817155485387, 6412.23053233615, 6422.357764223634, 6423.454006409414, 6436.549441539141, 6443.613383197023, 6261.5616906816995, 6270.404311590391, 6366.045093235959, 6377.23473183221, 6379.0, 6125.326214116443, 6308.747650093945, 6321.683915804191, 6342.746290148435, 6344.936550634435, 5555.694436806015, 6254.499640028786, 6311.053341998645, 6319.957207060876, 6335.968320158462, 6241.251049874044, 6254.249490061222, 6308.779192728232, 6313.958196897461, 6345.746170153235, 5021.72380519075, 5082.542571168613, 5085.821996230188, 5092.439831618519, 5098.566621837112, 4569.840055598038, 4573.725576465423, 4579.771011449414, 4581.221192397301, 4608.354830323758, 6046.969765151146, 6108.72510737009, 6169.043798211284, 6185.103160041769, 6194.256689197326, 6306.716197771111, 6309.053641953652, 6309.211348581427, 6329.715162817684, 6330.8100756977365, 5454.809081682122, 6003.3996600339615, 6151.815445536641, 6171.13604095427, 6172.722227499773, 5414.242006119146, 5508.6970216637665, 5544.833654990276, 5587.3015873015875, 5609.326880774252, 6504.5121615879, 6524.934750652527, 6558.770443034662, 6569.211694596488, 6583.341665833378, 6234.220722409699, 6297.622142671455, 6316.336784637547, 6319.020551814476, 6320.462760665395, 6495.935040649533, 6569.310222426577, 6570.967145164243, 6586.769463068769, 6599.571027883172, 6265.154204182377, 6273.466755325666, 6278.780242691484, 6284.780032698834, 6299.275583307795, 6195.597286176384, 6233.158523599437, 6244.313125556276, 6246.968765156145, 6316.842078948063, 6278.0896769967185, 6317.305096439296, 6328.746850125944, 6339.2392912850755, 6346.174997250328, 6327.588706734047, 6328.7152078157515, 6335.778247761306, 6336.334684858208, 6338.239411270677, 5987.43119403656, 6065.272167339947, 6143.082036032849, 6176.4441200292185, 6193.256809182927, 6316.242050953915, 6325.810225693236, 6331.651759153291, 6339.778107766206, 6350.301466838737, 6153.5692501526255, 6187.133801267916, 6236.719347629459, 6240.188775459162, 6245.843853903689], "value": 5874.235075732775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.061829942702, 540.0441219042295, 593.7387549478226, 594.0435898203891, 619.2352444730759, 31399.058028259133, 31983.52024719631, 32008.199795005108, 32092.67907320926, 32135.0, 33149.0, 33657.83171084141, 33677.831610841975, 39941.400878986766, 40787.980300492505, 9484.905150948505, 9652.565634546463, 9678.080582344666, 9689.854652180187, 9707.660231891885, 9525.142737153656, 9651.179649729782, 9652.806943861118, 9653.131218190361, 9669.95165024174, 9215.723528294162, 9652.227821774277, 10136.13842823361, 11740.823887641693, 11974.0, 11550.191486595899, 11652.242604230698, 11660.650180494598, 11682.532698692043, 11693.473793679219, 11506.252093613888, 11630.825537616942, 11633.6509904703, 11636.301821890713, 11638.70903227426, 38518.42222366667, 38833.0, 38862.0, 38927.805360973296, 39021.0, 3243.7405007599336, 3323.7839540429795, 3334.3831391192466, 3536.929261414783, 3628.3650361186687, 28116.718832811614, 29006.984755533667, 29191.124266272047, 29309.12072637824, 29456.410871782446, 2758.1449750577185, 2766.806323557352, 2772.2989261450784, 2818.957715634267, 2824.61867647867, 491025.0, 492779.53610232077, 492819.0, 493751.0, 494430.0, 37204.44193337102, 63977.0, 64294.0, 64388.0, 64467.48727589117, 36400.27199456049, 36435.453468198, 36456.27087458289, 36488.635113648525, 36566.0, 15924.044557326366, 15937.521874343789, 16052.197390130446, 16054.956427832154, 16076.75884861728, 13597.932010339884, 13674.726505469835, 13679.658008549866, 13680.31598420075, 13712.794308085387, 7957.8408431832195, 8316.0, 8374.748757537283, 8402.789930251793, 8490.004848860513, 3130.7651926105177, 3421.3328400962073, 3558.626344233818, 3561.8753343632848, 3595.6044835068124, 1009.2733232072895, 1038.9636362727267, 1062.3519653011656, 1102.3330884814732, 1235.7960936445565, 22534.32397028092, 26281.948722050904, 28116.71883281182, 28758.281042974093, 30091.0, 1133.4162906103363, 1135.2110283353156, 1146.696125526736, 1155.9884401156048, 1166.8658104318113, 15649.765253521206, 15726.0, 15764.76352854708, 15816.52550423489, 16190.190490475428, 480927.0, 624311.0, 631199.0, 632058.0, 633740.0, 54819.17771233435, 55580.88838223294, 62738.686306568175, 62842.68578657077, 63831.680841595495, 1542.367629271993, 1550.7906432631676, 1564.8904576679522, 1568.05916450129, 1569.709603723292, 28018.71981280161, 29298.853505732335, 29501.96743113981, 30090.699093009665, 30155.09534713962, 39545.0, 48724.0, 48757.0, 48798.268025980346, 48859.778505537644, 801921.0, 818086.0, 818163.0, 819967.0, 821052.0, 27283.863580682762, 28032.29919252035, 28090.0, 42933.92665183396, 44355.55644443514, 44176.0, 44413.33379999238, 44447.777761110985, 44554.0, 45377.63867083993, 34577.0, 35492.645073548934, 36488.27023459569, 37096.629033709316, 37169.0, 35811.64188358083, 36064.45903311505, 36201.81899090593, 36923.261534768615, 36954.44568331423, 31854.36291274115, 37030.44454333241, 38018.61981380151, 38152.61847381491, 39097.0, 31846.68153318437, 33844.0, 34004.65995340015, 34036.82981585076, 34060.637574496744, 24973.250802475955, 25152.24543263705, 25165.748342517072, 25231.11691090803, 25237.611931343217], "value": 19109.91451689832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.37636357282304, 415.4059694636672, 416.81451753969475, 419.63701398290476, 427.9572042795719, 20185.394438166877, 20444.08001639926, 21087.683684744723, 21146.471338216554, 21867.781322186773, 21146.048427820748, 21196.25813096542, 22814.429639259026, 22823.771762282373, 22901.541969160608, 5433.510984011438, 5768.740406681688, 5770.971145144289, 5778.219940308068, 5779.682117483537, 5647.09646456567, 5709.74306156224, 5728.16941543476, 5737.741801618937, 5739.225204597367, 6047.183630209909, 6113.296970848342, 6249.3438188990185, 6251.343608921066, 6263.373662633746, 5639.436056394369, 6164.4143806338325, 6212.9068063979075, 6218.098375735538, 6224.221972253491, 5580.91628625571, 5601.635893666939, 5601.803936862231, 5611.382747897728, 5615.410381909923, 13857.653558661013, 14051.64870878226, 14315.78526322106, 14318.642033949234, 14339.354729037219, 2071.3164655663745, 2197.2748992832326, 2319.4085508195303, 2381.8570885746913, 2389.223502361722, 9975.351602145909, 10028.849567256497, 10296.382217066925, 10353.01646343596, 10616.203784716177, 1723.9053201217191, 1792.7131658934509, 1817.972730409045, 1847.7413162157309, 1848.9445316640522, 90324.54837725835, 99312.0, 108732.82534349347, 111543.44228278888, 114212.85787142106, 9815.509224538744, 11569.537218511334, 11913.702157446132, 11936.880631193751, 11996.340201288838, 15348.539543813704, 15464.072155670696, 15536.844631553766, 15580.0, 15585.986910850985, 9240.491772952551, 9289.90710092904, 9290.303227257982, 9310.0224476429, 9422.387544809566, 9272.536373181314, 9280.767980800534, 9289.581968811419, 9359.953200233955, 9374.343795934356, 4821.083994041121, 4845.53967373099, 4849.975750121227, 4856.465788763233, 4884.755762211947, 1992.4819546917906, 2033.4916270932267, 2041.1529215375454, 2053.2342185720267, 2061.1137210999414, 900.5407242306339, 940.2618944128963, 1001.8547310639916, 1054.847047178155, 1098.0995583621514, 17264.74102888458, 20712.171513139307, 21517.67723484149, 21519.67720484194, 21763.020664069838, 990.3958585262984, 1036.300497164411, 1045.1012129568717, 1057.318029870729, 1060.867391576053, 10896.891031089588, 11194.552217911356, 11420.600278990196, 11450.484728187252, 11456.713582160513, 636446.0, 650938.0, 656346.0, 663390.0, 668511.0, 113879.0, 118080.0, 124797.0, 127466.36266818793, 128542.0, 1031.8297480915714, 1036.2538971940191, 1052.2371280821496, 1054.3463052907246, 1054.8206804843196, 18089.909550452165, 18832.52918677044, 18869.962152081767, 18918.243270269584, 19299.938503381887, 43489.34765978449, 49780.0, 51864.74067629638, 55104.89790204093, 55679.0, 58597.0, 74948.0, 76579.23420765944, 78375.60812195903, 78737.60631196808, 6960.234374218933, 8218.465799722999, 8252.33981281484, 8491.532965686947, 8584.356173286904, 9198.586063627286, 12145.514179433078, 12628.936855315664, 12960.092793504742, 13023.413946372626, 10907.727306817393, 11168.497417616389, 11198.88801112011, 11327.716807079889, 11342.97913187817, 10960.945195273973, 10984.505697243483, 11030.393328367018, 11273.379964102052, 11273.887261127611, 11240.606578769704, 11468.0, 11519.94240028828, 11583.478743456733, 11807.704807379885, 8336.416450848383, 8383.706570270011, 8452.239298463168, 8473.788155296166, 8607.526586037828, 10657.946710266398, 11246.718832029264, 11516.712082198012, 11540.019098376732, 11552.537898483966], "value": 9614.425803003545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.4030387844855, 1519.7492413751731, 1638.7869576954997, 1868.4581471373303, 1999.4801351648566, 8393.664253429863, 9157.267418606512, 9319.301052421079, 9342.532873356331, 9343.719688409341, 7331.816704582388, 9236.815263694722, 9248.630054797817, 9301.720948371543, 9317.06829317068, 2298.747137814839, 2454.600877499826, 2592.675915510561, 2592.7277635848245, 2595.8572278524675, 2525.3434107132093, 2587.4695687384137, 2589.948201035978, 2592.44262483566, 2594.1050337633583, 2537.8731063446753, 2575.446279050004, 2581.3933725574475, 2582.6771653543306, 2584.6639936808187, 2554.757298056691, 2573.691157061146, 2580.148550978182, 2588.0682954136496, 2595.0268649256527, 2530.430653103037, 2570.6144078388206, 2577.3298942274955, 2581.4062765563835, 2583.044273618773, 8995.55022248885, 9251.814963700755, 9288.628454861797, 9305.395149315273, 9311.860322095106, 5723.313202415695, 5898.085796701518, 5964.701764911737, 5981.043033114681, 5981.611195272337, 3677.3380791457525, 3742.2141350316465, 3804.733668643196, 3815.4467602197524, 3819.0452386903276, 1053.8208504554243, 1065.1053115383115, 1065.8880817514205, 1081.9242653014292, 1110.8722496912878, 12686.619401417973, 12755.0, 12771.297578633079, 12775.552855650101, 12831.422585983653, 4821.373221481185, 4835.588974937099, 4849.102915960559, 4854.441739199967, 4916.877078073006, 9839.508024598885, 9840.0, 9848.704538863845, 9865.457399842933, 9881.357711748713, 5687.857803554944, 5692.37383887772, 5694.202811606378, 5694.544436445074, 5696.430356964271, 3619.8371073301764, 4715.481297057321, 4773.403324584427, 4773.880652983703, 5266.7366631668265, 3764.1906989997283, 3999.440078389028, 4009.6391324780325, 4100.630943215066, 4109.075458021981, 1270.244204698203, 1271.8982481401465, 1276.610633756713, 1286.852012018611, 1288.3171918883006, 773.307889438949, 824.7072289337319, 893.145431695231, 928.4846909964899, 975.48299401316, 6095.110515740134, 6237.875242495215, 6268.0, 6278.874422511524, 6283.8114856554375, 976.6337623391229, 982.111189373618, 996.0338471682456, 1032.550840384435, 1058.5659879449388, 3252.3332716793, 3337.8831740889436, 4095.1809638072505, 4108.753474791522, 4124.340105583153, 11264.831027534594, 11754.177207595387, 11769.941150294193, 11778.823317650242, 11782.764344713058, 11574.88425115755, 11611.303321800719, 11625.534978600761, 11715.472803723853, 11743.47154378055, 8749.956250218707, 8895.777605559913, 8973.50645714479, 8977.865332020025, 8986.685466008788, 5772.5959182856795, 5951.434613711691, 6046.032634778414, 6135.417135372132, 6217.0, 10129.189664826943, 10307.0, 10463.94768026155, 10476.161907047266, 10512.632057877938, 10458.633947812094, 10547.103496202908, 10942.0, 10955.890441095487, 10981.890181098086, 6771.3905748482875, 7372.520786148883, 7507.737229196952, 7515.699372025277, 7542.698292068256, 8145.714899978472, 8504.192101750325, 8716.825663486821, 8733.039365669898, 8797.0, 7624.313811756969, 7684.500507466997, 7725.768226953201, 7819.452638315263, 7838.176991415819, 7585.087215633372, 7695.961520192363, 7722.922770772445, 7763.922360776546, 7906.604669766603, 7273.818154545967, 7278.308560686726, 7330.743423980135, 7342.265773422615, 7342.632868356668, 5009.448960614257, 5038.445770965118, 5147.150720131136, 5179.92230116541, 5237.502437268454, 5120.667156634807, 5125.308083408841, 5132.8460146195675, 5148.43367229612, 5241.737913104405], "value": 4804.073663147564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.89310973933476, 332.678964798969, 342.45720532955266, 344.0401280427607, 345.77697385186553, 6018.518518518519, 6600.669966501674, 6697.0, 6700.229473610536, 6705.832354191148, 6295.338989406104, 6461.547691661585, 6466.224053113633, 6585.802425927218, 6612.900806487906, 4934.358533390654, 4982.202847544394, 4995.100881841286, 4998.750062496861, 5017.623678224129, 5001.424836143854, 5003.874903127433, 5009.398872135349, 5018.09312461266, 5035.194368900977, 4715.174844402233, 4824.348712923763, 4915.975420122894, 4966.528179822929, 4972.925406118911, 4081.7142800004012, 4946.604271658259, 4974.452810190913, 4976.502349765031, 4984.750762461898, 4286.228478873802, 4291.291936830419, 4294.849680261207, 4304.720193187432, 4304.849330273425, 6340.587861788969, 6340.587861789015, 6343.27052388972, 6346.682665866688, 6366.299707032223, 5783.884322313572, 5861.296644402656, 5862.091375836752, 5873.823785286406, 5879.059350503899, 6789.219239787439, 7018.33325834045, 7026.508144429892, 7040.507164498487, 7050.259722729091, 4737.502562230985, 4775.331453596499, 4776.689515181537, 4776.737279449629, 4780.737059461728, 6806.523543351967, 7452.254774522558, 7458.6270686466005, 7464.365528930048, 7476.25237476248, 4857.052874689472, 4860.3195552622665, 4870.732109733928, 4876.414830220397, 4881.755912204376, 4131.793410329472, 4945.554900059012, 4948.455669876311, 4971.825986090542, 5000.374953130859, 5599.160125981135, 5821.155932389865, 5834.766609335664, 5834.912476312858, 5838.2702162229725, 5689.288838895138, 7064.540804847668, 7064.7527336544, 7088.539244949062, 7089.432845372357, 1613.532075698058, 1699.6855581717423, 1726.507945235627, 1728.4037007232484, 1728.9049102299243, 1046.785408991155, 1099.961501347449, 1121.159130652011, 1125.8986691197667, 1128.7686024364984, 6682.465402767767, 6701.865962680719, 6781.694823732944, 6788.151481064867, 6788.389044985975, 7321.63391830417, 7323.853522929511, 7340.779776606711, 7349.7060117595765, 7352.669129889167, 6695.698693558801, 6769.356911093439, 6777.390034896883, 6779.35596118368, 6780.457563394916, 3726.1988672435014, 3813.828377723009, 3867.3812190049457, 3875.6511913927884, 3893.5717071122153, 7644.464887457936, 7669.501482403737, 7675.884861727079, 7684.0, 7684.923150768421, 6044.818655440344, 7460.962695186489, 7500.624968751541, 7507.549547027196, 7512.0, 6146.7233974471255, 6210.378962103844, 7635.42734294919, 7660.5020673657145, 7673.117591477052, 7022.473314501331, 7254.129504459499, 7279.235680253497, 7313.341799238094, 7315.268473152855, 5738.942610573841, 7091.503594748318, 7102.325279098477, 7153.213146553979, 7159.355657990805, 6236.594621349598, 7653.9234607655435, 7657.6554055066545, 7692.9615351922885, 7701.614919254127, 4915.5330243626795, 4916.803327866845, 4918.360613120271, 4919.680220785637, 4923.852284431473, 6906.93093069083, 7246.166690830411, 7249.710011599477, 7255.238199988925, 7271.091113610799, 6964.268751781193, 6985.685644146127, 6990.126234220723, 6999.020137180901, 7007.7196912122945, 6965.0, 6999.930000700131, 7004.474664400089, 7004.649767511502, 7017.543859649107, 5612.540739407702, 6819.874720671034, 6833.180018397626, 6859.348361905611, 6880.449564034765, 6795.524313298021, 6805.183377994672, 7000.61496617691, 7049.929500705132, 7057.752978645723, 5474.671519708831, 6811.421029212374, 6894.13823272091, 6896.517243792886, 6904.344087311697], "value": 5186.553575763734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.3959394920367, 713.664577648505, 751.3650964934632, 765.0, 790.6679194738213, 15525.534233972985, 15749.897507174503, 15784.36862525499, 15787.28957196926, 15791.684166316667, 14297.428102875872, 14464.349104290306, 14467.204303763288, 14484.493042743507, 14506.0, 768.2317682317696, 792.8810678398257, 792.9603519824014, 793.0681449297082, 793.2820797178534, 931.8136372725448, 966.9806603867919, 973.737090985437, 974.1476208317722, 974.3277138774223, 1021.6883850425618, 1033.607229252883, 1035.099463466785, 1035.6116456328878, 1036.5801850250662, 819.7212947597786, 1016.9745756356076, 1041.234692501011, 1044.3264094658978, 1045.675840489447, 780.8399278147966, 781.5584194929903, 782.2568559868091, 783.506390973683, 786.626352482572, 15588.92205538965, 15621.218939053115, 15696.843031569651, 15703.780724951357, 15711.764323535157, 13026.478940842355, 13028.41372138256, 13183.209007459584, 13274.867251327556, 13381.464741410331, 10227.442541618133, 10301.639442619547, 10349.327293725884, 10692.358458492516, 10715.678529644123, 3544.131687736521, 3554.2180720241504, 3602.963970360289, 3655.707543396522, 3851.229754049173, 85132.72300915491, 85785.57107214487, 86690.56654716749, 87951.0, 88152.23695526118, 9701.417914925127, 9868.80262394748, 9876.851847222297, 9887.0, 10117.241206909512, 19203.711944320847, 23094.0, 23106.844657767044, 23155.768442315697, 23188.536229275658, 7643.312101910855, 7684.577348245788, 7740.3420709240345, 7742.225777422213, 7926.564038977912, 4185.455890734185, 4284.507281662586, 4313.61177494027, 4332.068605249887, 4591.931121033187, 3835.5780864104927, 3889.766614003169, 3895.435161901565, 3907.2185562887535, 3923.3330333843314, 682.689376333767, 702.1574111066741, 702.8613645893685, 713.4043074033136, 734.5592644413416, 510.88505086356014, 613.3988691082675, 617.6818938246806, 623.3019018699086, 627.0155855307215, 7615.466917315845, 7845.882311765214, 7951.840963180704, 8046.919530804734, 8298.377621678399, 517.7618295583998, 524.4414698346249, 590.1973316289842, 594.7977687586241, 599.1851082527759, 3639.161454065833, 3829.2532956073296, 3879.495665563515, 3917.373220284741, 3948.230095131479, 89366.55316723375, 89712.0, 91013.54493227624, 91101.17797644142, 91120.08879911117, 74253.62873185599, 76829.23170768221, 77446.61276693581, 77769.83345249826, 78886.0, 65813.67093164503, 65907.34092659107, 65917.34082659207, 66563.0, 66863.32841678997, 7486.775396738107, 7729.536227826124, 7843.0, 7934.365250780039, 8102.83794324122, 47333.0, 47922.5207747932, 48113.75943120262, 48166.0, 48258.03483930372, 59942.0, 64620.35379646144, 64781.0, 65090.674546626964, 65817.67091164514, 10588.947055264674, 10590.258681892194, 10816.972387623164, 11372.715682108013, 11541.902624568493, 11858.584949526725, 11963.880361196276, 12155.088368372231, 12173.634790956285, 12453.750924981268, 11526.135539834379, 11602.593909213138, 11708.590199342982, 11906.821397679216, 12199.512019519474, 11539.134564907497, 11716.414179291172, 11834.881651183723, 11887.227330223508, 12190.51237950472, 10933.890661093288, 11062.225644205151, 11117.555297787998, 11264.436778161224, 11984.880151198377, 9366.297527685314, 9569.856452153363, 9649.228061755182, 9932.553035113293, 10017.899821001696, 9451.432914025181, 9596.23230141601, 9604.85592716096, 9635.518224088628, 9707.369021013612], "value": 7039.550117192425, "unit": "score"}], "name": "dromaeo_css", "value": 7577.630727214205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 120.0, 114.0, 112.0, 113.0, 113.0, 114.0, 115.0, 133.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 151.0, 144.0, 163.0, 119.0, 142.0, 137.0, 118.0, 171.0, 116.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 187.0, 187.0, 187.0, 185.0, 185.0, 187.0, 187.0, 185.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 75.0, 150.0, 56.0, 74.0, 85.0, 89.0, 147.0, 56.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 139.0, 78.0, 86.0, 90.0, 129.0, 81.0, 77.0, 127.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 88.0, 90.0, 86.0, 91.0, 88.0, 90.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 147.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 84.0, 86.0, 85.0, 85.0, 84.0, 84.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 81.0, 58.0, 56.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 76.0, 73.0, 70.0, 64.0, 65.0, 66.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 96.0, 81.0, 79.0, 78.0, 93.0, 101.0, 100.0, 80.0, 84.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 121.0, 137.0, 146.0, 134.0, 135.0, 123.0, 146.0, 151.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 162.0, 166.0, 168.0, 210.0, 157.0, 163.0, 162.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 67.0, 67.0, 65.0, 68.0, 68.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1496.7, "alertThreshold": 2.0}]} 19:23:17 INFO - Return code: 0 19:23:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:23:17 ERROR - # TBPL SUCCESS # 19:23:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:23:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:23:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:23:17 INFO - 2016-07-07 19:23:17.337 screenresolution[2243:18730] starting screenresolution argv=screenresolution get 19:23:17 INFO - 2016-07-07 19:23:17.340 screenresolution[2243:18730] Display 0: 1600x1200x32@60 19:23:17 INFO - 2016-07-07 19:23:17.346 screenresolution[2244:18733] starting screenresolution argv=screenresolution list 19:23:17 INFO - Available Modes on Display 0 19:23:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:23:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:23:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:23:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:23:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:23:17 INFO - Intel Iris: 19:23:17 INFO - Chipset Model: Intel Iris 19:23:17 INFO - Type: GPU 19:23:17 INFO - Bus: Built-In 19:23:17 INFO - VRAM (Dynamic, Max): 1536 MB 19:23:17 INFO - Vendor: Intel (0x8086) 19:23:17 INFO - Device ID: 0x0a2e 19:23:17 INFO - Revision ID: 0x0009 19:23:17 INFO - Displays: 19:23:17 INFO - Display: 19:23:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:23:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:23:17 INFO - Display Serial Number: 1600x1200 60 19:23:17 INFO - Main Display: Yes 19:23:17 INFO - Mirror: Off 19:23:17 INFO - Online: Yes 19:23:17 INFO - Rotation: Supported 19:23:17 INFO - Return code: 0 19:23:17 INFO - Running post-action listener: _resource_record_post_action 19:23:17 INFO - Running post-run listener: _resource_record_post_run 19:23:18 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 536576; Write bytes: 492412928; Read time: 4; Write time: 1515 19:23:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191097344; Write bytes: 185853952; Read time: 17346; Write time: 394 19:23:18 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 536576; Write bytes: 295770112; Read time: 4; Write time: 1084 19:23:18 INFO - Running post-run listener: _upload_blobber_files 19:23:18 INFO - Blob upload gear active. 19:23:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23:18 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 19:23:18 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'] 19:23:18 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 19:23:19 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:23:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:20 INFO - (blobuploader) - INFO - Done attempting. 19:23:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:23:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:23:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:21 INFO - (blobuploader) - INFO - Done attempting. 19:23:21 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:21 INFO - Return code: 0 19:23:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2289ded4fe647e0860263c20ed3499c56c1632bc61fe20fb7a26e5ac8c5fc4d54b2d4281a9847d6f8ee3b3c2d8b40c75d91a31122d635b729c86158f34e8b80c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/daf42892dad32caa20f0c1cbc967aa0ba944f6a54343b424789513069521b36996576b8d5afb80031170878bdc1dbe86c66b0c9b6a9fc8849b19acbea0ddc1f4"} 19:23:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:21 INFO - Contents: 19:23:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2289ded4fe647e0860263c20ed3499c56c1632bc61fe20fb7a26e5ac8c5fc4d54b2d4281a9847d6f8ee3b3c2d8b40c75d91a31122d635b729c86158f34e8b80c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/daf42892dad32caa20f0c1cbc967aa0ba944f6a54343b424789513069521b36996576b8d5afb80031170878bdc1dbe86c66b0c9b6a9fc8849b19acbea0ddc1f4"} 19:23:21 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:21 INFO - Copying logs to upload dir... 19:23:21 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.572547 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-07 19:23:21.135537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.139172) ========= 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.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2289ded4fe647e0860263c20ed3499c56c1632bc61fe20fb7a26e5ac8c5fc4d54b2d4281a9847d6f8ee3b3c2d8b40c75d91a31122d635b729c86158f34e8b80c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/daf42892dad32caa20f0c1cbc967aa0ba944f6a54343b424789513069521b36996576b8d5afb80031170878bdc1dbe86c66b0c9b6a9fc8849b19acbea0ddc1f4"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815758/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2289ded4fe647e0860263c20ed3499c56c1632bc61fe20fb7a26e5ac8c5fc4d54b2d4281a9847d6f8ee3b3c2d8b40c75d91a31122d635b729c86158f34e8b80c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/daf42892dad32caa20f0c1cbc967aa0ba944f6a54343b424789513069521b36996576b8d5afb80031170878bdc1dbe86c66b0c9b6a9fc8849b19acbea0ddc1f4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.171825) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.172180) ========= 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.J118oNgt4Q/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.ZKBvI6quWK/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005164 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:23:21.221304) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:23:21.221629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 19:23:21.221977) ========= ========= Total master_lag: 0.18 =========