builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0018 starttime: 1472469217.41 results: success (0) buildid: 20160829031629 builduid: 2d70c2fbaf0c475c8d893fb32b5fe6bc revision: 4f72b1d0526767db87007ed8f00f07cf90e49443 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.414575) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.414974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.415454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.475152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.475448) ========= 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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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-08-29 04:13:37-- 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% 29.2M=0s 2016-08-29 04:13:37 (29.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160429 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.760284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:37.760574) ========= 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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.027432 ========= master_lag: 0.76 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:38.549914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 04:13:38.550218) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f72b1d0526767db87007ed8f00f07cf90e49443 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4f72b1d0526767db87007ed8f00f07cf90e49443 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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-08-29 04:13:38,650 truncating revision to first 12 chars 2016-08-29 04:13:38,650 Setting DEBUG logging. 2016-08-29 04:13:38,650 attempt 1/10 2016-08-29 04:13:38,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f72b1d05267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 04:13:40,282 unpacking tar archive at: mozilla-central-4f72b1d05267/testing/mozharness/ program finished with exit code 0 elapsedTime=1.894831 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-29 04:13:40.480898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:40.481177) ========= script_repo_revision: 4f72b1d0526767db87007ed8f00f07cf90e49443 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:40.481549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:40.481814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 04:13:40.546263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-08-29 04:13:40.546605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:13:40 INFO - MultiFileLogger online at 20160829 04:13:40 in /builds/slave/test 04:13:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:13:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:40 INFO - {'append_to_log': False, 04:13:40 INFO - 'base_work_dir': '/builds/slave/test', 04:13:40 INFO - 'blob_upload_branch': 'Firefox', 04:13:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:40 INFO - 'branch': 'Firefox', 04:13:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:40 INFO - 'config_files': ('talos/mac_config.py',), 04:13:40 INFO - 'default_actions': ('clobber', 04:13:40 INFO - 'read-buildbot-config', 04:13:40 INFO - 'download-and-extract', 04:13:40 INFO - 'populate-webroot', 04:13:40 INFO - 'create-virtualenv', 04:13:40 INFO - 'install', 04:13:40 INFO - 'run-tests'), 04:13:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:40 INFO - 'download_minidump_stackwalk': True, 04:13:40 INFO - 'download_symbols': 'ondemand', 04:13:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:40 INFO - 'installer_path': 'installer.exe', 04:13:40 INFO - 'log_level': 'info', 04:13:40 INFO - 'log_name': 'talos', 04:13:40 INFO - 'log_to_console': True, 04:13:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:13:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:13:40 INFO - 'opt_config_files': (), 04:13:40 INFO - 'pip_index': False, 04:13:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:40 INFO - 'cmd': ('bash', 04:13:40 INFO - '-c', 04:13:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:40 INFO - 'enabled': True, 04:13:40 INFO - 'halt_on_failure': False, 04:13:40 INFO - 'name': 'check_screen_resolution'},), 04:13:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:13:40 INFO - 'cmd': ('bash', 04:13:40 INFO - '-c', 04:13:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:13:40 INFO - 'enabled': True, 04:13:40 INFO - 'halt_on_failure': False, 04:13:40 INFO - 'name': 'check_screen_resolution'},), 04:13:40 INFO - 'run_cmd_checks_enabled': True, 04:13:40 INFO - 'sps_profile': False, 04:13:40 INFO - 'sps_profile_interval': 0, 04:13:40 INFO - 'suite': 'dromaeojs', 04:13:40 INFO - 'system_bits': '32', 04:13:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:40 INFO - 'title': 't-yosemite-r7-0018', 04:13:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:40 INFO - 'use_talos_json': True, 04:13:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:40 INFO - 'work_dir': 'build'} 04:13:40 INFO - [mozharness: 2016-08-29 11:13:40.747775Z] Running clobber step. 04:13:40 INFO - Running pre-action listener: _resource_record_pre_action 04:13:40 INFO - Running main action method: clobber 04:13:40 INFO - rmtree: /builds/slave/test/build 04:13:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:42 INFO - Running post-action listener: _resource_record_post_action 04:13:42 INFO - [mozharness: 2016-08-29 11:13:42.849568Z] Finished clobber step (success) 04:13:42 INFO - [mozharness: 2016-08-29 11:13:42.849707Z] Running read-buildbot-config step. 04:13:42 INFO - Running pre-action listener: _resource_record_pre_action 04:13:42 INFO - Running main action method: read_buildbot_config 04:13:42 INFO - Using buildbot properties: 04:13:42 INFO - { 04:13:42 INFO - "project": "", 04:13:42 INFO - "product": "firefox", 04:13:42 INFO - "script_repo_revision": "production", 04:13:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:13:42 INFO - "repository": "", 04:13:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:13:42 INFO - "buildid": "20160829031629", 04:13:42 INFO - "pgo_build": "False", 04:13:42 INFO - "basedir": "/builds/slave/test", 04:13:42 INFO - "buildnumber": 6, 04:13:42 INFO - "slavename": "t-yosemite-r7-0018", 04:13:42 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:13:42 INFO - "platform": "yosemite_r7", 04:13:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:13:42 INFO - "branch": "mozilla-central", 04:13:42 INFO - "repo_path": "mozilla-central", 04:13:42 INFO - "revision": "4f72b1d0526767db87007ed8f00f07cf90e49443", 04:13:42 INFO - "stage_platform": "macosx64", 04:13:42 INFO - "builduid": "2d70c2fbaf0c475c8d893fb32b5fe6bc", 04:13:42 INFO - "slavebuilddir": "test" 04:13:42 INFO - } 04:13:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:13:42 INFO - Running post-action listener: _resource_record_post_action 04:13:42 INFO - [mozharness: 2016-08-29 11:13:42.853189Z] Finished read-buildbot-config step (success) 04:13:42 INFO - [mozharness: 2016-08-29 11:13:42.853292Z] Running download-and-extract step. 04:13:42 INFO - Running pre-action listener: _resource_record_pre_action 04:13:42 INFO - Running main action method: download_and_extract 04:13:42 INFO - mkdir: /builds/slave/test/build/tests 04:13:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:42 INFO - trying https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 04:13:44 INFO - Downloaded 1199 bytes. 04:13:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:13:44 INFO - Using the following test package requirements: 04:13:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:13:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:13:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:13:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'jsshell-mac.zip'], 04:13:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:13:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:13:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:13:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:13:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:13:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:13:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:13:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:44 INFO - trying https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:45 INFO - Downloaded 16369292 bytes. 04:13:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:13:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:51 INFO - trying https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:13:51 INFO - Downloading https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:13:52 INFO - Downloaded 16369292 bytes. 04:13:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:59 INFO - trying https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:13:59 INFO - Downloading https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:14:00 INFO - Downloaded 14413998 bytes. 04:14:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:01 INFO - trying https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:14:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 04:14:09 INFO - Downloaded 111539707 bytes. 04:14:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:14:09 INFO - mkdir: /builds/slave/test/properties 04:14:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:09 INFO - Contents: 04:14:09 INFO - build_url:https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:14:10 INFO - Running post-action listener: _resource_record_post_action 04:14:10 INFO - Running post-action listener: set_extra_try_arguments 04:14:10 INFO - [mozharness: 2016-08-29 11:14:10.605131Z] Finished download-and-extract step (success) 04:14:10 INFO - [mozharness: 2016-08-29 11:14:10.605248Z] Running populate-webroot step. 04:14:10 INFO - Running pre-action listener: _resource_record_pre_action 04:14:10 INFO - Running main action method: populate_webroot 04:14:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:10 INFO - '--tppagecycles', 04:14:10 INFO - '7'], 04:14:10 INFO - 'tests': ['tsvgm']}}, 04:14:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['damp', 'tps']}, 04:14:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'tests': ['damp', 'tps']}, 04:14:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['dromaeo_dom']}, 04:14:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['basic_compositor_video']}, 04:14:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:14:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['a11yr', 04:14:10 INFO - 'ts_paint', 04:14:10 INFO - 'tpaint', 04:14:10 INFO - 'sessionrestore', 04:14:10 INFO - 'sessionrestore_no_auto_restore', 04:14:10 INFO - 'tabpaint']}, 04:14:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['tsvgx', 04:14:10 INFO - 'tsvgr_opacity', 04:14:10 INFO - 'tart', 04:14:10 INFO - 'tscrollx', 04:14:10 INFO - 'cart']}, 04:14:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:10 INFO - 'tsvgr_opacity', 04:14:10 INFO - 'tart', 04:14:10 INFO - 'tscrollx', 04:14:10 INFO - 'cart']}, 04:14:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'talos_options': ['--disable-e10s'], 04:14:10 INFO - 'tests': ['tp5o']}, 04:14:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'tests': ['tp5o']}, 04:14:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'talos_options': ['--disable-e10s', 04:14:10 INFO - '--xperf_path', 04:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:10 INFO - 'tests': ['tp5n']}, 04:14:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:10 INFO - 'talos_options': ['--xperf_path', 04:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:10 INFO - 'tests': ['tp5n']}}, 04:14:10 INFO - 'talos.zip': {'path': '', 04:14:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:10 INFO - Running post-action listener: _resource_record_post_action 04:14:10 INFO - [mozharness: 2016-08-29 11:14:10.624104Z] Finished populate-webroot step (success) 04:14:10 INFO - [mozharness: 2016-08-29 11:14:10.624220Z] Running create-virtualenv step. 04:14:10 INFO - Running pre-action listener: _resource_record_pre_action 04:14:10 INFO - Running main action method: create_virtualenv 04:14:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:10 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 04:14:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:10 INFO - Using real prefix '/tools/python27' 04:14:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:14 INFO - Installing pip.................done. 04:14:14 INFO - Return code: 0 04:14:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14: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', 'pip>=1.5'] in /builds/slave/test/build 04:14: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 pip>=1.5 04:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:14 INFO - 'HOME': '/Users/cltbld', 04:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:14 INFO - 'LOGNAME': 'cltbld', 04:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:14 INFO - 'MOZ_NO_REMOTE': '1', 04:14:14 INFO - 'NO_EM_RESTART': '1', 04:14:14 INFO - 'PAGER': '/bin/cat', 04:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:14 INFO - 'PWD': '/builds/slave/test', 04:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:14 INFO - 'SHELL': '/bin/bash', 04:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:14 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:14 INFO - 'USER': 'cltbld', 04:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:14 INFO - 'XPC_FLAGS': '0x0', 04:14:14 INFO - 'XPC_SERVICE_NAME': '0', 04:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:14 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 04:14:14 INFO - Cleaning up... 04:14:14 INFO - Return code: 0 04:14:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:14: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 psutil>=3.1.1 04:14:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:14 INFO - 'HOME': '/Users/cltbld', 04:14:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:14 INFO - 'LOGNAME': 'cltbld', 04:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:14 INFO - 'MOZ_NO_REMOTE': '1', 04:14:14 INFO - 'NO_EM_RESTART': '1', 04:14:14 INFO - 'PAGER': '/bin/cat', 04:14:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:14 INFO - 'PWD': '/builds/slave/test', 04:14:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:14 INFO - 'SHELL': '/bin/bash', 04:14:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:14 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:14 INFO - 'USER': 'cltbld', 04:14:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:14 INFO - 'XPC_FLAGS': '0x0', 04:14:14 INFO - 'XPC_SERVICE_NAME': '0', 04:14:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:14 INFO - Downloading/unpacking psutil>=3.1.1 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:18 INFO - Installing collected packages: psutil 04:14:18 INFO - Running setup.py install for psutil 04:14:18 INFO - building 'psutil._psutil_osx' extension 04:14:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:14:19 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 04:14:19 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 04:14:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:14:19 INFO - building 'psutil._psutil_posix' extension 04:14:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:14:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:14:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:14:19 INFO - ^ 04:14:19 INFO - 1 warning generated. 04:14:19 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:14:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:19 INFO - Successfully installed psutil 04:14:19 INFO - Cleaning up... 04:14:19 INFO - Return code: 0 04:14:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:19 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:19 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.3'] in /builds/slave/test/build 04:14:19 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.3 04:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:19 INFO - 'HOME': '/Users/cltbld', 04:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:19 INFO - 'LOGNAME': 'cltbld', 04:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:19 INFO - 'MOZ_NO_REMOTE': '1', 04:14:19 INFO - 'NO_EM_RESTART': '1', 04:14:19 INFO - 'PAGER': '/bin/cat', 04:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:19 INFO - 'PWD': '/builds/slave/test', 04:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:19 INFO - 'SHELL': '/bin/bash', 04:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:19 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:19 INFO - 'USER': 'cltbld', 04:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:19 INFO - 'XPC_FLAGS': '0x0', 04:14:19 INFO - 'XPC_SERVICE_NAME': '0', 04:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:22 INFO - Installing collected packages: mozsystemmonitor 04:14:22 INFO - Running setup.py install for mozsystemmonitor 04:14:22 INFO - Successfully installed mozsystemmonitor 04:14:22 INFO - Cleaning up... 04:14:22 INFO - Return code: 0 04:14:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:22 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:22 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==2.5.1'] in /builds/slave/test/build 04:14:22 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==2.5.1 04:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:22 INFO - 'HOME': '/Users/cltbld', 04:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:22 INFO - 'LOGNAME': 'cltbld', 04:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:22 INFO - 'MOZ_NO_REMOTE': '1', 04:14:22 INFO - 'NO_EM_RESTART': '1', 04:14:22 INFO - 'PAGER': '/bin/cat', 04:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:22 INFO - 'PWD': '/builds/slave/test', 04:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:22 INFO - 'SHELL': '/bin/bash', 04:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:22 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:22 INFO - 'USER': 'cltbld', 04:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:22 INFO - 'XPC_FLAGS': '0x0', 04:14:22 INFO - 'XPC_SERVICE_NAME': '0', 04:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:23 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 04:14:23 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 04:14:23 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 04:14:23 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 04:14:23 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 04:14:23 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 04:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:26 INFO - warning: no files found matching '*.txt' 04:14:26 INFO - no previously-included directories found matching 'build' 04:14:26 INFO - no previously-included directories found matching 'dist' 04:14:26 INFO - no previously-included directories found matching '.git*' 04:14:26 INFO - Installing collected packages: jsonschema, functools32 04:14:26 INFO - Running setup.py install for functools32 04:14:26 INFO - warning: no files found matching '*.txt' 04:14:26 INFO - no previously-included directories found matching 'build' 04:14:26 INFO - no previously-included directories found matching 'dist' 04:14:26 INFO - no previously-included directories found matching '.git*' 04:14:26 INFO - Successfully installed jsonschema functools32 04:14:26 INFO - Cleaning up... 04:14:26 INFO - Return code: 0 04:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:26 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:14:26 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 functools32==3.2.3-2 04:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:26 INFO - 'HOME': '/Users/cltbld', 04:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PAGER': '/bin/cat', 04:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:26 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - 'XPC_FLAGS': '0x0', 04:14:26 INFO - 'XPC_SERVICE_NAME': '0', 04:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:26 INFO - Cleaning up... 04:14:26 INFO - Return code: 0 04:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:26 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 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:26 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 04:14:26 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 04:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:26 INFO - 'HOME': '/Users/cltbld', 04:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PAGER': '/bin/cat', 04:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:26 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - 'XPC_FLAGS': '0x0', 04:14:26 INFO - 'XPC_SERVICE_NAME': '0', 04:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:29 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 04:14:29 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 04:14:29 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 04:14:29 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 04:14:29 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 04:14:29 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 04:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:30 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 04:14:30 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 04:14:30 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 04:14:30 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 04:14:30 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 04:14:30 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 04:14:30 INFO - Downloading docopt-0.6.1.tar.gz 04:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:30 INFO - Running setup.py install for blobuploader 04:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:30 INFO - Running setup.py install for requests 04:14:31 INFO - Running setup.py install for docopt 04:14:31 INFO - Successfully installed blobuploader requests docopt 04:14:31 INFO - Cleaning up... 04:14:31 INFO - Return code: 0 04:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:31 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 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:31 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 04:14:31 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 04:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:31 INFO - 'HOME': '/Users/cltbld', 04:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:31 INFO - 'LOGNAME': 'cltbld', 04:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:31 INFO - 'MOZ_NO_REMOTE': '1', 04:14:31 INFO - 'NO_EM_RESTART': '1', 04:14:31 INFO - 'PAGER': '/bin/cat', 04:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:31 INFO - 'PWD': '/builds/slave/test', 04:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:31 INFO - 'SHELL': '/bin/bash', 04:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:31 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:31 INFO - 'USER': 'cltbld', 04:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:31 INFO - 'XPC_FLAGS': '0x0', 04:14:31 INFO - 'XPC_SERVICE_NAME': '0', 04:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-FmfGq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-W7wfNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-LfCT6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-kSFDnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-07eabu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-yr83W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-3cXH5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-0b6v32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-fVc1dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-qgzQHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-in7sNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-rD6iml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:32 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-_p1oBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:33 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-qCHHlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:33 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-5xAWy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:33 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-S7xmMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:33 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-T0c4On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:33 INFO - Running setup.py install for manifestparser 04:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:33 INFO - Running setup.py install for mozcrash 04:14:33 INFO - Running setup.py install for mozdebug 04:14:33 INFO - Running setup.py install for mozdevice 04:14:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Running setup.py install for mozfile 04:14:34 INFO - Running setup.py install for mozhttpd 04:14:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Running setup.py install for mozinfo 04:14:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Running setup.py install for mozInstall 04:14:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Running setup.py install for mozleak 04:14:34 INFO - Running setup.py install for mozlog 04:14:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:34 INFO - Running setup.py install for moznetwork 04:14:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Running setup.py install for mozprocess 04:14:35 INFO - Running setup.py install for mozprofile 04:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Running setup.py install for mozrunner 04:14:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Running setup.py install for mozscreenshot 04:14:35 INFO - Running setup.py install for moztest 04:14:35 INFO - Running setup.py install for mozversion 04:14:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:35 INFO - Cleaning up... 04:14:35 INFO - Return code: 0 04:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 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 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:36 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 04:14:36 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 04:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:36 INFO - 'HOME': '/Users/cltbld', 04:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PAGER': '/bin/cat', 04:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:36 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - 'XPC_FLAGS': '0x0', 04:14:36 INFO - 'XPC_SERVICE_NAME': '0', 04:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-0RalOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-qcBXNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-QyjqCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-G0Jy3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-UhSBfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-CuZuWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:36 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)) 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:36 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-tF_niW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-dxcRDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ggB1YX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-TTpjdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-92YG00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-zrH3oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-XgUEwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-f9I_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-oJ4RnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-LJFycT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:37 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)) 04:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:37 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-sNFB69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:38 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)) 04:14:38 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)) 04:14:38 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)) 04:14:38 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)) 04:14:38 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)) 04:14:38 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)) 04:14:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:40 INFO - Downloading blessings-1.6.tar.gz 04:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:40 INFO - Installing collected packages: blessings 04:14:40 INFO - Running setup.py install for blessings 04:14:40 INFO - Successfully installed blessings 04:14:40 INFO - Cleaning up... 04:14:40 INFO - Return code: 0 04:14:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:41 INFO - Reading from file tmpfile_stdout 04:14:41 INFO - Current package versions: 04:14:41 INFO - blessings == 1.6 04:14:41 INFO - blobuploader == 1.2.4 04:14:41 INFO - docopt == 0.6.1 04:14:41 INFO - functools32 == 3.2.3-2 04:14:41 INFO - jsonschema == 2.5.1 04:14:41 INFO - manifestparser == 1.1 04:14:41 INFO - mozInstall == 1.12 04:14:41 INFO - mozcrash == 0.17 04:14:41 INFO - mozdebug == 0.1 04:14:41 INFO - mozdevice == 0.48 04:14:41 INFO - mozfile == 1.2 04:14:41 INFO - mozhttpd == 0.7 04:14:41 INFO - mozinfo == 0.9 04:14:41 INFO - mozleak == 0.1 04:14:41 INFO - mozlog == 3.3 04:14:41 INFO - moznetwork == 0.27 04:14:41 INFO - mozprocess == 0.23 04:14:41 INFO - mozprofile == 0.28 04:14:41 INFO - mozrunner == 6.12 04:14:41 INFO - mozscreenshot == 0.1 04:14:41 INFO - mozsystemmonitor == 0.3 04:14:41 INFO - moztest == 0.7 04:14:41 INFO - mozversion == 1.4 04:14:41 INFO - psutil == 3.1.1 04:14:41 INFO - requests == 1.2.3 04:14:41 INFO - wsgiref == 0.1.2 04:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 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 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:41 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 04:14:41 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 04:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:41 INFO - 'HOME': '/Users/cltbld', 04:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PAGER': '/bin/cat', 04:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:41 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - 'XPC_FLAGS': '0x0', 04:14:41 INFO - 'XPC_SERVICE_NAME': '0', 04:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 INFO - Cleaning up... 04:14:41 INFO - Return code: 0 04:14:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa46a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fadb618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc11c69a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, '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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:41 INFO - 'HOME': '/Users/cltbld', 04:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PAGER': '/bin/cat', 04:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:14:41 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - 'XPC_FLAGS': '0x0', 04:14:41 INFO - 'XPC_SERVICE_NAME': '0', 04:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:41 INFO - Cleaning up... 04:14:41 INFO - Return code: 0 04:14:41 INFO - Running post-action listener: _resource_record_post_action 04:14:41 INFO - Running post-action listener: _start_resource_monitoring 04:14:41 INFO - Starting resource monitoring. 04:14:41 INFO - [mozharness: 2016-08-29 11:14:41.668076Z] Finished create-virtualenv step (success) 04:14:41 INFO - [mozharness: 2016-08-29 11:14:41.669138Z] Running install step. 04:14:41 INFO - Running pre-action listener: _resource_record_pre_action 04:14:41 INFO - Running main action method: install 04:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:41 INFO - Reading from file tmpfile_stdout 04:14:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:42 INFO - Reading from file tmpfile_stdout 04:14:42 INFO - Output received: 04:14:42 INFO - Usage: mozinstall [options] installer 04:14:42 INFO - Options: 04:14:42 INFO - -h, --help show this help message and exit 04:14:42 INFO - -d DEST, --destination=DEST 04:14:42 INFO - Directory to install application into. [default: 04:14:42 INFO - "/builds/slave/test"] 04:14:42 INFO - --app=APP Application being installed. [default: firefox] 04:14:42 INFO - mkdir: /builds/slave/test/build/application 04:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:15:16 INFO - Reading from file tmpfile_stdout 04:15:16 INFO - Output received: 04:15:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:15:16 INFO - Running post-action listener: _resource_record_post_action 04:15:16 INFO - [mozharness: 2016-08-29 11:15:16.376627Z] Finished install step (success) 04:15:16 INFO - [mozharness: 2016-08-29 11:15:16.376757Z] Running run-tests step. 04:15:16 INFO - Running pre-action listener: _resource_record_pre_action 04:15:16 INFO - Running main action method: run_tests 04:15:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:16 INFO - 2016-08-29 04:15:16.389 screenresolution[1645:8074] starting screenresolution argv=screenresolution get 04:15:16 INFO - 2016-08-29 04:15:16.391 screenresolution[1645:8074] Display 0: 1600x1200x32@60 04:15:16 INFO - 2016-08-29 04:15:16.397 screenresolution[1646:8076] starting screenresolution argv=screenresolution list 04:15:16 INFO - Available Modes on Display 0 04:15:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:16 INFO - Intel Iris: 04:15:16 INFO - Chipset Model: Intel Iris 04:15:16 INFO - Type: GPU 04:15:16 INFO - Bus: Built-In 04:15:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:16 INFO - Vendor: Intel (0x8086) 04:15:16 INFO - Device ID: 0x0a2e 04:15:16 INFO - Revision ID: 0x0009 04:15:16 INFO - Displays: 04:15:16 INFO - Display: 04:15:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:16 INFO - Display Serial Number: 1600x1200 60 04:15:16 INFO - Main Display: Yes 04:15:16 INFO - Mirror: Off 04:15:16 INFO - Online: Yes 04:15:16 INFO - Rotation: Supported 04:15:16 INFO - Return code: 0 04:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:16 INFO - Python 2.7.3 04:15:16 INFO - Return code: 0 04:15:16 INFO - grabbing minidump binary from tooltool 04:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:16 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9aad30>, '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 0x10f70fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9a2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:16 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 04:15:16 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 04:15:16 INFO - Calling ['/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'] with output_timeout 600 04:15:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:16 INFO - Return code: 0 04:15:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:15:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:15:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 04:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 04:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmuKgOOB4E/Render', 04:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:15:16 INFO - 'HOME': '/Users/cltbld', 04:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:15:16 INFO - 'LOGNAME': 'cltbld', 04:15:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:16 INFO - 'MOZ_NO_REMOTE': '1', 04:15:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:16 INFO - 'NO_EM_RESTART': '1', 04:15:16 INFO - 'PAGER': '/bin/cat', 04:15:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:16 INFO - 'PWD': '/builds/slave/test', 04:15:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:15:16 INFO - 'SHELL': '/bin/bash', 04:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lOgFsk8nvg/Listeners', 04:15:16 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:15:16 INFO - 'USER': 'cltbld', 04:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:16 INFO - 'XPC_FLAGS': '0x0', 04:15:16 INFO - 'XPC_SERVICE_NAME': '0', 04:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:15:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 04:15:16 INFO - mozversion application_buildid: 20160829031629 04:15:16 INFO - mozversion application_changeset: 4f72b1d0526767db87007ed8f00f07cf90e49443 04:15:16 INFO - mozversion application_display_name: Nightly 04:15:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:16 INFO - mozversion application_name: Firefox 04:15:16 INFO - mozversion application_remotingname: firefox 04:15:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:16 INFO - mozversion application_vendor: Mozilla 04:15:16 INFO - mozversion application_version: 51.0a1 04:15:16 INFO - mozversion platform_buildid: 20160829031629 04:15:16 INFO - mozversion platform_changeset: 4f72b1d0526767db87007ed8f00f07cf90e49443 04:15:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:16 INFO - mozversion platform_version: 51.0a1 04:15:16 INFO - using testdate: 1472469316 04:15:16 INFO - actual date: 1472469316 04:15:16 INFO - starting webserver on 'localhost:49270' 04:15:16 INFO - SUITE-START | Running 2 tests 04:15:16 INFO - TEST-START | dromaeo_css 04:15:16 INFO - operating with platform_type : mac_ 04:15:16 INFO - Initialising browser for dromaeo_css test... 04:15:16 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpje4QRc/profile http://localhost:49270/getInfo.html) 04:15:19 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 04:15:19 INFO - PROCESS | 1656 | colorDepth:24 04:15:19 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 04:15:19 INFO - PROCESS | 1656 | __metrics 04:15:19 INFO - PROCESS | 1656 | 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" 04:15:19 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:15:20 INFO - TEST-INFO | 1656: exit 0 04:15:20 INFO - Browser initialized. 04:15:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:20 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpje4QRc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:32 INFO - PROCESS | 1659 | RSS: Main: 232718336 04:15:32 INFO - PROCESS | 1659 | 04:16:23 INFO - PROCESS | 1659 | 1472469383677 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] 04:18:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 04:18:36 INFO - PROCESS | 1659 | RSS: Main: 364929024 04:18:36 INFO - PROCESS | 1659 | 04:21:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 04:21:40 INFO - PROCESS | 1659 | RSS: Main: 368672768 04:21:40 INFO - PROCESS | 1659 | 04:24:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 04:24:43 INFO - PROCESS | 1659 | RSS: Main: 330948608 04:24:43 INFO - PROCESS | 1659 | 04:27:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 04:27:46 INFO - PROCESS | 1659 | RSS: Main: 329375744 04:27:46 INFO - PROCESS | 1659 | 04:30:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 04:30:50 INFO - PROCESS | 1659 | RSS: Main: 327856128 04:30:50 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 04:33:53 INFO - PROCESS | 1659 | RSS: Main: 375091200 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | __start_tp_report 04:33:53 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 04:33:53 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 04:33:53 INFO - PROCESS | 1659 | |i|pagename|runs| 04:33:53 INFO - PROCESS | 1659 | |0;dojo.html;2740.876240741296;3320.2529430878058;3357.882474113405;3364.6971772540464;3405.1997780521574;5570.192322113291;5642.266505354309;5673.319201695792;5728.5989980701315;5737.627054241471;4628.606568441678;5646.548276137909;5732.312122545301;5757.050086735694;5814.796482123126;5140.434552199255;5165.922511162316;5190.532852043315;5193.402758682762;5316.867078323035;5292.550133238679;5295.099833028395;5295.205719142121;5299.417064122943;5303.2575439438315;5084.669496482717;5125.1287281162295;5155.793768249266;5196.700824793802;5245;4432.268675668511;5144.279800827887;5176.948230517684;5196.090684130262;5206.895862082737;4256.34026725858;5097.528999486578;5171.50870667286;5190.766415511311;5269.604779641504;5583.246261754652;5627.986962346776;5645;5674.978503869302;5714.45712657301;6226.470749986257;6232.875342493125;6233.407826256498;6261.686915654244;6266.968665156691;5814;6143.232095988002;6150.538709596798;6229.190205273286;6255.280642726099;5754.88490230193;5784.71076446176;5829.504492118217;5830.8542286442325;5833.912491312633;6331.68341582919;6336.588121772163;6339.366063393716;6347.428731414195;6374.649394283359;5916.171735956969;5964.970175149097;6086.147939288503;6137.4689182037;6139.416755408229;6258.593191442542;6262.968685156545;6265.373462653698;6274.309825919146;6280.183576135165;5649.180868774087;6188.164597779332;6196.597221180609;6206.813795586139;6220.160278362454;5749.453801888814;6074.696265186723;6105.938940610626;6144.539159562962;6146.955017647011;4963.8014479421145;4970.254461830682;4972.229304457815;4975.4278258000795;5018.146915024382;4421.579949904753;4423.867283981485;4427.623651989553;4454.955450445454;4477.462704475419;5546.611737178358;5585.553155747531;5590.496855283044;5677.943220567824;5695.088785794336;6182.969085154546;6251.874962500816;6253.280872699698;6254.6872656366995;6285.308616052231;5668.376478587352;5673.971630141823;5676.545876329884;5687.829365119053;5732;5288.81489147878;5318.760655770422;5324.866878328073;5357.303550538405;5401.243825864382;6267;6303.243610766737;6334.429901308904;6336.746530138743;6356.872862542723;6288.402601752826;6295.905561416674;6301.7164227608955;6307.7476900925285;6317.5893566918;6241.656708881055;6285.560010799383;6311.053341998737;6326.557141000086;6330.778422755181;5989.1914591529585;6033.879322413615;6110.236220472441;6159.5688301818445;6195.473384762166;6245.718942647501;6285.937140628718;6291.496680265659;6294.6852657366035;6304.991201407753;5934.546036221153;6041;6050.909236361546;6053.545984051302;6055.364186760503;5688.402717714746;5902.793402230901;5978.970105149447;6089.360617135314;6113.266408031065;5808.273965754281;5883.705814709333;5896.764129434946;5919.437653422918;5938.970305148619;5060.51925067118;6026.849328766816;6034.487068599043;6040.546958978182;6053.848653783691;5664.405237450173;5810.215620891126;5836.299644042742;5842.737076831638;5868.295804503487 04:33:53 INFO - PROCESS | 1659 | |1;ext.html;478.9281607758838;521.0100808463918;530.358266497538;531.572084472;532.7469452010296;40096.797096087124;41565.168696626046;41706.95732606686;41732;44063.55936440635;42876.57123428765;43251.78374108125;43341.56658433423;43350.7832460838;43378.13243735123;9775.217982561397;9964.950175249114;9970.800583988315;9985.600575976952;9988.650397236099;9775;9845.45849978251;9866.260030497742;9873.851892221623;9881.950590247076;9848.212143028577;9878.357906736039;9896.604135834594;9902.950485247564;9915.950420247924;9820.558074886612;9867.96386379427;9885.25860560461;9888.159506441962;9891.455969921652;9772.609095636166;9880.802383952281;9888.851667224997;9889.75275618108;9892.703218903445;40835.38746918798;41157.588424115675;41197.38203926943;41268;41334.58665413367;3354.5974483062187;3406.8466918988706;3428.211511352403;3861.420786881962;4113.506379234481;30712.385752285052;31088.8445557773;31401.52897706536;32364.514532282035;32416.513752293733;3232.208109013307;3240.044186964851;3240.189952511872;3246.772725909187;3358.44585643371;506099;507401;509092;640256;642256.7887160581;62325.68837155785;62990.68504657447;63003;63025.68487157627;63072;33787.49318760221;34826.82586587051;65953.67023164853;66124;66458.66770666116;16519;16622.418215362406;16637.91681041587;16640.583985400463;16645.33418663264;12792.488300467878;12891.48434062627;12892.419841107172;12894.968402527775;12922.289274089828;16985.89591676537;19240.326588569333;19255.940923249356;19303.710444343345;19305.420837374902;7602.201768814305;8108.716194933149;8139.1453897339925;8163.510189388656;8198.42611017235;853.7268074216191;897.5736525150501;996.9601215951426;1039.3192458939407;1124.8706398764084;29844;29922;30131.246718832204;30792.538111928337;30970;1011.4993078426226;1046.398320965448;1084.951177197028;1129.4635048352131;1140.5779861451317;14928.850711492963;15575.454859079879;15602.297896594453;15622.437756224286;16046.438374657064;169600;169971;170047;170892;171176;58059;58906.41093589095;58989;58993.41006589879;58994;1224.5652793258444;1258.2764910176868;1363.7477066742683;1376.3599926034242;1388.5417812121975;27116.593251101644;29126.27184320409;30505.694943050286;30749.335942960603;31264.687353126177;51073.744631276604;51963.740181298854;52062.73968630133;52064.95870082653;52071.73964130155;597797;608845;610518;610629;611652;42360.36459453049;43123.353149703406;43446.26214951366;43451.78274108736;44965.32552011657;40183.79908100558;47307.52692473169;48064.5193548074;48245.5175448255;49545.25682114843;38963.80518097391;39005;39503.60496394999;40150.59849401469;40681;37857.24285514219;38390.65632702842;38503.422448662735;39131.021724455975;39691.80154099211;32485.837570811993;33095;38227.80886095552;38699.6130038696;38850.80574597109;31702;34484.65515344815;34750.652493475754;35254.64745352514;36186.638133618326;23327.41681457977;25019.41573570712;25451.87274063618;25896.302813381026;25915.74314783139 04:33:53 INFO - PROCESS | 1659 | |2;jquery.html;364.24601075773154;369.4716555325883;376.9905752356191;389.2312682452156;394.982225799839;19374.93437860917;20681.482962925933;20789.376318710445;20820.8958955205;21094.789052109474;20111.39665810028;20976.74139551624;21425.46436339092;21617.02723377448;21637.242696505626;5746.51154651853;5848.064309710437;6002.519798416138;6020.698965051752;6024.397560243962;4145.233131870598;4369.672274579403;5872.354041055481;5999.730012149442;6327.936720632781;6614.768483103092;6628.4697224221945;6655.036764154586;6680.966595167018;6710.127683401151;6371.808845734636;6585.967070164618;6648.401643852028;6649.5012874034155;6674.432673222782;5642.971785141089;5699.487046165865;5740.253767010262;5740.311162660466;5770.2210201622665;26558.73441265582;26629.733702662917;26658.86670566654;26671.932727736366;26987.730122698915;2228;2409.349475641567;2747.5603903375363;3084.1826915867314;3193.409219294415;14833.110013399231;15592.688146237011;15821.369381601879;15915.840841591551;16243.269052892649;1665.800103987517;1845.8523318134517;1861.8324350808357;1975.9703604445945;2029.8579099463043;124154;127511.36244318719;129868.3506582461;130518;130963;11066.833997490045;11479.942600286946;11498.573049376051;11511.48198331077;11720.941395292968;14420.927895360455;14440;14441.422343106158;14446.638834029234;14454.710905781825;8228.547429891294;8473.70342038038;8535.695362252158;8655.6970506032;8666.350023748244;8522.147785221552;8576.785580360542;8584.8712269316;8740.737777866674;8777.297816174818;3699.6300369962787;4376.518582955872;4506.909861802746;4565.474970378383;4566.611837993808;1744.7819022622173;1791.973120403195;1845.4094689699168;1876.4839669090836;1899.2877670873422;844.1010324004915;857.6697971280977;889.9866502002475;942.6465075596651;986.2473289134911;20618.381448556567;20984.74736415858;21061.789382105984;21092.261770837948;21095.472613184793;880.308957468397;903.2322525852973;917.682850801731;935.6538080910107;954.4607296877242;6107.694615269219;8706.825863482694;10973.122150227962;11026.669199924016;11148.2753621016;571867.2813271898;574450;582345;584463;585526;75377;83747;89878;125530.74469255374;134491;962.0427674463813;969.6896992962326;970.0897308075772;978.0464047553578;996.8685541909985;17171.742423863903;17405.82594174042;18348.08259587042;18635.90682046581;18657;54298;54662.72668636632;55244.171337429165;55388.44611553994;55866.72066639641;76353.61823190849;76921;77392.61303693446;77634.6118269405;78082.6095869517;5530.806421775219;7856.764297071097;8109.472884262504;8229.25936665679;8255.720363343691;11019.504122314354;12717.10980231375;12875.227486350848;13091.738165236451;13128.540501082416;9343.439393636132;11154.665360039211;11362.602308919148;11440.656780296604;11456.541738330374;8789.692360767342;9066.410683305565;10946.233763636468;11055.668329949793;11223.382713950485;11360.602378916697;11451.828222576502;11524.94237528807;11590.014848737952;11720.355380454157;8026.799330016796;8103.878441823495;8107.473014254055;8158.959205203936;8329.759114258495;8206.862788731056;9459.10138536838;11096.944515277371;11126.276792008493;11583.305001699924 04:33:53 INFO - PROCESS | 1659 | |3;mootools.html;1328.1831673520776;1474.874635655969;1507.6230942264433;1695.7032519309125;1894.6873765828648;7689.231076892315;8553.657853685852;8818.338624603148;8833.11668833118;8971.596278167483;8749.737507874757;8830.293576513879;8839.77900552485;8864.911350886488;8865.512396818172;2328.196772113618;2374.6319320505263;2375.70303712036;2376.3227480168157;2376.8098552115875;2312.491251924574;2348.729896061958;2360.0441821062414;2363.9645405318934;2375.4417711837705;2326.9069237230574;2347;2354.223106374901;2359.95280094398;2362.397588614901;2287.4853158039473;2315.7568455312203;2315.837891347598;2322.175627652176;2343.718753749561;2333.101755824003;2339.4619237575284;2340.379799353173;2346;2354.5173239485866;8508.702195423131;8748.212660860552;8757.649694012232;8830.955845220733;8857.911420885837;4614.561616646413;5180.3265575475325;5368.543673787733;5387.488188622075;5402.621816472849;3364.814935178564;3519.1202199450136;3586.9820650896577;3592.8383222755037;3595.478655594924;1002.6340385759146;1031.9422591843345;1043.5564884923954;1057.8413238014282;1059.0362769879373;11458.770824583462;11542.596009139725;11565.95906368431;11597.724250332456;11606.941965290203;4314.697971142053;4380.715253508575;4549.27211646135;4551.7724113794175;4559.863204103882;9080.455172689659;9090.90909090914;9099;9104.089591040844;9123.680671176477;5221.973890130601;5224.895502090013;5227.085260079471;5229.08491014071;5234.685918844882;4180.372944058355;4336.783160841946;4664.253719404879;4834.95165048352;4889;3681.466187402865;3681.7054635629083;3789.242151569697;3792.715546333981;3830.5211848518934;1149.8620165580016;1162.9302241865514;1172.7771723372532;1174.0150024045438;1181.6573193773881;844.4553263145237;859.9742007739778;907.2379201470796;912.9452232866049;935.3218916285774;5683.460071293221;5751.798687046017;6014.6391216527145;6042.697865106815;6210.378962103753;766.7623036858591;879.5514287713185;884.2925659472396;927.5547737086237;947.6351604632129;3922.686185105185;4011.7314859386;4055.913595279797;4081.2449696806184;4136.482939632546;10456.424896630606;10829.512671929782;10835.079018283534;10839.295445795999;10848.077913377452;10750.677479675622;10751.462426878625;10777.407242601732;10791.298565593212;10794.838077428845;8079.3536517079665;8195.34437245019;8216.630251638691;8216.630251638691;8231.794205144799;5087.567556757717;5509.724513774376;5812.273465816773;5873.853153671022;5962.940370596239;9566.426014439156;9901.950490247502;9918.553665085234;10061.446620435947;10066.496675166067;9182.081791820765;9949.353292035994;10177.287589868638;10178.49107544605;10180.592776289162;7295.8540829184185;7417.962910185414;7480;7522.548647081193;7536.886946695694;8156.184381561797;8226.547539885363;8231.547264900488;8233;8261.38039647041;7228.710851565878;7416.110066792019;7457.366123879531;7570.242975702386;7574.166841647304;6253.187085678833;7133.322334378226;7253.891191632235;7258.854822903618;7285.854282914418;6862.696087743313;7008.474364422791;7010.018597396471;7012;7019.543729657556;4831.396075490564;4909.165441874961;4941.925871111865;5028.572571331331;5072.213806859942;4971.304017437634;4991.850244492671;5050.494950505067;5209.765560549708;5217.373915130209 04:33:53 INFO - PROCESS | 1659 | |4;prototype.html;298.4776640878462;301.5958615455289;307.8383848479547;313.8320998265927;315.16952829294803;4695.882602934924;5271.894562108756;5354.946450535494;5374.435684253156;5416.620836541444;4215.704900656948;4736.12381709384;5016.8644597126795;5056.938043010972;5273.815416460425;3827.2919509890758;3865.4974853269036;4013.5785742497055;4036.9596304036877;4066.7356621819486;4081.693872959525;4081.7755023473696;4094.9181016379653;4128.917421651565;4137.2552940470705;3477;3610.711143108558;3692.4276737105793;4028.415879697442;4056.1482088761395;3752.9249415011545;3804.5814960354337;3862.6909847212155;4023.8591649292134;4049.77726225059;3233.466478031122;3502.5271588335504;3507.5790905091553;3512.5082488451635;3515.91210219744;5122.795088196468;5129.333186685744;5142.35168888023;5193.675612718733;5200.931450444256;4369.2052489706275;4570.451545814491;4629.375034370384;4635;4635.655659858637;5492.148716948879;5500.724963751796;5505.311836020497;5512.972435137799;5550.91673624896;3426.3832510148163;3863.517060367454;3896.8246428910766;3902.551206611219;3916.1580260244186;5596.59346481013;5849.64902105875;5887.205227294303;5902.026165682614;5948.226730525004;3414.2488652496413;3674.7427680062137;3914.549826769901;3930.331843586597;3939.5666476687543;3425.554677891908;4000.7599544027453;4009.69927255457;4043.959560404417;4109.0959988802415;3883.883483495443;3912.217556488714;4632.698874573142;4643.489216186217;4646.4191976003;5181.559567436735;5495.681036551279;5608.298962629671;5642.943570564324;5648.85877853057;1088.2382332367374;1243.639344590077;1367.8426980897125;1381.7029338692028;1393.226759148662;802.8153524689354;846.6274839070912;857.6397912876607;862.1895418306772;870.2863651805585;4267.871963841089;4744.644151688637;4922.75386230687;5200.557952573998;5229.790808367698;4641.396618439649;4667.556582124693;5422.566194704415;5426;5675.460831221028;4929.510597148417;5169.4830516948;5209.348831396075;5212.582993360522;5248.868778280574;2978.076796193187;2983.1498023063323;2997.4005198960294;2998.7600991920594;3007.9398412032074;5337.786488540492;5401.137397179501;5725.627834190765;5839.795607153814;5905.350411454737;5198.350206224222;5846.766129354778;5875.619229481069;5897.5871688982215;5956.880862382728;5028.7737051832755;5982.192404025401;6000.459958603747;6030.788922387783;6036.336003039574;5286.56817863787;5771.394003629726;5866.7066646668345;5901.557383196363;5902.321233058254;4641.885947372539;5036.84889453317;5673.234113394804;5679.233303503974;5709.172170035405;4982.576480999156;5387.542058925035;5624.128260119688;5679.722062535896;6017.789377371771;3256.6254880688075;3281.9661806530867;3328.850201740879;3409.181796368903;3892.9221415572097;4421.933670994873;4981.800727970841;5261.763220655003;5457.426970168075;5792.362840087671;4475.597196252353;5522.834314970557;5537.972310138423;5555.7499912504845;5589.385167631639;5250.711210883438;5527.778888844401;5626.2685850839125;5627.662340259598;5642.391918303264;4709.199436095941;4748.741583480311;5432.320959880015;5432.809851655173;5455.399906010415;5253.448387919367;5413.8615246978015;5464.863378415572;5484.506394424521;5530.751116199861;4518;4906.582940449959;5278.4721527846905;5316.840494785162;5434.184872269033 04:33:53 INFO - PROCESS | 1659 | |5;yui.html;643.4466358931318;695.3915324091422;698.9720411183553;732.7472022152356;809.8096947217407;12898.226106433596;13108.868911310885;15649.687006259883;15656.921715391436;15700.764488532666;13946.302684865766;14068.437262509487;14071.859281407184;14483.493077742281;15341.693166136698;859.5702148925553;875.1598465473154;882.1355072029415;883.0551310098198;885.9025507194203;887.0995939121797;889.168627333442;890.1321211818457;891.2201823404521;891.2869704236584;632.4845251120345;710.0414440505302;733.7688628082163;735.1325435985535;740.1968863782802;681.512718406337;694.9957311684567;729.3690957321932;730.6310313291754;731.4112139727517;537.9778421000132;542.0487045235626;542.8344354971732;542.8778524831921;543.2665901033613;15281.388744450209;15325.540233793005;15347.00244484105;15363.231838408146;15385.230738463144;13935.372908219155;13957.441702331895;14221.644458888508;14289.428422863073;14558;10533.420661863594;10560.207984401124;11671;11975.161738678296;12140.878591214063;3660.5424321959754;3728.7762734236035;3813.561440434358;3825.48355971943;3887.4751908492276;99138.99999999927;122895;124768;126395;127017.72982270151;10321.793564128675;10326.22553308505;10746.140308775279;10802.621908233174;11165.944170279097;21733.891330543247;21913.452163696034;22372;22388;22434.663480047813;7612.352949999312;7865.567393793396;7877;8143.877841832259;8245.79385515367;4378.211921854033;4417.3815665806815;4463.375127482155;4468.106378724268;4652.302154676758;3311.023248141804;3477.426224672901;3488.127968007998;3646.5441819772527;3653.1597732521136;669.3306693306694;688.0814113158889;692.764460083574;719.0400814912047;722.7145277615313;588.9234399528034;648.1412128929188;654.3325807676143;656.7504348347597;669.608279156689;8572.571371431528;8920.375573709907;9457.76355591102;9591.280653950982;9602.711918642452;560.8373571664172;600.9188759517497;642.5437939063224;653.8231183869111;677.7593954146306;4187.994881228483;4625;4641.771949464276;4653.488116307203;4745.976270118696;82204;83318;85023.57488212519;87009;97307.51346243224;89836.5508172468;115789;119294;122847;123759.76240237663;60754.78490430255;95695;96211;97189;105965.47017264864;7562.546247225184;8604.483730975911;9821.214302855897;9880.555375007998;9887.802243954937;53067.46932530625;60279;64863.027054595164;65431.67284163549;68083.65958170178;91545.54227229087;97367.51316243374;97593;98293.50853245688;101012;12060.97481714064;12788.744225115259;13245.20528768277;13246.403911824184;13254.403551839998;13571.52499662507;14717.33771980242;14883.85116148868;15008.924955375152;15278.694426111639;13631.087886743204;13720.65698357509;13775;13851.597876828246;14099.718005640036;13586.79619805684;13691.178529288274;13696.246706431242;13962;14235.572932812032;13195;13284.601461956157;13324.666883327995;13359.465621375037;13389.799153012518;11200.271982321123;11208.943955280172;11385.146114041645;11516.712082198012;11812.40937953116;11055.889441105808;11285;11383.487743051417;11541.422928853355;11569.7107572308 04:33:53 INFO - PROCESS | 1659 | __end_tp_report 04:33:53 INFO - PROCESS | 1659 | __start_cc_report 04:33:53 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1230 04:33:53 INFO - PROCESS | 1659 | __end_cc_report 04:33:53 INFO - PROCESS | 1659 | __startTimestamp1472470433713__endTimestamp 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | ------- Summary: start ------- 04:33:53 INFO - PROCESS | 1659 | Number of tests: 6 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5692.86 Median:5833.91 stddev:666.12 (11.4%) stddev-sans-first:626.62 04:33:53 INFO - PROCESS | 1659 | Values: 2740.9 3320.3 3357.9 3364.7 3405.2 5570.2 5642.3 5673.3 5728.6 5737.6 4628.6 5646.5 5732.3 5757.1 5814.8 5140.4 5165.9 5190.5 5193.4 5316.9 5292.6 5295.1 5295.2 5299.4 5303.3 5084.7 5125.1 5155.8 5196.7 5245.0 4432.3 5144.3 5176.9 5196.1 5206.9 4256.3 5097.5 5171.5 5190.8 5269.6 5583.2 5628.0 5645.0 5675.0 5714.5 6226.5 6232.9 6233.4 6261.7 6267.0 5814.0 6143.2 6150.5 6229.2 6255.3 5754.9 5784.7 5829.5 5830.9 5833.9 6331.7 6336.6 6339.4 6347.4 6374.6 5916.2 5965.0 6086.1 6137.5 6139.4 6258.6 6263.0 6265.4 6274.3 6280.2 5649.2 6188.2 6196.6 6206.8 6220.2 5749.5 6074.7 6105.9 6144.5 6147.0 4963.8 4970.3 4972.2 4975.4 5018.1 4421.6 4423.9 4427.6 4455.0 4477.5 5546.6 5585.6 5590.5 5677.9 5695.1 6183.0 6251.9 6253.3 6254.7 6285.3 5668.4 5674.0 5676.5 5687.8 5732.0 5288.8 5318.8 5324.9 5357.3 5401.2 6267.0 6303.2 6334.4 6336.7 6356.9 6288.4 6295.9 6301.7 6307.7 6317.6 6241.7 6285.6 6311.1 6326.6 6330.8 5989.2 6033.9 6110.2 6159.6 6195.5 6245.7 6285.9 6291.5 6294.7 6305.0 5934.5 6041.0 6050.9 6053.5 6055.4 5688.4 5902.8 5979.0 6089.4 6113.3 5808.3 5883.7 5896.8 5919.4 5939.0 5060.5 6026.8 6034.5 6040.5 6053.8 5664.4 5810.2 5836.3 5842.7 5868.3 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:60572.56 Median:22474.45 stddev:131467.87 (585.0%) stddev-sans-first:131759.25 04:33:53 INFO - PROCESS | 1659 | Values: 478.9 521.0 530.4 531.6 532.7 40096.8 41565.2 41707.0 41732.0 44063.6 42876.6 43251.8 43341.6 43350.8 43378.1 9775.2 9965.0 9970.8 9985.6 9988.7 9775.0 9845.5 9866.3 9873.9 9882.0 9848.2 9878.4 9896.6 9903.0 9916.0 9820.6 9868.0 9885.3 9888.2 9891.5 9772.6 9880.8 9888.9 9889.8 9892.7 40835.4 41157.6 41197.4 41268.0 41334.6 3354.6 3406.8 3428.2 3861.4 4113.5 30712.4 31088.8 31401.5 32364.5 32416.5 3232.2 3240.0 3240.2 3246.8 3358.4 506099.0 507401.0 509092.0 640256.0 642256.8 62325.7 62990.7 63003.0 63025.7 63072.0 33787.5 34826.8 65953.7 66124.0 66458.7 16519.0 16622.4 16637.9 16640.6 16645.3 12792.5 12891.5 12892.4 12895.0 12922.3 16985.9 19240.3 19255.9 19303.7 19305.4 7602.2 8108.7 8139.1 8163.5 8198.4 853.7 897.6 997.0 1039.3 1124.9 29844.0 29922.0 30131.2 30792.5 30970.0 1011.5 1046.4 1085.0 1129.5 1140.6 14928.9 15575.5 15602.3 15622.4 16046.4 169600.0 169971.0 170047.0 170892.0 171176.0 58059.0 58906.4 58989.0 58993.4 58994.0 1224.6 1258.3 1363.7 1376.4 1388.5 27116.6 29126.3 30505.7 30749.3 31264.7 51073.7 51963.7 52062.7 52065.0 52071.7 597797.0 608845.0 610518.0 610629.0 611652.0 42360.4 43123.4 43446.3 43451.8 44965.3 40183.8 47307.5 48064.5 48245.5 49545.3 38963.8 39005.0 39503.6 40150.6 40681.0 37857.2 38390.7 38503.4 39131.0 39691.8 32485.8 33095.0 38227.8 38699.6 38850.8 31702.0 34484.7 34750.7 35254.6 36186.6 23327.4 25019.4 25451.9 25896.3 25915.7 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:34270.68 Median:2270.11 stddev:96656.76 (4257.8%) stddev-sans-first:96894.38 04:33:53 INFO - PROCESS | 1659 | Values: 364.2 369.5 377.0 389.2 395.0 19374.9 20681.5 20789.4 20820.9 21094.8 20111.4 20976.7 21425.5 21617.0 21637.2 5746.5 5848.1 6002.5 6020.7 6024.4 4145.2 4369.7 5872.4 5999.7 6327.9 6614.8 6628.5 6655.0 6681.0 6710.1 6371.8 6586.0 6648.4 6649.5 6674.4 5643.0 5699.5 5740.3 5740.3 5770.2 26558.7 26629.7 26658.9 26671.9 26987.7 2228.0 2409.3 2747.6 3084.2 3193.4 14833.1 15592.7 15821.4 15915.8 16243.3 1665.8 1845.9 1861.8 1976.0 2029.9 124154.0 127511.4 129868.4 130518.0 130963.0 11066.8 11479.9 11498.6 11511.5 11720.9 14420.9 14440.0 14441.4 14446.6 14454.7 8228.5 8473.7 8535.7 8655.7 8666.4 8522.1 8576.8 8584.9 8740.7 8777.3 3699.6 4376.5 4506.9 4565.5 4566.6 1744.8 1792.0 1845.4 1876.5 1899.3 844.1 857.7 890.0 942.6 986.2 20618.4 20984.7 21061.8 21092.3 21095.5 880.3 903.2 917.7 935.7 954.5 6107.7 8706.8 10973.1 11026.7 11148.3 571867.3 574450.0 582345.0 584463.0 585526.0 75377.0 83747.0 89878.0 125530.7 134491.0 962.0 969.7 970.1 978.0 996.9 17171.7 17405.8 18348.1 18635.9 18657.0 54298.0 54662.7 55244.2 55388.4 55866.7 76353.6 76921.0 77392.6 77634.6 78082.6 5530.8 7856.8 8109.5 8229.3 8255.7 11019.5 12717.1 12875.2 13091.7 13128.5 9343.4 11154.7 11362.6 11440.7 11456.5 8789.7 9066.4 10946.2 11055.7 11223.4 11360.6 11451.8 11524.9 11590.0 11720.4 8026.8 8103.9 8107.5 8159.0 8329.8 8206.9 9459.1 11096.9 11126.3 11583.3 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5645.03 Median:5010.21 stddev:3172.84 (63.3%) stddev-sans-first:3165.15 04:33:53 INFO - PROCESS | 1659 | Values: 1328.2 1474.9 1507.6 1695.7 1894.7 7689.2 8553.7 8818.3 8833.1 8971.6 8749.7 8830.3 8839.8 8864.9 8865.5 2328.2 2374.6 2375.7 2376.3 2376.8 2312.5 2348.7 2360.0 2364.0 2375.4 2326.9 2347.0 2354.2 2360.0 2362.4 2287.5 2315.8 2315.8 2322.2 2343.7 2333.1 2339.5 2340.4 2346.0 2354.5 8508.7 8748.2 8757.6 8831.0 8857.9 4614.6 5180.3 5368.5 5387.5 5402.6 3364.8 3519.1 3587.0 3592.8 3595.5 1002.6 1031.9 1043.6 1057.8 1059.0 11458.8 11542.6 11566.0 11597.7 11606.9 4314.7 4380.7 4549.3 4551.8 4559.9 9080.5 9090.9 9099.0 9104.1 9123.7 5222.0 5224.9 5227.1 5229.1 5234.7 4180.4 4336.8 4664.3 4835.0 4889.0 3681.5 3681.7 3789.2 3792.7 3830.5 1149.9 1162.9 1172.8 1174.0 1181.7 844.5 860.0 907.2 912.9 935.3 5683.5 5751.8 6014.6 6042.7 6210.4 766.8 879.6 884.3 927.6 947.6 3922.7 4011.7 4055.9 4081.2 4136.5 10456.4 10829.5 10835.1 10839.3 10848.1 10750.7 10751.5 10777.4 10791.3 10794.8 8079.4 8195.3 8216.6 8216.6 8231.8 5087.6 5509.7 5812.3 5873.9 5962.9 9566.4 9902.0 9918.6 10061.4 10066.5 9182.1 9949.4 10177.3 10178.5 10180.6 7295.9 7418.0 7480.0 7522.5 7536.9 8156.2 8226.5 8231.5 8233.0 8261.4 7228.7 7416.1 7457.4 7570.2 7574.2 6253.2 7133.3 7253.9 7258.9 7285.9 6862.7 7008.5 7010.0 7012.0 7019.5 4831.4 4909.2 4941.9 5028.6 5072.2 4971.3 4991.9 5050.5 5209.8 5217.4 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4481.93 Median:5046.89 stddev:1383.29 (27.4%) stddev-sans-first:1351.06 04:33:53 INFO - PROCESS | 1659 | Values: 298.5 301.6 307.8 313.8 315.2 4695.9 5271.9 5354.9 5374.4 5416.6 4215.7 4736.1 5016.9 5056.9 5273.8 3827.3 3865.5 4013.6 4037.0 4066.7 4081.7 4081.8 4094.9 4128.9 4137.3 3477.0 3610.7 3692.4 4028.4 4056.1 3752.9 3804.6 3862.7 4023.9 4049.8 3233.5 3502.5 3507.6 3512.5 3515.9 5122.8 5129.3 5142.4 5193.7 5200.9 4369.2 4570.5 4629.4 4635.0 4635.7 5492.1 5500.7 5505.3 5513.0 5550.9 3426.4 3863.5 3896.8 3902.6 3916.2 5596.6 5849.6 5887.2 5902.0 5948.2 3414.2 3674.7 3914.5 3930.3 3939.6 3425.6 4000.8 4009.7 4044.0 4109.1 3883.9 3912.2 4632.7 4643.5 4646.4 5181.6 5495.7 5608.3 5642.9 5648.9 1088.2 1243.6 1367.8 1381.7 1393.2 802.8 846.6 857.6 862.2 870.3 4267.9 4744.6 4922.8 5200.6 5229.8 4641.4 4667.6 5422.6 5426.0 5675.5 4929.5 5169.5 5209.3 5212.6 5248.9 2978.1 2983.1 2997.4 2998.8 3007.9 5337.8 5401.1 5725.6 5839.8 5905.4 5198.4 5846.8 5875.6 5897.6 5956.9 5028.8 5982.2 6000.5 6030.8 6036.3 5286.6 5771.4 5866.7 5901.6 5902.3 4641.9 5036.8 5673.2 5679.2 5709.2 4982.6 5387.5 5624.1 5679.7 6017.8 3256.6 3282.0 3328.9 3409.2 3892.9 4421.9 4981.8 5261.8 5457.4 5792.4 4475.6 5522.8 5538.0 5555.7 5589.4 5250.7 5527.8 5626.3 5627.7 5642.4 4709.2 4748.7 5432.3 5432.8 5455.4 5253.4 5413.9 5464.9 5484.5 5530.8 4518.0 4906.6 5278.5 5316.8 5434.2 04:33:53 INFO - PROCESS | 1659 | 04:33:53 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:22643.94 Median:4283.10 stddev:34212.11 (798.8%) stddev-sans-first:34268.20 04:33:53 INFO - PROCESS | 1659 | Values: 643.4 695.4 699.0 732.7 809.8 12898.2 13108.9 15649.7 15656.9 15700.8 13946.3 14068.4 14071.9 14483.5 15341.7 859.6 875.2 882.1 883.1 885.9 887.1 889.2 890.1 891.2 891.3 632.5 710.0 733.8 735.1 740.2 681.5 695.0 729.4 730.6 731.4 538.0 542.0 542.8 542.9 543.3 15281.4 15325.5 15347.0 15363.2 15385.2 13935.4 13957.4 14221.6 14289.4 14558.0 10533.4 10560.2 11671.0 11975.2 12140.9 3660.5 3728.8 3813.6 3825.5 3887.5 99139.0 122895.0 124768.0 126395.0 127017.7 10321.8 10326.2 10746.1 10802.6 11165.9 21733.9 21913.5 22372.0 22388.0 22434.7 7612.4 7865.6 7877.0 8143.9 8245.8 4378.2 4417.4 4463.4 4468.1 4652.3 3311.0 3477.4 3488.1 3646.5 3653.2 669.3 688.1 692.8 719.0 722.7 588.9 648.1 654.3 656.8 669.6 8572.6 8920.4 9457.8 9591.3 9602.7 560.8 600.9 642.5 653.8 677.8 4188.0 4625.0 4641.8 4653.5 4746.0 82204.0 83318.0 85023.6 87009.0 97307.5 89836.6 115789.0 119294.0 122847.0 123759.8 60754.8 95695.0 96211.0 97189.0 105965.5 7562.5 8604.5 9821.2 9880.6 9887.8 53067.5 60279.0 64863.0 65431.7 68083.7 91545.5 97367.5 97593.0 98293.5 101012.0 12061.0 12788.7 13245.2 13246.4 13254.4 13571.5 14717.3 14883.9 15008.9 15278.7 13631.1 13720.7 13775.0 13851.6 14099.7 13586.8 13691.2 13696.2 13962.0 14235.6 13195.0 13284.6 13324.7 13359.5 13389.8 11200.3 11208.9 11385.1 11516.7 11812.4 11055.9 11285.0 11383.5 11541.4 11569.7 04:33:53 INFO - PROCESS | 1659 | -------- Summary: end -------- 04:33:53 INFO - PROCESS | 1659 | 04:33:54 INFO - TEST-INFO | 1659: exit 0 04:33:54 INFO - TEST-OK | dromaeo_css | took 1117364ms 04:33:54 INFO - TEST-START | kraken 04:33:54 INFO - operating with platform_type : mac_ 04:33:54 INFO - Initialising browser for kraken test... 04:33:54 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpJKVbwY/profile http://localhost:49270/getInfo.html) 04:33:56 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 04:33:56 INFO - PROCESS | 1665 | colorDepth:24 04:33:56 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 04:33:56 INFO - PROCESS | 1665 | __metrics 04:33:56 INFO - PROCESS | 1665 | 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" 04:33:56 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:57 INFO - TEST-INFO | 1665: exit 0 04:33:57 INFO - Browser initialized. 04:33:57 INFO - Running cycle 1/1 for kraken test... 04:33:57 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpJKVbwY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:09 INFO - PROCESS | 1666 | RSS: Main: 233369600 04:34:09 INFO - PROCESS | 1666 | 04:34:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:13 INFO - PROCESS | 1666 | RSS: Main: 290926592 04:34:13 INFO - PROCESS | 1666 | 04:34:15 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 04:34:16 INFO - PROCESS | 1666 | RSS: Main: 287248384 04:34:16 INFO - PROCESS | 1666 | 04:34:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 04:34:20 INFO - PROCESS | 1666 | RSS: Main: 379588608 04:34:20 INFO - PROCESS | 1666 | 04:34:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 04:34:23 INFO - PROCESS | 1666 | RSS: Main: 281341952 04:34:23 INFO - PROCESS | 1666 | 04:34:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:26 INFO - PROCESS | 1666 | RSS: Main: 283123712 04:34:26 INFO - PROCESS | 1666 | 04:34:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:29 INFO - PROCESS | 1666 | RSS: Main: 320606208 04:34:29 INFO - PROCESS | 1666 | 04:34:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:33 INFO - PROCESS | 1666 | RSS: Main: 323837952 04:34:33 INFO - PROCESS | 1666 | 04:34:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 04:34:36 INFO - PROCESS | 1666 | RSS: Main: 321396736 04:34:36 INFO - PROCESS | 1666 | 04:34:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:38 INFO - PROCESS | 1666 | RSS: Main: 297164800 04:34:38 INFO - PROCESS | 1666 | 04:34:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:41 INFO - PROCESS | 1666 | RSS: Main: 300781568 04:34:41 INFO - PROCESS | 1666 | 04:34:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:44 INFO - PROCESS | 1666 | RSS: Main: 305594368 04:34:44 INFO - PROCESS | 1666 | 04:34:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:48 INFO - PROCESS | 1666 | RSS: Main: 320962560 04:34:48 INFO - PROCESS | 1666 | 04:34:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:51 INFO - PROCESS | 1666 | RSS: Main: 317083648 04:34:51 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 04:34:53 INFO - PROCESS | 1666 | RSS: Main: 359936000 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | __start_tp_report 04:34:53 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 04:34:53 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 04:34:53 INFO - PROCESS | 1666 | |i|pagename|runs| 04:34:53 INFO - PROCESS | 1666 | |0;ai-astar;112;113;133;113;114;114;113;113;113;113 04:34:53 INFO - PROCESS | 1666 | |1;audio-beat-detection;148;117;162;151;134;162;162;106;159;126 04:34:53 INFO - PROCESS | 1666 | |2;audio-dft;189;186;259;218;185;185;189;185;183;183 04:34:53 INFO - PROCESS | 1666 | |3;audio-fft;78;73;77;153;61;74;82;95;152;57 04:34:53 INFO - PROCESS | 1666 | |4;audio-oscillator;83;84;130;69;74;91;117;68;70;116 04:34:53 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;90;88;89;87;89;88;90;88;90;86 04:34:53 INFO - PROCESS | 1666 | |6;imaging-darkroom;96;98;101;98;97;97;97;98;97;113 04:34:53 INFO - PROCESS | 1666 | |7;imaging-desaturate;86;85;85;84;85;85;85;85;84;83 04:34:53 INFO - PROCESS | 1666 | |8;json-parse-financial;54;55;55;54;54;54;55;55;54;54 04:34:53 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;67;74;80;78;72;72;70;70;71 04:34:53 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;86;88;90;85;92;106;106;109;89;86 04:34:53 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;141;138;137;137;140;139;132;158;202;155 04:34:53 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;172;172;213;239;238;174;171;170;177;172 04:34:53 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;74;87;88;59;75;87;89;89;72;67 04:34:53 INFO - PROCESS | 1666 | __end_tp_report 04:34:53 INFO - PROCESS | 1666 | __start_cc_report 04:34:53 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2093 04:34:53 INFO - PROCESS | 1666 | __end_cc_report 04:34:53 INFO - PROCESS | 1666 | __startTimestamp1472470493943__endTimestamp 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | ------- Summary: start ------- 04:34:53 INFO - PROCESS | 1666 | Number of tests: 14 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:115.10 Median:113.00 stddev:6.31 (5.6%) stddev-sans-first:6.60 04:34:53 INFO - PROCESS | 1666 | Values: 112.0 113.0 133.0 113.0 114.0 114.0 113.0 113.0 113.0 113.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:155.00 stddev:20.66 (13.3%) stddev-sans-first:21.83 04:34:53 INFO - PROCESS | 1666 | Values: 148.0 117.0 162.0 151.0 134.0 162.0 162.0 106.0 159.0 126.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:196.20 Median:187.50 stddev:24.38 (13.0%) stddev-sans-first:25.72 04:34:53 INFO - PROCESS | 1666 | Values: 189.0 186.0 259.0 218.0 185.0 185.0 189.0 185.0 183.0 183.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:90.20 Median:75.50 stddev:34.46 (45.6%) stddev-sans-first:36.27 04:34:53 INFO - PROCESS | 1666 | Values: 78.0 73.0 77.0 153.0 61.0 74.0 82.0 95.0 152.0 57.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:72.00 stddev:22.78 (31.6%) stddev-sans-first:24.02 04:34:53 INFO - PROCESS | 1666 | Values: 83.0 84.0 130.0 69.0 74.0 91.0 117.0 68.0 70.0 116.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:1.35 (1.5%) stddev-sans-first:1.32 04:34:53 INFO - PROCESS | 1666 | Values: 90.0 88.0 89.0 87.0 89.0 88.0 90.0 88.0 90.0 86.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:97.00 stddev:5.03 (5.2%) stddev-sans-first:5.20 04:34:53 INFO - PROCESS | 1666 | Values: 96.0 98.0 101.0 98.0 97.0 97.0 97.0 98.0 97.0 113.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 04:34:53 INFO - PROCESS | 1666 | Values: 86.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 84.0 83.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 04:34:53 INFO - PROCESS | 1666 | Values: 54.0 55.0 55.0 54.0 54.0 54.0 55.0 55.0 54.0 54.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:4.25 (5.9%) stddev-sans-first:4.09 04:34:53 INFO - PROCESS | 1666 | Values: 67.0 67.0 74.0 80.0 78.0 72.0 72.0 70.0 70.0 71.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:93.70 Median:87.00 stddev:9.44 (10.9%) stddev-sans-first:9.59 04:34:53 INFO - PROCESS | 1666 | Values: 86.0 88.0 90.0 85.0 92.0 106.0 106.0 109.0 89.0 86.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:140.50 stddev:20.70 (14.7%) stddev-sans-first:21.81 04:34:53 INFO - PROCESS | 1666 | Values: 141.0 138.0 137.0 137.0 140.0 139.0 132.0 158.0 202.0 155.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.80 Median:175.50 stddev:28.66 (16.3%) stddev-sans-first:29.66 04:34:53 INFO - PROCESS | 1666 | Values: 172.0 172.0 213.0 239.0 238.0 174.0 171.0 170.0 177.0 172.0 04:34:53 INFO - PROCESS | 1666 | 04:34:53 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.70 Median:87.00 stddev:10.76 (12.4%) stddev-sans-first:11.28 04:34:53 INFO - PROCESS | 1666 | Values: 74.0 87.0 88.0 59.0 75.0 87.0 89.0 89.0 72.0 67.0 04:34:53 INFO - PROCESS | 1666 | -------- Summary: end -------- 04:34:53 INFO - PROCESS | 1666 | 04:34:54 INFO - TEST-INFO | 1666: exit 0 04:34:54 INFO - TEST-OK | kraken | took 60447ms 04:34:54 INFO - SUITE-END | took 1177s 04:34:55 INFO - Completed test suite (00:19:38) 04:34:55 INFO - javascript benchmark 04:34:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2740.876240741296, 3320.2529430878058, 3357.882474113405, 3364.6971772540464, 3405.1997780521574, 5570.192322113291, 5642.266505354309, 5673.319201695792, 5728.5989980701315, 5737.627054241471, 4628.606568441678, 5646.548276137909, 5732.312122545301, 5757.050086735694, 5814.796482123126, 5140.434552199255, 5165.922511162316, 5190.532852043315, 5193.402758682762, 5316.867078323035, 5292.550133238679, 5295.099833028395, 5295.205719142121, 5299.417064122943, 5303.2575439438315, 5084.669496482717, 5125.1287281162295, 5155.793768249266, 5196.700824793802, 5245.0, 4432.268675668511, 5144.279800827887, 5176.948230517684, 5196.090684130262, 5206.895862082737, 4256.34026725858, 5097.528999486578, 5171.50870667286, 5190.766415511311, 5269.604779641504, 5583.246261754652, 5627.986962346776, 5645.0, 5674.978503869302, 5714.45712657301, 6226.470749986257, 6232.875342493125, 6233.407826256498, 6261.686915654244, 6266.968665156691, 5814.0, 6143.232095988002, 6150.538709596798, 6229.190205273286, 6255.280642726099, 5754.88490230193, 5784.71076446176, 5829.504492118217, 5830.8542286442325, 5833.912491312633, 6331.68341582919, 6336.588121772163, 6339.366063393716, 6347.428731414195, 6374.649394283359, 5916.171735956969, 5964.970175149097, 6086.147939288503, 6137.4689182037, 6139.416755408229, 6258.593191442542, 6262.968685156545, 6265.373462653698, 6274.309825919146, 6280.183576135165, 5649.180868774087, 6188.164597779332, 6196.597221180609, 6206.813795586139, 6220.160278362454, 5749.453801888814, 6074.696265186723, 6105.938940610626, 6144.539159562962, 6146.955017647011, 4963.8014479421145, 4970.254461830682, 4972.229304457815, 4975.4278258000795, 5018.146915024382, 4421.579949904753, 4423.867283981485, 4427.623651989553, 4454.955450445454, 4477.462704475419, 5546.611737178358, 5585.553155747531, 5590.496855283044, 5677.943220567824, 5695.088785794336, 6182.969085154546, 6251.874962500816, 6253.280872699698, 6254.6872656366995, 6285.308616052231, 5668.376478587352, 5673.971630141823, 5676.545876329884, 5687.829365119053, 5732.0, 5288.81489147878, 5318.760655770422, 5324.866878328073, 5357.303550538405, 5401.243825864382, 6267.0, 6303.243610766737, 6334.429901308904, 6336.746530138743, 6356.872862542723, 6288.402601752826, 6295.905561416674, 6301.7164227608955, 6307.7476900925285, 6317.5893566918, 6241.656708881055, 6285.560010799383, 6311.053341998737, 6326.557141000086, 6330.778422755181, 5989.1914591529585, 6033.879322413615, 6110.236220472441, 6159.5688301818445, 6195.473384762166, 6245.718942647501, 6285.937140628718, 6291.496680265659, 6294.6852657366035, 6304.991201407753, 5934.546036221153, 6041.0, 6050.909236361546, 6053.545984051302, 6055.364186760503, 5688.402717714746, 5902.793402230901, 5978.970105149447, 6089.360617135314, 6113.266408031065, 5808.273965754281, 5883.705814709333, 5896.764129434946, 5919.437653422918, 5938.970305148619, 5060.51925067118, 6026.849328766816, 6034.487068599043, 6040.546958978182, 6053.848653783691, 5664.405237450173, 5810.215620891126, 5836.299644042742, 5842.737076831638, 5868.295804503487], "value": 5648.960174669222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.9281607758838, 521.0100808463918, 530.358266497538, 531.572084472, 532.7469452010296, 40096.797096087124, 41565.168696626046, 41706.95732606686, 41732.0, 44063.55936440635, 42876.57123428765, 43251.78374108125, 43341.56658433423, 43350.7832460838, 43378.13243735123, 9775.217982561397, 9964.950175249114, 9970.800583988315, 9985.600575976952, 9988.650397236099, 9775.0, 9845.45849978251, 9866.260030497742, 9873.851892221623, 9881.950590247076, 9848.212143028577, 9878.357906736039, 9896.604135834594, 9902.950485247564, 9915.950420247924, 9820.558074886612, 9867.96386379427, 9885.25860560461, 9888.159506441962, 9891.455969921652, 9772.609095636166, 9880.802383952281, 9888.851667224997, 9889.75275618108, 9892.703218903445, 40835.38746918798, 41157.588424115675, 41197.38203926943, 41268.0, 41334.58665413367, 3354.5974483062187, 3406.8466918988706, 3428.211511352403, 3861.420786881962, 4113.506379234481, 30712.385752285052, 31088.8445557773, 31401.52897706536, 32364.514532282035, 32416.513752293733, 3232.208109013307, 3240.044186964851, 3240.189952511872, 3246.772725909187, 3358.44585643371, 506099.0, 507401.0, 509092.0, 640256.0, 642256.7887160581, 62325.68837155785, 62990.68504657447, 63003.0, 63025.68487157627, 63072.0, 33787.49318760221, 34826.82586587051, 65953.67023164853, 66124.0, 66458.66770666116, 16519.0, 16622.418215362406, 16637.91681041587, 16640.583985400463, 16645.33418663264, 12792.488300467878, 12891.48434062627, 12892.419841107172, 12894.968402527775, 12922.289274089828, 16985.89591676537, 19240.326588569333, 19255.940923249356, 19303.710444343345, 19305.420837374902, 7602.201768814305, 8108.716194933149, 8139.1453897339925, 8163.510189388656, 8198.42611017235, 853.7268074216191, 897.5736525150501, 996.9601215951426, 1039.3192458939407, 1124.8706398764084, 29844.0, 29922.0, 30131.246718832204, 30792.538111928337, 30970.0, 1011.4993078426226, 1046.398320965448, 1084.951177197028, 1129.4635048352131, 1140.5779861451317, 14928.850711492963, 15575.454859079879, 15602.297896594453, 15622.437756224286, 16046.438374657064, 169600.0, 169971.0, 170047.0, 170892.0, 171176.0, 58059.0, 58906.41093589095, 58989.0, 58993.41006589879, 58994.0, 1224.5652793258444, 1258.2764910176868, 1363.7477066742683, 1376.3599926034242, 1388.5417812121975, 27116.593251101644, 29126.27184320409, 30505.694943050286, 30749.335942960603, 31264.687353126177, 51073.744631276604, 51963.740181298854, 52062.73968630133, 52064.95870082653, 52071.73964130155, 597797.0, 608845.0, 610518.0, 610629.0, 611652.0, 42360.36459453049, 43123.353149703406, 43446.26214951366, 43451.78274108736, 44965.32552011657, 40183.79908100558, 47307.52692473169, 48064.5193548074, 48245.5175448255, 49545.25682114843, 38963.80518097391, 39005.0, 39503.60496394999, 40150.59849401469, 40681.0, 37857.24285514219, 38390.65632702842, 38503.422448662735, 39131.021724455975, 39691.80154099211, 32485.837570811993, 33095.0, 38227.80886095552, 38699.6130038696, 38850.80574597109, 31702.0, 34484.65515344815, 34750.652493475754, 35254.64745352514, 36186.638133618326, 23327.41681457977, 25019.41573570712, 25451.87274063618, 25896.302813381026, 25915.74314783139], "value": 19834.977995857033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.24601075773154, 369.4716555325883, 376.9905752356191, 389.2312682452156, 394.982225799839, 19374.93437860917, 20681.482962925933, 20789.376318710445, 20820.8958955205, 21094.789052109474, 20111.39665810028, 20976.74139551624, 21425.46436339092, 21617.02723377448, 21637.242696505626, 5746.51154651853, 5848.064309710437, 6002.519798416138, 6020.698965051752, 6024.397560243962, 4145.233131870598, 4369.672274579403, 5872.354041055481, 5999.730012149442, 6327.936720632781, 6614.768483103092, 6628.4697224221945, 6655.036764154586, 6680.966595167018, 6710.127683401151, 6371.808845734636, 6585.967070164618, 6648.401643852028, 6649.5012874034155, 6674.432673222782, 5642.971785141089, 5699.487046165865, 5740.253767010262, 5740.311162660466, 5770.2210201622665, 26558.73441265582, 26629.733702662917, 26658.86670566654, 26671.932727736366, 26987.730122698915, 2228.0, 2409.349475641567, 2747.5603903375363, 3084.1826915867314, 3193.409219294415, 14833.110013399231, 15592.688146237011, 15821.369381601879, 15915.840841591551, 16243.269052892649, 1665.800103987517, 1845.8523318134517, 1861.8324350808357, 1975.9703604445945, 2029.8579099463043, 124154.0, 127511.36244318719, 129868.3506582461, 130518.0, 130963.0, 11066.833997490045, 11479.942600286946, 11498.573049376051, 11511.48198331077, 11720.941395292968, 14420.927895360455, 14440.0, 14441.422343106158, 14446.638834029234, 14454.710905781825, 8228.547429891294, 8473.70342038038, 8535.695362252158, 8655.6970506032, 8666.350023748244, 8522.147785221552, 8576.785580360542, 8584.8712269316, 8740.737777866674, 8777.297816174818, 3699.6300369962787, 4376.518582955872, 4506.909861802746, 4565.474970378383, 4566.611837993808, 1744.7819022622173, 1791.973120403195, 1845.4094689699168, 1876.4839669090836, 1899.2877670873422, 844.1010324004915, 857.6697971280977, 889.9866502002475, 942.6465075596651, 986.2473289134911, 20618.381448556567, 20984.74736415858, 21061.789382105984, 21092.261770837948, 21095.472613184793, 880.308957468397, 903.2322525852973, 917.682850801731, 935.6538080910107, 954.4607296877242, 6107.694615269219, 8706.825863482694, 10973.122150227962, 11026.669199924016, 11148.2753621016, 571867.2813271898, 574450.0, 582345.0, 584463.0, 585526.0, 75377.0, 83747.0, 89878.0, 125530.74469255374, 134491.0, 962.0427674463813, 969.6896992962326, 970.0897308075772, 978.0464047553578, 996.8685541909985, 17171.742423863903, 17405.82594174042, 18348.08259587042, 18635.90682046581, 18657.0, 54298.0, 54662.72668636632, 55244.171337429165, 55388.44611553994, 55866.72066639641, 76353.61823190849, 76921.0, 77392.61303693446, 77634.6118269405, 78082.6095869517, 5530.806421775219, 7856.764297071097, 8109.472884262504, 8229.25936665679, 8255.720363343691, 11019.504122314354, 12717.10980231375, 12875.227486350848, 13091.738165236451, 13128.540501082416, 9343.439393636132, 11154.665360039211, 11362.602308919148, 11440.656780296604, 11456.541738330374, 8789.692360767342, 9066.410683305565, 10946.233763636468, 11055.668329949793, 11223.382713950485, 11360.602378916697, 11451.828222576502, 11524.94237528807, 11590.014848737952, 11720.355380454157, 8026.799330016796, 8103.878441823495, 8107.473014254055, 8158.959205203936, 8329.759114258495, 8206.862788731056, 9459.10138536838, 11096.944515277371, 11126.276792008493, 11583.305001699924], "value": 9641.076975740676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.1831673520776, 1474.874635655969, 1507.6230942264433, 1695.7032519309125, 1894.6873765828648, 7689.231076892315, 8553.657853685852, 8818.338624603148, 8833.11668833118, 8971.596278167483, 8749.737507874757, 8830.293576513879, 8839.77900552485, 8864.911350886488, 8865.512396818172, 2328.196772113618, 2374.6319320505263, 2375.70303712036, 2376.3227480168157, 2376.8098552115875, 2312.491251924574, 2348.729896061958, 2360.0441821062414, 2363.9645405318934, 2375.4417711837705, 2326.9069237230574, 2347.0, 2354.223106374901, 2359.95280094398, 2362.397588614901, 2287.4853158039473, 2315.7568455312203, 2315.837891347598, 2322.175627652176, 2343.718753749561, 2333.101755824003, 2339.4619237575284, 2340.379799353173, 2346.0, 2354.5173239485866, 8508.702195423131, 8748.212660860552, 8757.649694012232, 8830.955845220733, 8857.911420885837, 4614.561616646413, 5180.3265575475325, 5368.543673787733, 5387.488188622075, 5402.621816472849, 3364.814935178564, 3519.1202199450136, 3586.9820650896577, 3592.8383222755037, 3595.478655594924, 1002.6340385759146, 1031.9422591843345, 1043.5564884923954, 1057.8413238014282, 1059.0362769879373, 11458.770824583462, 11542.596009139725, 11565.95906368431, 11597.724250332456, 11606.941965290203, 4314.697971142053, 4380.715253508575, 4549.27211646135, 4551.7724113794175, 4559.863204103882, 9080.455172689659, 9090.90909090914, 9099.0, 9104.089591040844, 9123.680671176477, 5221.973890130601, 5224.895502090013, 5227.085260079471, 5229.08491014071, 5234.685918844882, 4180.372944058355, 4336.783160841946, 4664.253719404879, 4834.95165048352, 4889.0, 3681.466187402865, 3681.7054635629083, 3789.242151569697, 3792.715546333981, 3830.5211848518934, 1149.8620165580016, 1162.9302241865514, 1172.7771723372532, 1174.0150024045438, 1181.6573193773881, 844.4553263145237, 859.9742007739778, 907.2379201470796, 912.9452232866049, 935.3218916285774, 5683.460071293221, 5751.798687046017, 6014.6391216527145, 6042.697865106815, 6210.378962103753, 766.7623036858591, 879.5514287713185, 884.2925659472396, 927.5547737086237, 947.6351604632129, 3922.686185105185, 4011.7314859386, 4055.913595279797, 4081.2449696806184, 4136.482939632546, 10456.424896630606, 10829.512671929782, 10835.079018283534, 10839.295445795999, 10848.077913377452, 10750.677479675622, 10751.462426878625, 10777.407242601732, 10791.298565593212, 10794.838077428845, 8079.3536517079665, 8195.34437245019, 8216.630251638691, 8216.630251638691, 8231.794205144799, 5087.567556757717, 5509.724513774376, 5812.273465816773, 5873.853153671022, 5962.940370596239, 9566.426014439156, 9901.950490247502, 9918.553665085234, 10061.446620435947, 10066.496675166067, 9182.081791820765, 9949.353292035994, 10177.287589868638, 10178.49107544605, 10180.592776289162, 7295.8540829184185, 7417.962910185414, 7480.0, 7522.548647081193, 7536.886946695694, 8156.184381561797, 8226.547539885363, 8231.547264900488, 8233.0, 8261.38039647041, 7228.710851565878, 7416.110066792019, 7457.366123879531, 7570.242975702386, 7574.166841647304, 6253.187085678833, 7133.322334378226, 7253.891191632235, 7258.854822903618, 7285.854282914418, 6862.696087743313, 7008.474364422791, 7010.018597396471, 7012.0, 7019.543729657556, 4831.396075490564, 4909.165441874961, 4941.925871111865, 5028.572571331331, 5072.213806859942, 4971.304017437634, 4991.850244492671, 5050.494950505067, 5209.765560549708, 5217.373915130209], "value": 4523.150026474501, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4776640878462, 301.5958615455289, 307.8383848479547, 313.8320998265927, 315.16952829294803, 4695.882602934924, 5271.894562108756, 5354.946450535494, 5374.435684253156, 5416.620836541444, 4215.704900656948, 4736.12381709384, 5016.8644597126795, 5056.938043010972, 5273.815416460425, 3827.2919509890758, 3865.4974853269036, 4013.5785742497055, 4036.9596304036877, 4066.7356621819486, 4081.693872959525, 4081.7755023473696, 4094.9181016379653, 4128.917421651565, 4137.2552940470705, 3477.0, 3610.711143108558, 3692.4276737105793, 4028.415879697442, 4056.1482088761395, 3752.9249415011545, 3804.5814960354337, 3862.6909847212155, 4023.8591649292134, 4049.77726225059, 3233.466478031122, 3502.5271588335504, 3507.5790905091553, 3512.5082488451635, 3515.91210219744, 5122.795088196468, 5129.333186685744, 5142.35168888023, 5193.675612718733, 5200.931450444256, 4369.2052489706275, 4570.451545814491, 4629.375034370384, 4635.0, 4635.655659858637, 5492.148716948879, 5500.724963751796, 5505.311836020497, 5512.972435137799, 5550.91673624896, 3426.3832510148163, 3863.517060367454, 3896.8246428910766, 3902.551206611219, 3916.1580260244186, 5596.59346481013, 5849.64902105875, 5887.205227294303, 5902.026165682614, 5948.226730525004, 3414.2488652496413, 3674.7427680062137, 3914.549826769901, 3930.331843586597, 3939.5666476687543, 3425.554677891908, 4000.7599544027453, 4009.69927255457, 4043.959560404417, 4109.0959988802415, 3883.883483495443, 3912.217556488714, 4632.698874573142, 4643.489216186217, 4646.4191976003, 5181.559567436735, 5495.681036551279, 5608.298962629671, 5642.943570564324, 5648.85877853057, 1088.2382332367374, 1243.639344590077, 1367.8426980897125, 1381.7029338692028, 1393.226759148662, 802.8153524689354, 846.6274839070912, 857.6397912876607, 862.1895418306772, 870.2863651805585, 4267.871963841089, 4744.644151688637, 4922.75386230687, 5200.557952573998, 5229.790808367698, 4641.396618439649, 4667.556582124693, 5422.566194704415, 5426.0, 5675.460831221028, 4929.510597148417, 5169.4830516948, 5209.348831396075, 5212.582993360522, 5248.868778280574, 2978.076796193187, 2983.1498023063323, 2997.4005198960294, 2998.7600991920594, 3007.9398412032074, 5337.786488540492, 5401.137397179501, 5725.627834190765, 5839.795607153814, 5905.350411454737, 5198.350206224222, 5846.766129354778, 5875.619229481069, 5897.5871688982215, 5956.880862382728, 5028.7737051832755, 5982.192404025401, 6000.459958603747, 6030.788922387783, 6036.336003039574, 5286.56817863787, 5771.394003629726, 5866.7066646668345, 5901.557383196363, 5902.321233058254, 4641.885947372539, 5036.84889453317, 5673.234113394804, 5679.233303503974, 5709.172170035405, 4982.576480999156, 5387.542058925035, 5624.128260119688, 5679.722062535896, 6017.789377371771, 3256.6254880688075, 3281.9661806530867, 3328.850201740879, 3409.181796368903, 3892.9221415572097, 4421.933670994873, 4981.800727970841, 5261.763220655003, 5457.426970168075, 5792.362840087671, 4475.597196252353, 5522.834314970557, 5537.972310138423, 5555.7499912504845, 5589.385167631639, 5250.711210883438, 5527.778888844401, 5626.2685850839125, 5627.662340259598, 5642.391918303264, 4709.199436095941, 4748.741583480311, 5432.320959880015, 5432.809851655173, 5455.399906010415, 5253.448387919367, 5413.8615246978015, 5464.863378415572, 5484.506394424521, 5530.751116199861, 4518.0, 4906.582940449959, 5278.4721527846905, 5316.840494785162, 5434.184872269033], "value": 4040.4001521833475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.4466358931318, 695.3915324091422, 698.9720411183553, 732.7472022152356, 809.8096947217407, 12898.226106433596, 13108.868911310885, 15649.687006259883, 15656.921715391436, 15700.764488532666, 13946.302684865766, 14068.437262509487, 14071.859281407184, 14483.493077742281, 15341.693166136698, 859.5702148925553, 875.1598465473154, 882.1355072029415, 883.0551310098198, 885.9025507194203, 887.0995939121797, 889.168627333442, 890.1321211818457, 891.2201823404521, 891.2869704236584, 632.4845251120345, 710.0414440505302, 733.7688628082163, 735.1325435985535, 740.1968863782802, 681.512718406337, 694.9957311684567, 729.3690957321932, 730.6310313291754, 731.4112139727517, 537.9778421000132, 542.0487045235626, 542.8344354971732, 542.8778524831921, 543.2665901033613, 15281.388744450209, 15325.540233793005, 15347.00244484105, 15363.231838408146, 15385.230738463144, 13935.372908219155, 13957.441702331895, 14221.644458888508, 14289.428422863073, 14558.0, 10533.420661863594, 10560.207984401124, 11671.0, 11975.161738678296, 12140.878591214063, 3660.5424321959754, 3728.7762734236035, 3813.561440434358, 3825.48355971943, 3887.4751908492276, 99138.99999999927, 122895.0, 124768.0, 126395.0, 127017.72982270151, 10321.793564128675, 10326.22553308505, 10746.140308775279, 10802.621908233174, 11165.944170279097, 21733.891330543247, 21913.452163696034, 22372.0, 22388.0, 22434.663480047813, 7612.352949999312, 7865.567393793396, 7877.0, 8143.877841832259, 8245.79385515367, 4378.211921854033, 4417.3815665806815, 4463.375127482155, 4468.106378724268, 4652.302154676758, 3311.023248141804, 3477.426224672901, 3488.127968007998, 3646.5441819772527, 3653.1597732521136, 669.3306693306694, 688.0814113158889, 692.764460083574, 719.0400814912047, 722.7145277615313, 588.9234399528034, 648.1412128929188, 654.3325807676143, 656.7504348347597, 669.608279156689, 8572.571371431528, 8920.375573709907, 9457.76355591102, 9591.280653950982, 9602.711918642452, 560.8373571664172, 600.9188759517497, 642.5437939063224, 653.8231183869111, 677.7593954146306, 4187.994881228483, 4625.0, 4641.771949464276, 4653.488116307203, 4745.976270118696, 82204.0, 83318.0, 85023.57488212519, 87009.0, 97307.51346243224, 89836.5508172468, 115789.0, 119294.0, 122847.0, 123759.76240237663, 60754.78490430255, 95695.0, 96211.0, 97189.0, 105965.47017264864, 7562.546247225184, 8604.483730975911, 9821.214302855897, 9880.555375007998, 9887.802243954937, 53067.46932530625, 60279.0, 64863.027054595164, 65431.67284163549, 68083.65958170178, 91545.54227229087, 97367.51316243374, 97593.0, 98293.50853245688, 101012.0, 12060.97481714064, 12788.744225115259, 13245.20528768277, 13246.403911824184, 13254.403551839998, 13571.52499662507, 14717.33771980242, 14883.85116148868, 15008.924955375152, 15278.694426111639, 13631.087886743204, 13720.65698357509, 13775.0, 13851.597876828246, 14099.718005640036, 13586.79619805684, 13691.178529288274, 13696.246706431242, 13962.0, 14235.572932812032, 13195.0, 13284.601461956157, 13324.666883327995, 13359.465621375037, 13389.799153012518, 11200.271982321123, 11208.943955280172, 11385.146114041645, 11516.712082198012, 11812.40937953116, 11055.889441105808, 11285.0, 11383.487743051417, 11541.422928853355, 11569.7107572308], "value": 7551.286300268244, "unit": "score"}], "name": "dromaeo_css", "value": 7281.874328788152, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 133.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 162.0, 151.0, 134.0, 162.0, 162.0, 106.0, 159.0, 126.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 186.0, 259.0, 218.0, 185.0, 185.0, 189.0, 185.0, 183.0, 183.0], "value": 196.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 77.0, 153.0, 61.0, 74.0, 82.0, 95.0, 152.0, 57.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 130.0, 69.0, 74.0, 91.0, 117.0, 68.0, 70.0, 116.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 87.0, 89.0, 88.0, 90.0, 88.0, 90.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 101.0, 98.0, 97.0, 97.0, 97.0, 98.0, 97.0, 113.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 74.0, 80.0, 78.0, 72.0, 72.0, 70.0, 70.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 90.0, 85.0, 92.0, 106.0, 106.0, 109.0, 89.0, 86.0], "value": 93.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 137.0, 137.0, 140.0, 139.0, 132.0, 158.0, 202.0, 155.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 213.0, 239.0, 238.0, 174.0, 171.0, 170.0, 177.0, 172.0], "value": 189.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 87.0, 88.0, 59.0, 75.0, 87.0, 89.0, 89.0, 72.0, 67.0], "value": 78.7, "unit": "score"}], "name": "kraken", "value": 1543.4, "alertThreshold": 2.0}]} 04:34:55 INFO - Return code: 0 04:34:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:55 INFO - # TBPL SUCCESS # 04:34:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:55 INFO - 2016-08-29 04:34:55.273 screenresolution[1670:10148] starting screenresolution argv=screenresolution get 04:34:55 INFO - 2016-08-29 04:34:55.275 screenresolution[1670:10148] Display 0: 1600x1200x32@60 04:34:55 INFO - 2016-08-29 04:34:55.281 screenresolution[1671:10151] starting screenresolution argv=screenresolution list 04:34:55 INFO - Available Modes on Display 0 04:34:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:55 INFO - Intel Iris: 04:34:55 INFO - Chipset Model: Intel Iris 04:34:55 INFO - Type: GPU 04:34:55 INFO - Bus: Built-In 04:34:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:55 INFO - Vendor: Intel (0x8086) 04:34:55 INFO - Device ID: 0x0a2e 04:34:55 INFO - Revision ID: 0x0009 04:34:55 INFO - Displays: 04:34:55 INFO - Display: 04:34:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:55 INFO - Display Serial Number: 1600x1200 60 04:34:55 INFO - Main Display: Yes 04:34:55 INFO - Mirror: Off 04:34:55 INFO - Online: Yes 04:34:55 INFO - Rotation: Supported 04:34:55 INFO - Return code: 0 04:34:55 INFO - Running post-action listener: _resource_record_post_action 04:34:55 INFO - [mozharness: 2016-08-29 11:34:55.515409Z] Finished run-tests step (success) 04:34:55 INFO - Running post-run listener: _resource_record_post_run 04:34:55 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31710208; Write bytes: 707399680; Read time: 313; Write time: 2196 04:34:55 INFO - TinderboxPrint: CPU usage
53.6% 04:34:55 INFO - TinderboxPrint: I/O read bytes / time
31,710,208 / 313 04:34:55 INFO - TinderboxPrint: I/O write bytes / time
707,399,680 / 2,196 04:34:55 INFO - TinderboxPrint: CPU idle
2,251.6 (46.4%) 04:34:55 INFO - TinderboxPrint: CPU system
972.5 (20.0%) 04:34:55 INFO - TinderboxPrint: CPU user
1,629.6 (33.6%) 04:34:55 INFO - TinderboxPrint: Swap in / out
433,442,816 / 0 04:34:55 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392499712; Write bytes: 387807232; Read time: 29197; Write time: 878 04:34:55 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30764032; Write bytes: 297568256; Read time: 297; Write time: 1273 04:34:56 INFO - Running post-run listener: _upload_blobber_files 04:34:56 INFO - Blob upload gear active. 04:34:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:56 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 04:34:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:56 INFO - Traceback (most recent call last): 04:34:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:34:56 INFO - main() 04:34:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:34:56 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:34:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:34:56 INFO - return set(response.json().get('whitelist', [])) 04:34:56 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:34:56 INFO - return json.loads(self.text or self.content, **kwargs) 04:34:56 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 04:34:56 INFO - return _default_decoder.decode(s) 04:34:56 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 04:34:56 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:34:56 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:34:56 INFO - raise ValueError("No JSON object could be decoded") 04:34:56 INFO - ValueError: No JSON object could be decoded 04:34:56 ERROR - Return code: 1 04:34:56 INFO - Setting buildbot property blobber_files to {} 04:34:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:56 INFO - Contents: 04:34:56 INFO - blobber_files:{} 04:34:56 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:56 INFO - Copying logs to upload dir... 04:34:56 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.896044 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-08-29 04:34:56.484871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 04:34:56.488860) ========= 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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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:{} build_url:https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/QMHXBX_-SeaNW9j0oRvuIw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 04:34:56.522628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:34:56.523023) ========= 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.TmuKgOOB4E/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.lOgFsk8nvg/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.005170 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 04:34:56.572521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 04:34:56.572889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 04:34:56.573261) ========= ========= Total master_lag: 1.03 =========