builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0385 starttime: 1471486150.96 results: success (0) buildid: 20160817165416 builduid: d5907f4eea5d475c98c4ca1b90c013f1 revision: 97a52326b06a07930216ebefa5af333271578904 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:10.963064) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:10.963490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:10.963759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:10.988522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:10.989754) ========= 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.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-17 19:09:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-08-17 19:09:11 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:11.160948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:11.161271) ========= 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.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.025485 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:11.209572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:11.209952) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 97a52326b06a07930216ebefa5af333271578904 --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 97a52326b06a07930216ebefa5af333271578904 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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-17 19:09:11,291 truncating revision to first 12 chars 2016-08-17 19:09:11,291 Setting DEBUG logging. 2016-08-17 19:09:11,291 attempt 1/10 2016-08-17 19:09:11,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/97a52326b06a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 19:09:11,982 unpacking tar archive at: mozilla-central-97a52326b06a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.960499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:12.192808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:12.193141) ========= script_repo_revision: 97a52326b06a07930216ebefa5af333271578904 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:12.193555) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:12.193821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 19:09:12.212334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-17 19:09:12.212665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:09:12 INFO - MultiFileLogger online at 20160817 19:09:12 in /builds/slave/test 19:09:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:09:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:12 INFO - {'append_to_log': False, 19:09:12 INFO - 'base_work_dir': '/builds/slave/test', 19:09:12 INFO - 'blob_upload_branch': 'Firefox', 19:09:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:12 INFO - 'branch': 'Firefox', 19:09:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:12 INFO - 'config_files': ('talos/mac_config.py',), 19:09:12 INFO - 'default_actions': ('clobber', 19:09:12 INFO - 'read-buildbot-config', 19:09:12 INFO - 'download-and-extract', 19:09:12 INFO - 'populate-webroot', 19:09:12 INFO - 'create-virtualenv', 19:09:12 INFO - 'install', 19:09:12 INFO - 'run-tests'), 19:09:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:12 INFO - 'download_minidump_stackwalk': True, 19:09:12 INFO - 'download_symbols': 'ondemand', 19:09:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:12 INFO - 'installer_path': 'installer.exe', 19:09:12 INFO - 'log_level': 'info', 19:09:12 INFO - 'log_name': 'talos', 19:09:12 INFO - 'log_to_console': True, 19:09:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:09:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:09:12 INFO - 'opt_config_files': (), 19:09:12 INFO - 'pip_index': False, 19:09:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:12 INFO - 'cmd': ('bash', 19:09:12 INFO - '-c', 19:09:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:12 INFO - 'enabled': True, 19:09:12 INFO - 'halt_on_failure': False, 19:09:12 INFO - 'name': 'check_screen_resolution'},), 19:09:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:09:12 INFO - 'cmd': ('bash', 19:09:12 INFO - '-c', 19:09:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:09:12 INFO - 'enabled': True, 19:09:12 INFO - 'halt_on_failure': False, 19:09:12 INFO - 'name': 'check_screen_resolution'},), 19:09:12 INFO - 'run_cmd_checks_enabled': True, 19:09:12 INFO - 'sps_profile': False, 19:09:12 INFO - 'sps_profile_interval': 0, 19:09:12 INFO - 'suite': 'dromaeojs-e10s', 19:09:12 INFO - 'system_bits': '32', 19:09:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:12 INFO - 'title': 't-yosemite-r7-0385', 19:09:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:12 INFO - 'use_talos_json': True, 19:09:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:12 INFO - 'work_dir': 'build'} 19:09:12 INFO - [mozharness: 2016-08-18 02:09:12.407780Z] Running clobber step. 19:09:12 INFO - Running pre-action listener: _resource_record_pre_action 19:09:12 INFO - Running main action method: clobber 19:09:12 INFO - rmtree: /builds/slave/test/build 19:09:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:14 INFO - Running post-action listener: _resource_record_post_action 19:09:14 INFO - [mozharness: 2016-08-18 02:09:14.324651Z] Finished clobber step (success) 19:09:14 INFO - [mozharness: 2016-08-18 02:09:14.324819Z] Running read-buildbot-config step. 19:09:14 INFO - Running pre-action listener: _resource_record_pre_action 19:09:14 INFO - Running main action method: read_buildbot_config 19:09:14 INFO - Using buildbot properties: 19:09:14 INFO - { 19:09:14 INFO - "project": "", 19:09:14 INFO - "product": "firefox", 19:09:14 INFO - "script_repo_revision": "production", 19:09:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:09:14 INFO - "repository": "", 19:09:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:09:14 INFO - "buildid": "20160817165416", 19:09:14 INFO - "pgo_build": "False", 19:09:14 INFO - "basedir": "/builds/slave/test", 19:09:14 INFO - "buildnumber": 62, 19:09:14 INFO - "slavename": "t-yosemite-r7-0385", 19:09:14 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:09:14 INFO - "platform": "yosemite_r7", 19:09:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:09:14 INFO - "branch": "mozilla-central", 19:09:14 INFO - "repo_path": "mozilla-central", 19:09:14 INFO - "revision": "97a52326b06a07930216ebefa5af333271578904", 19:09:14 INFO - "stage_platform": "macosx64", 19:09:14 INFO - "builduid": "d5907f4eea5d475c98c4ca1b90c013f1", 19:09:14 INFO - "slavebuilddir": "test" 19:09:14 INFO - } 19:09:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:09:14 INFO - Running post-action listener: _resource_record_post_action 19:09:14 INFO - [mozharness: 2016-08-18 02:09:14.328366Z] Finished read-buildbot-config step (success) 19:09:14 INFO - [mozharness: 2016-08-18 02:09:14.328478Z] Running download-and-extract step. 19:09:14 INFO - Running pre-action listener: _resource_record_pre_action 19:09:14 INFO - Running main action method: download_and_extract 19:09:14 INFO - mkdir: /builds/slave/test/build/tests 19:09: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')]} 19:09:14 INFO - trying https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:09:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:14 INFO - Downloaded 1199 bytes. 19:09:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:09:14 INFO - Using the following test package requirements: 19:09:14 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:09:14 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:09:14 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:09:14 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'jsshell-mac.zip'], 19:09:14 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:09:14 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:09:14 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:09:14 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:09:14 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:09:14 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:09:14 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:09:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:09: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')]} 19:09:14 INFO - trying https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:09:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:15 INFO - Downloaded 16339500 bytes. 19:09:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:09:22 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 19:09: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')]} 19:09:22 INFO - trying https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:23 INFO - Downloaded 16339500 bytes. 19:09:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 19:09:29 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')]} 19:09:29 INFO - trying https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:09:29 INFO - Downloading https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:31 INFO - Downloaded 14413981 bytes. 19:09:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 19:09: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')]} 19:09:31 INFO - trying https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/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 19:09:34 INFO - Downloaded 111305036 bytes. 19:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:09:34 INFO - mkdir: /builds/slave/test/properties 19:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:09:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:09:34 INFO - Contents: 19:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:09:34 INFO - Running post-action listener: _resource_record_post_action 19:09:34 INFO - Running post-action listener: set_extra_try_arguments 19:09:34 INFO - [mozharness: 2016-08-18 02:09:34.950035Z] Finished download-and-extract step (success) 19:09:34 INFO - [mozharness: 2016-08-18 02:09:34.950194Z] Running populate-webroot step. 19:09:34 INFO - Running pre-action listener: _resource_record_pre_action 19:09:34 INFO - Running main action method: populate_webroot 19:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:09:34 INFO - '--tppagecycles', 19:09:34 INFO - '7'], 19:09:34 INFO - 'tests': ['tsvgm']}}, 19:09:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:09:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:09:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:09:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:09:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:09:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['damp', 'tps']}, 19:09:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'tests': ['damp', 'tps']}, 19:09:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['dromaeo_dom']}, 19:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:09:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['basic_compositor_video']}, 19:09:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:09:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['a11yr', 19:09:34 INFO - 'ts_paint', 19:09:34 INFO - 'tpaint', 19:09:34 INFO - 'sessionrestore', 19:09:34 INFO - 'sessionrestore_no_auto_restore', 19:09:34 INFO - 'tabpaint']}, 19:09:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['tsvgx', 19:09:34 INFO - 'tsvgr_opacity', 19:09:34 INFO - 'tart', 19:09:34 INFO - 'tscrollx', 19:09:34 INFO - 'cart']}, 19:09:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:09:34 INFO - 'tsvgr_opacity', 19:09:34 INFO - 'tart', 19:09:34 INFO - 'tscrollx', 19:09:34 INFO - 'cart']}, 19:09:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'talos_options': ['--disable-e10s'], 19:09:34 INFO - 'tests': ['tp5o']}, 19:09:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'tests': ['tp5o']}, 19:09:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'talos_options': ['--disable-e10s', 19:09:34 INFO - '--xperf_path', 19:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:34 INFO - 'tests': ['tp5n']}, 19:09:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:09:34 INFO - 'talos_options': ['--xperf_path', 19:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:09:34 INFO - 'tests': ['tp5n']}}, 19:09:34 INFO - 'talos.zip': {'path': '', 19:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:09:34 INFO - Running post-action listener: _resource_record_post_action 19:09:34 INFO - [mozharness: 2016-08-18 02:09:34.969474Z] Finished populate-webroot step (success) 19:09:34 INFO - [mozharness: 2016-08-18 02:09:34.969587Z] Running create-virtualenv step. 19:09:34 INFO - Running pre-action listener: _resource_record_pre_action 19:09:34 INFO - Running main action method: create_virtualenv 19:09:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:09:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:09:35 INFO - Using real prefix '/tools/python27' 19:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:09:38 INFO - Installing pip.................done. 19:09:38 INFO - Return code: 0 19:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:38 INFO - 'HOME': '/Users/cltbld', 19:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:38 INFO - 'LOGNAME': 'cltbld', 19:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:38 INFO - 'MOZ_NO_REMOTE': '1', 19:09:38 INFO - 'NO_EM_RESTART': '1', 19:09:38 INFO - 'PAGER': '/bin/cat', 19:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:38 INFO - 'PWD': '/builds/slave/test', 19:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:38 INFO - 'SHELL': '/bin/bash', 19:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:38 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:38 INFO - 'USER': 'cltbld', 19:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:38 INFO - 'XPC_FLAGS': '0x0', 19:09:38 INFO - 'XPC_SERVICE_NAME': '0', 19:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:09:38 INFO - Cleaning up... 19:09:38 INFO - Return code: 0 19:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:38 INFO - 'HOME': '/Users/cltbld', 19:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:38 INFO - 'LOGNAME': 'cltbld', 19:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:38 INFO - 'MOZ_NO_REMOTE': '1', 19:09:38 INFO - 'NO_EM_RESTART': '1', 19:09:38 INFO - 'PAGER': '/bin/cat', 19:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:38 INFO - 'PWD': '/builds/slave/test', 19:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:38 INFO - 'SHELL': '/bin/bash', 19:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:38 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:38 INFO - 'USER': 'cltbld', 19:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:38 INFO - 'XPC_FLAGS': '0x0', 19:09:38 INFO - 'XPC_SERVICE_NAME': '0', 19:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:39 INFO - Downloading/unpacking psutil>=3.1.1 19:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:42 INFO - Installing collected packages: psutil 19:09:42 INFO - Running setup.py install for psutil 19:09:42 INFO - building 'psutil._psutil_osx' extension 19:09:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:09:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:09:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:09:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:09:43 INFO - building 'psutil._psutil_posix' extension 19:09:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:09:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:09:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:09:43 INFO - ^ 19:09:43 INFO - 1 warning generated. 19:09:43 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:09:43 INFO - Successfully installed psutil 19:09:43 INFO - Cleaning up... 19:09:43 INFO - Return code: 0 19:09:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:43 INFO - 'HOME': '/Users/cltbld', 19:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:43 INFO - 'LOGNAME': 'cltbld', 19:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:43 INFO - 'MOZ_NO_REMOTE': '1', 19:09:43 INFO - 'NO_EM_RESTART': '1', 19:09:43 INFO - 'PAGER': '/bin/cat', 19:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:43 INFO - 'PWD': '/builds/slave/test', 19:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:43 INFO - 'SHELL': '/bin/bash', 19:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:43 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:43 INFO - 'USER': 'cltbld', 19:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:43 INFO - 'XPC_FLAGS': '0x0', 19:09:43 INFO - 'XPC_SERVICE_NAME': '0', 19:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:09:46 INFO - Installing collected packages: mozsystemmonitor 19:09:46 INFO - Running setup.py install for mozsystemmonitor 19:09:46 INFO - Successfully installed mozsystemmonitor 19:09:46 INFO - Cleaning up... 19:09:46 INFO - Return code: 0 19:09:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:46 INFO - 'HOME': '/Users/cltbld', 19:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:46 INFO - 'LOGNAME': 'cltbld', 19:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:46 INFO - 'MOZ_NO_REMOTE': '1', 19:09:46 INFO - 'NO_EM_RESTART': '1', 19:09:46 INFO - 'PAGER': '/bin/cat', 19:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:46 INFO - 'PWD': '/builds/slave/test', 19:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:46 INFO - 'SHELL': '/bin/bash', 19:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:46 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:46 INFO - 'USER': 'cltbld', 19:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:46 INFO - 'XPC_FLAGS': '0x0', 19:09:46 INFO - 'XPC_SERVICE_NAME': '0', 19:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:46 INFO - Downloading/unpacking jsonschema==2.5.1 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:09:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:09:49 INFO - warning: no files found matching '*.txt' 19:09:49 INFO - no previously-included directories found matching 'build' 19:09:49 INFO - no previously-included directories found matching 'dist' 19:09:49 INFO - no previously-included directories found matching '.git*' 19:09:49 INFO - Installing collected packages: jsonschema, functools32 19:09:49 INFO - Running setup.py install for functools32 19:09:49 INFO - warning: no files found matching '*.txt' 19:09:49 INFO - no previously-included directories found matching 'build' 19:09:49 INFO - no previously-included directories found matching 'dist' 19:09:49 INFO - no previously-included directories found matching '.git*' 19:09:49 INFO - Successfully installed jsonschema functools32 19:09:49 INFO - Cleaning up... 19:09:49 INFO - Return code: 0 19:09:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:09:49 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')]} 19:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:49 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')]} 19:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:49 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:49 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 19:09:49 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 19:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:49 INFO - 'HOME': '/Users/cltbld', 19:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:49 INFO - 'LOGNAME': 'cltbld', 19:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:49 INFO - 'MOZ_NO_REMOTE': '1', 19:09:49 INFO - 'NO_EM_RESTART': '1', 19:09:49 INFO - 'PAGER': '/bin/cat', 19:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:49 INFO - 'PWD': '/builds/slave/test', 19:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:49 INFO - 'SHELL': '/bin/bash', 19:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:49 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:49 INFO - 'USER': 'cltbld', 19:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:49 INFO - 'XPC_FLAGS': '0x0', 19:09:49 INFO - 'XPC_SERVICE_NAME': '0', 19:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:09:50 INFO - Cleaning up... 19:09:50 INFO - Return code: 0 19:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:09:50 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')]} 19:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:50 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')]} 19:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:50 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:50 INFO - 'HOME': '/Users/cltbld', 19:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:50 INFO - 'LOGNAME': 'cltbld', 19:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:50 INFO - 'MOZ_NO_REMOTE': '1', 19:09:50 INFO - 'NO_EM_RESTART': '1', 19:09:50 INFO - 'PAGER': '/bin/cat', 19:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:50 INFO - 'PWD': '/builds/slave/test', 19:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:50 INFO - 'SHELL': '/bin/bash', 19:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:50 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:50 INFO - 'USER': 'cltbld', 19:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:50 INFO - 'XPC_FLAGS': '0x0', 19:09:50 INFO - 'XPC_SERVICE_NAME': '0', 19:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:09:53 INFO - Downloading docopt-0.6.1.tar.gz 19:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:09:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:09:54 INFO - Running setup.py install for blobuploader 19:09:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:09:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:09:54 INFO - Running setup.py install for requests 19:09:54 INFO - Running setup.py install for docopt 19:09:54 INFO - Successfully installed blobuploader requests docopt 19:09:54 INFO - Cleaning up... 19:09:55 INFO - Return code: 0 19:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:55 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:55 INFO - 'HOME': '/Users/cltbld', 19:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:55 INFO - 'LOGNAME': 'cltbld', 19:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:55 INFO - 'MOZ_NO_REMOTE': '1', 19:09:55 INFO - 'NO_EM_RESTART': '1', 19:09:55 INFO - 'PAGER': '/bin/cat', 19:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:55 INFO - 'PWD': '/builds/slave/test', 19:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:55 INFO - 'SHELL': '/bin/bash', 19:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:55 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:55 INFO - 'USER': 'cltbld', 19:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:55 INFO - 'XPC_FLAGS': '0x0', 19:09:55 INFO - 'XPC_SERVICE_NAME': '0', 19:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-0s5ZdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-X5aMZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-vHOCja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-THom_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Fr4Olm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mUfvN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-B1QBiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:09:55 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-f5QcU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-SrsnZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-q4lnc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-Gji98z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-917zrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-kLbktW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-RrgdKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-vFwYWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-OPdgEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:09:56 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1cPf48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:09:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:09:57 INFO - Running setup.py install for manifestparser 19:09:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:09:57 INFO - Running setup.py install for mozcrash 19:09:57 INFO - Running setup.py install for mozdebug 19:09:57 INFO - Running setup.py install for mozdevice 19:09:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:09:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:09:57 INFO - Running setup.py install for mozfile 19:09:57 INFO - Running setup.py install for mozhttpd 19:09:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:09:57 INFO - Running setup.py install for mozinfo 19:09:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Running setup.py install for mozInstall 19:09:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Running setup.py install for mozleak 19:09:58 INFO - Running setup.py install for mozlog 19:09:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Running setup.py install for moznetwork 19:09:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Running setup.py install for mozprocess 19:09:58 INFO - Running setup.py install for mozprofile 19:09:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:09:58 INFO - Running setup.py install for mozrunner 19:09:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:09:59 INFO - Running setup.py install for mozscreenshot 19:09:59 INFO - Running setup.py install for moztest 19:09:59 INFO - Running setup.py install for mozversion 19:09:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:09:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:09:59 INFO - Cleaning up... 19:09:59 INFO - Return code: 0 19:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:09: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')]} 19:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09: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')]} 19:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:09:59 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:09:59 INFO - 'HOME': '/Users/cltbld', 19:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:09:59 INFO - 'LOGNAME': 'cltbld', 19:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:59 INFO - 'MOZ_NO_REMOTE': '1', 19:09:59 INFO - 'NO_EM_RESTART': '1', 19:09:59 INFO - 'PAGER': '/bin/cat', 19:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:59 INFO - 'PWD': '/builds/slave/test', 19:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:09:59 INFO - 'SHELL': '/bin/bash', 19:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:09:59 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:09:59 INFO - 'USER': 'cltbld', 19:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:59 INFO - 'XPC_FLAGS': '0x0', 19:09:59 INFO - 'XPC_SERVICE_NAME': '0', 19:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:09:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-2xRkgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:09:59 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mSpzMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-mw9wkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-t8JqXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1MdrWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-ydEI4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-AcYevj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-NwBr4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-yX0s9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-BNqGuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:00 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)) 19:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:00 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-1oasNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-yBITRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:01 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)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-wjngPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-aVuPpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:01 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)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-xxg0Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-0UQYBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:01 INFO - Running setup.py (path:/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/pip-lpmwwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:10:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:04 INFO - Downloading blessings-1.6.tar.gz 19:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:04 INFO - Installing collected packages: blessings 19:10:04 INFO - Running setup.py install for blessings 19:10:04 INFO - Successfully installed blessings 19:10:04 INFO - Cleaning up... 19:10:04 INFO - Return code: 0 19:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:04 INFO - Reading from file tmpfile_stdout 19:10:04 INFO - Current package versions: 19:10:04 INFO - blessings == 1.6 19:10:04 INFO - blobuploader == 1.2.4 19:10:04 INFO - docopt == 0.6.1 19:10:04 INFO - functools32 == 3.2.3-2 19:10:04 INFO - jsonschema == 2.5.1 19:10:04 INFO - manifestparser == 1.1 19:10:04 INFO - mozInstall == 1.12 19:10:04 INFO - mozcrash == 0.17 19:10:04 INFO - mozdebug == 0.1 19:10:04 INFO - mozdevice == 0.48 19:10:04 INFO - mozfile == 1.2 19:10:04 INFO - mozhttpd == 0.7 19:10:04 INFO - mozinfo == 0.9 19:10:04 INFO - mozleak == 0.1 19:10:04 INFO - mozlog == 3.3 19:10:04 INFO - moznetwork == 0.27 19:10:04 INFO - mozprocess == 0.23 19:10:04 INFO - mozprofile == 0.28 19:10:04 INFO - mozrunner == 6.12 19:10:04 INFO - mozscreenshot == 0.1 19:10:04 INFO - mozsystemmonitor == 0.3 19:10:04 INFO - moztest == 0.7 19:10:04 INFO - mozversion == 1.4 19:10:04 INFO - psutil == 3.1.1 19:10:04 INFO - requests == 1.2.3 19:10:04 INFO - wsgiref == 0.1.2 19:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:04 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:04 INFO - 'HOME': '/Users/cltbld', 19:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:04 INFO - 'LOGNAME': 'cltbld', 19:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:04 INFO - 'MOZ_NO_REMOTE': '1', 19:10:04 INFO - 'NO_EM_RESTART': '1', 19:10:04 INFO - 'PAGER': '/bin/cat', 19:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:04 INFO - 'PWD': '/builds/slave/test', 19:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:04 INFO - 'SHELL': '/bin/bash', 19:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:10:04 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:04 INFO - 'USER': 'cltbld', 19:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:04 INFO - 'XPC_FLAGS': '0x0', 19:10:04 INFO - 'XPC_SERVICE_NAME': '0', 19:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:10:05 INFO - Cleaning up... 19:10:05 INFO - Return code: 0 19:10:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10:05 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')]} 19:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:05 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')]} 19:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:05 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 0x10b972a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba07618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb78d993b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, '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.lypa3I7jUO/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.UxYAsGe5G7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:10:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:10:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:05 INFO - 'HOME': '/Users/cltbld', 19:10:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:05 INFO - 'LOGNAME': 'cltbld', 19:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:05 INFO - 'MOZ_NO_REMOTE': '1', 19:10:05 INFO - 'NO_EM_RESTART': '1', 19:10:05 INFO - 'PAGER': '/bin/cat', 19:10:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:05 INFO - 'PWD': '/builds/slave/test', 19:10:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:05 INFO - 'SHELL': '/bin/bash', 19:10:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:10:05 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:10:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:05 INFO - 'USER': 'cltbld', 19:10:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:05 INFO - 'XPC_FLAGS': '0x0', 19:10:05 INFO - 'XPC_SERVICE_NAME': '0', 19:10:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:05 INFO - Cleaning up... 19:10:05 INFO - Return code: 0 19:10:05 INFO - Running post-action listener: _resource_record_post_action 19:10:05 INFO - Running post-action listener: _start_resource_monitoring 19:10:05 INFO - Starting resource monitoring. 19:10:05 INFO - [mozharness: 2016-08-18 02:10:05.326410Z] Finished create-virtualenv step (success) 19:10:05 INFO - [mozharness: 2016-08-18 02:10:05.327384Z] Running install step. 19:10:05 INFO - Running pre-action listener: _resource_record_pre_action 19:10:05 INFO - Running main action method: install 19:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:05 INFO - Reading from file tmpfile_stdout 19:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:05 INFO - Reading from file tmpfile_stdout 19:10:05 INFO - Output received: 19:10:05 INFO - Usage: mozinstall [options] installer 19:10:05 INFO - Options: 19:10:05 INFO - -h, --help show this help message and exit 19:10:05 INFO - -d DEST, --destination=DEST 19:10:05 INFO - Directory to install application into. [default: 19:10:05 INFO - "/builds/slave/test"] 19:10:05 INFO - --app=APP Application being installed. [default: firefox] 19:10:05 INFO - mkdir: /builds/slave/test/build/application 19:10:05 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'] 19:10:05 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 19:10:39 INFO - Reading from file tmpfile_stdout 19:10:39 INFO - Output received: 19:10:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - [mozharness: 2016-08-18 02:10:39.517169Z] Finished install step (success) 19:10:39 INFO - [mozharness: 2016-08-18 02:10:39.517272Z] Running run-tests step. 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: run_tests 19:10:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:10:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:10:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:10:39 INFO - 2016-08-17 19:10:39.529 screenresolution[1643:7687] starting screenresolution argv=screenresolution get 19:10:39 INFO - 2016-08-17 19:10:39.532 screenresolution[1643:7687] Display 0: 1600x1200x32@60 19:10:39 INFO - 2016-08-17 19:10:39.538 screenresolution[1644:7689] starting screenresolution argv=screenresolution list 19:10:39 INFO - Available Modes on Display 0 19:10:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:10:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:10:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:10:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:10:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:10:39 INFO - Intel Iris: 19:10:39 INFO - Chipset Model: Intel Iris 19:10:39 INFO - Type: GPU 19:10:39 INFO - Bus: Built-In 19:10:39 INFO - VRAM (Dynamic, Max): 1536 MB 19:10:39 INFO - Vendor: Intel (0x8086) 19:10:39 INFO - Device ID: 0x0a2e 19:10:39 INFO - Revision ID: 0x0009 19:10:39 INFO - Displays: 19:10:39 INFO - Display: 19:10:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:10:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:10:39 INFO - Display Serial Number: 1600x1200 60 19:10:39 INFO - Main Display: Yes 19:10:39 INFO - Mirror: Off 19:10:39 INFO - Online: Yes 19:10:39 INFO - Rotation: Supported 19:10:39 INFO - Return code: 0 19:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:39 INFO - Python 2.7.3 19:10:39 INFO - Return code: 0 19:10:39 INFO - grabbing minidump binary from tooltool 19:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:39 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 0x10b8d6d30>, '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 0x10b63bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8ceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:10:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:10:39 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 19:10:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:39 INFO - Return code: 0 19:10:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:10:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:10:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0385 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lypa3I7jUO/Render', 19:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:39 INFO - 'HOME': '/Users/cltbld', 19:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:39 INFO - 'LOGNAME': 'cltbld', 19:10:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:39 INFO - 'MOZ_NO_REMOTE': '1', 19:10:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:39 INFO - 'NO_EM_RESTART': '1', 19:10:39 INFO - 'PAGER': '/bin/cat', 19:10:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:39 INFO - 'PWD': '/builds/slave/test', 19:10:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:39 INFO - 'SHELL': '/bin/bash', 19:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UxYAsGe5G7/Listeners', 19:10:39 INFO - 'TMPDIR': '/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/', 19:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:39 INFO - 'USER': 'cltbld', 19:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:39 INFO - 'XPC_FLAGS': '0x0', 19:10:39 INFO - 'XPC_SERVICE_NAME': '0', 19:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0385', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:10:40 INFO - mozversion application_buildid: 20160817165416 19:10:40 INFO - mozversion application_changeset: 97a52326b06a07930216ebefa5af333271578904 19:10:40 INFO - mozversion application_display_name: Nightly 19:10:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:40 INFO - mozversion application_name: Firefox 19:10:40 INFO - mozversion application_remotingname: firefox 19:10:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:10:40 INFO - mozversion application_vendor: Mozilla 19:10:40 INFO - mozversion application_version: 51.0a1 19:10:40 INFO - mozversion platform_buildid: 20160817165416 19:10:40 INFO - mozversion platform_changeset: 97a52326b06a07930216ebefa5af333271578904 19:10:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:10:40 INFO - mozversion platform_version: 51.0a1 19:10:40 INFO - using testdate: 1471486240 19:10:40 INFO - actual date: 1471486240 19:10:40 INFO - starting webserver on 'localhost:49263' 19:10:40 INFO - SUITE-START | Running 2 tests 19:10:40 INFO - TEST-START | dromaeo_css 19:10:40 INFO - operating with platform_type : mac_ 19:10:40 INFO - Initialising browser for dromaeo_css test... 19:10:40 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpxcpzDG/profile http://localhost:49263/getInfo.html) 19:10:42 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 19:10:42 INFO - PROCESS | 1654 | colorDepth:24 19:10:42 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 19:10:42 INFO - PROCESS | 1654 | __metrics 19:10:43 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:10:43 INFO - TEST-INFO | 1654: exit 0 19:10:43 INFO - Browser initialized. 19:10:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:10:43 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpxcpzDG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:55 INFO - PROCESS | 1657 | RSS: Main: 239218688 19:10:55 INFO - PROCESS | 1657 | 19:11:45 INFO - PROCESS | 1657 | 1471486305283 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:13:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 19:13:57 INFO - PROCESS | 1657 | RSS: Main: 253992960 19:13:57 INFO - PROCESS | 1657 | 19:17:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 19:17:01 INFO - PROCESS | 1657 | RSS: Main: 267411456 19:17:01 INFO - PROCESS | 1657 | 19:20:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 19:20:03 INFO - PROCESS | 1657 | RSS: Main: 272236544 19:20:03 INFO - PROCESS | 1657 | 19:23:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 19:23:06 INFO - PROCESS | 1657 | RSS: Main: 272322560 19:23:06 INFO - PROCESS | 1657 | 19:26:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 19:26:09 INFO - PROCESS | 1657 | RSS: Main: 277155840 19:26:09 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 19:29:12 INFO - PROCESS | 1657 | RSS: Main: 279744512 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | __start_tp_report 19:29:12 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 19:29:12 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 19:29:12 INFO - PROCESS | 1657 | |i|pagename|runs| 19:29:12 INFO - PROCESS | 1657 | |0;dojo.html;2430.6597076409307;3124.297033167539;3234.0782876880094;3369.494575813629;3385.7122144617697;5525.281713377255;5608.327000759909;5634.521065709415;5706.3722990471015;5748.252727145476;4535.795889184987;5648.830535083954;5661.971690141543;5684.516816070639;5764.682942438164;5080.187170052783;5143.897122057557;5161.251618515313;5234.947650523484;5290.074237008508;4715.269133284346;5028.321176641143;5125.234111624422;5233.528982391584;5343.759530821122;5055.747212639353;5107.131787596118;5128.5640720538795;5180.766865491024;5206.297149884774;5210.062188806013;5222.503862133091;5224.294720212761;5232.764525596357;5249.842504724865;5157.355330583677;5194.480551944813;5201.635885488017;5202.505761952609;5216.686998780086;4627.334159702505;5253.3958594761325;5657.688827114507;5704.543636509111;5765.1928729977835;6158.353372895826;6220.315765265817;6228.252609686821;6238.625682459067;6263.34234905333;6216;6228.96885515574;6229.408206220402;6240.500759939194;6246.219222597176;5589.916151257735;5677.659340439504;5706.771729130788;5743.310802703702;5777.959967205901;6148.907766383508;6176.042713379434;6227.96886015567;6274.247090349188;6283.2460104787715;6114.663693496811;6144.139820425144;6148.6925653717135;6183.783567575113;6187;6075.362086980892;6242.1261023456755;6249.6562689051625;6254.21822272216;6268.341824108494;6103.389661033861;6159.907601385983;6170.691465426711;6197.659128747962;6228.159198508143;6186.81439556814;6216.222972128484;6224.688765561704;6226.813195604139;6245.28179259391;3992.181602771425;4886.633502487328;4891.706497610084;4913.65604407688;4929.260610908321;4311.590398912098;4324.394584758136;4357.847475338348;4360.258756011485;4428.645708343325;5677.17680936262;5742.339630942495;5760.308762948389;5788.131780232999;5796.478316951495;6123.571350005457;6190.41191086846;6194.473469755031;6195.349488303663;6201.255849298113;5699.373068962411;5720.456556627114;5787.855303617359;5831.912521312183;5875.059990401515;5437.891242175135;5443.292371991616;5450.972745136249;5451.945480545223;5460.563154947595;6151.292601350902;6257.186565746424;6298.338674439209;6300.558960872787;6351.269603995507;6161.568690191643;6171.475424588781;6206.131141640084;6224.315325314121;6252.874942501034;5045.293658887832;6247.718852651551;6251.749930002749;6321.115043893767;6333.588316759396;5389.27244821944;6052.75788968454;6076.544259180668;6210.192674952227;6227.1282020516255;6176.81469555914;6178.7219575120125;6196.597221180609;6234.906476402948;6238.937610624017;5383.219433182245;5759.337676167127;6062.848428789315;6136.938630613815;6146.231721034871;5783.392743761844;6126.448619624255;6154.661493617894;6165.537584681257;6180.6291622502795;4958.975205124096;5724.885502289848;5830.883382332415;5951.642901425928;5992.943598764574;6114.2357205349335;6130.386961303834;6132.478739307209;6138.662373569497;6154.046122850965;5807.94192058074;5933.643981361132;5990.760369585168;5998.040313549811;6000.009998350223 19:29:12 INFO - PROCESS | 1657 | |1;ext.html;456.35881586371147;472.69511165298405;530.9203619457084;541.9295491586095;542.9701366424847;37307;39562.406563901495;39566.80216598913;39597.40603890944;39667.80166099169;40519.392209116886;40896.59103408965;41042.97392565187;41147.38278925811;41165.79417102918;9684.467354295528;9901.10890019898;9916.702498925044;9937.850932236022;9942.65200717975;9822.508874556279;9925.305228633963;9935.105840474356;9939.652112176076;9959.900400996006;9925.702228933143;9986.750331241705;9995.500224988758;10002.249831262649;10014.298999070068;9955.800883982352;9959.153471954893;9974.750631234205;9990.45052522111;10011.59953601855;9787.412755234709;9819.852702209473;9822;9837.606495740161;9852.50737463124;38807;39026.41460378097;39131.41302880431;39163;39220;2566.5508536006123;3224.8387580620874;3482.7387945904156;3598.712103031751;4117.444145040411;22118;24814.875925620436;25388.49223015548;28186.718132818616;30243.546346804815;3206.7594930380315;3231.8710832587194;3249.2689144942437;3344.3980083584943;3346.7489938254485;439925;440467;441099;444822;445203.99999999674;32643.347133057207;32727.836360818044;32741;32765.017049488553;32825.67174328226;27561.31096722598;34417.483737743954;34983;35663;35721.28557428837;14522.346494407777;16085.276162572713;16142.919285403732;16206.594835129215;16224.756628650579;10262.127719143808;11866.644000679993;12471.875281247072;12490.81263781044;12502.687432814253;16585.087820170007;17939.923604583768;18894.24423023091;18914.716279255823;18959.336423225122;6994.860102797916;8125.878111828328;8298.54358010303;8319.542425166554;8393.370497212734;858.4248553469066;975.9414435133915;1002.293383164867;1089.8746644135867;1099.120703437263;26068.34829129287;30493.390132197233;30909.918152864993;31329.216769580944;32116.39739355517;857.4989120544353;914.8364118858851;968.6851773173606;1029.4955471818755;1073.4793625091825;14633.414663413558;15343.539693809204;15582;15625.765613515807;15706.371745130067;560843;625895;626853.79157938;626880;627462;54715;55290;55451.44548554543;57641.423585764445;59100.70449647724;1362.7206422683325;1377.2425166158573;1419.9432022718975;1422.3883729995994;1426.522115091456;28972.522980104724;30108.548371774003;30211.09366719002;30496.23759405944;30680.693193067782;41076.383854242806;49746.25380619221;50155.49844501508;50163.24755128603;50370.74814625904;611912;622070;622967;623331;624730;24426.389340266636;24794.50410991806;26611.7338826617;26991.865040675457;27084.593731094443;45203.32195017012;45533.772331138134;45562.77218614018;46036;46659.53340466688;34294.31411371709;34866.65133348735;37352.813235933645;37484.06289842776;38423.84728458039;36297.27405451929;37276.06809829776;37294.81352593219;38413;38753;34692.826535867156;36537.81731091434;36723.816380917924;37808.29862656242;38484.61515384923;32006.6799332013;33163.414428739845;33595.83202083974;33598.64013598621;33748.15629609279;23541.764582353957;24638;24672.629910551714;24786;24916.12793552217 19:29:12 INFO - PROCESS | 1657 | |2;jquery.html;354.6825591095968;370.6867696796206;376.785232417522;382.82772752261457;399.20956506117886;20488.89755551222;20489.18043278269;20843.95780210991;21156.047977840997;21315.786842131572;19716.802831971676;20770.584588308226;21020.789792102074;21340;21713.348599541998;5933.792317268896;5958.821235362935;6158.799346178607;6159.568830181889;6183.876322473548;3781.2059467511854;5190.11767999441;6036.275646922353;6115.143879856823;6243.843903902393;5866.794662186824;6698.73205071799;6847.520673552854;6857.725690972356;6874.243833178346;6586.967065164691;6769.323067693241;6845.520813543054;6846;6853.965730171367;4342.935980684721;5851.093080572518;5941.673207973559;5947.167396564484;5962.463378295931;24575;25688;25850.870745646152;25914;26125.477490450274;2109.789021097893;2148.5917675641576;2245.113180293791;2822.195674232834;2926.1514160893316;9961.40231586107;10043.447610381427;10066.547005384775;10120.089191972684;10182.338148020355;1841;1865.2818664814145;1906.5424298168477;1926.8940208288539;2093.2359688713664;114953.27570086539;116313;118878;123107;124269;9273.768155796024;10927.508262128064;11316.490757915913;11450.54197832094;11451.656450306504;14096.08375455592;14191.361388737532;14211.715765684836;14222.573322800332;14229.85770142306;8154.469959452616;8302.875456868152;8367.748967530984;8463.280621147149;8483.066862645104;6810.5913645181445;7209.459290553229;7245.601491917995;8332.416730828783;8485.406021578554;3680.705543556509;4478.641708663299;4481.395011673382;4494.70784399013;4573.245414506569;1577.7081239970412;1653.330401187521;1902.6480101181048;1942.4172748175774;1960.11794692389;767.781182363035;840.9411341206179;876.2114097312469;909.1953621045423;985.0887928666099;20525.281615143398;21218.681719774217;21224;21249.893750531148;21288.78711212899;906.7143849687459;915.455304094063;931.7717159296016;947.1759569174862;970.9805803883883;10693.83959240612;10795.676129716121;11160.16298777595;11404.258723182966;11430.828537571942;575809;586448;598116;612878;615383;81042;84340.57829710812;128131;130696;135516.32241838926;1020.7805321855836;1029.1098200056897;1063.5320458998171;1069.5454431866426;1070.3310430980637;19375.224991000203;19432.125554350372;19477.61044779068;19690.80309196947;19720.901395492932;55104.89790204254;55115.17327240014;55327.72336138294;58986.705066474395;59661.10508342292;84037.57981210055;84685;85209.57395212984;85385;85620.29417352469;7208.098987626547;7313.23211062852;7767.611619419119;8147.592620369076;8219.054808697076;9936.950315248378;12631.242125472501;12964.416601253155;13013.479460821462;13421.865781342452;8214.301784348158;11218.934201250868;11362.659120226406;11593.594224202112;11621.535138594361;9400.200982916529;10671.89328106709;11244.212905096565;11345;11411.486483108114;11414.201005929504;11659.591914283299;11758;11820.468078936641;11930.522779088738;7069;7111.7866464006165;7322.121345438582;7450.0687414073245;8399.874001890099;9430.905690943277;11257.662270131908;11645.359505227294;11797.227651502062;11892.108091893315 19:29:12 INFO - PROCESS | 1657 | |3;mootools.html;1536.0937047142183;1565.9217039148043;1764.4001039646525;1851.3797877710974;1852.9629407411844;7853.37173026158;8329.91670083299;8488.490690558556;8878.600462979166;8930.776730581738;8523.360747943898;8723.694670686527;8740.781480462992;8749.825003499942;8760.78098047549;1986.5629561496448;2294.6443301288286;2329.801966832821;2344.6248600223967;2368.0409434179187;2160.0495781855934;2295.185209250717;2314.6065168921323;2356.4226764442737;2363.3382652857226;2131.912724510495;2144.6782982552586;2196.626573482512;2273.6021196290667;2390.7131144262626;1993.601279744057;2019.3538067818304;2376.560336337766;2390;2392.102961389479;1946.250693483005;2101.569178318441;2191.80273775361;2380.797632201265;2393.401649587603;7580.810479737996;8815.955920220422;8905.866412003825;8918.598663060178;8931.285497160212;5210.687358758487;5301.363836339626;5360.16917377807;5389.649672771257;5391.16436952273;3504.5093686883856;3601.1717305019993;3688.79711615861;3728.9254214915823;3741.4013757798893;1108.5050121756276;1113.3653817324127;1117.6479408986143;1135.7955567997758;1142.5429828068757;11408.54365825366;11473.426328683616;11560.190786644855;11582.247153934968;11616.954474097287;4606.470255920612;4640.767961601974;4852.927206091911;4889.119958407449;4912.582430493448;9060.093990600888;9907.455089969977;9925.3548519346;9936.751581210528;9945.154661853823;5315.069862773999;5324.281222035053;5343.492368225013;5347.839564813062;5353.277307563507;3845.9038524037123;3973.205358928226;4677.7193368398;4843.2735089736825;4879.609631229493;3896.4544963705102;3939.625735555118;4061.634452899253;4089.1821635672986;4099.0162361033135;1297.228149251194;1301.069735139361;1314.2640121531972;1318.558282975195;1320.6434262749003;859.6002858670748;859.9914000860036;911.2300106410073;915.3272344826547;943.1605870775015;5327.600429967768;5449.128139497661;5688.772449102073;5894.322152952465;6043.969780151071;965.3725078698902;966.120830044656;983.2969426859829;987.5605355616682;1033.8087453821067;3906.9609303906595;3950.4469374287623;4021.4571032910767;4101.8974525637095;4117.608827161415;10349.586016559404;10625.946870265754;10658.307210031324;10664.573417063386;10675.092617127475;8860.822783544421;10179.236557258087;10637.149028077734;10641.946790266;10672.092872105957;7094.8293531566715;8051.838963220703;8101.6354264058255;8248.876266856121;8249.05135909366;4937.580305673914;5701.201831743476;5824.330202026652;5867.823965281048;5912.852178695567;9848.113669769755;9976.60093596248;10027.04743049409;10060.195184385086;10096;9662.71011869645;9929.702108936743;10069.748256293651;10188.184945204217;10279.383237005804;5606.887862242651;6863.416609588241;6964.860702786017;7040.190378106583;7079.8938015930835;8415.705450309455;8468.872966905625;8490.06609272967;8497.107803680772;8509.404341696269;7410.592417417094;7493.700251990077;7512.511686740344;7581.6209189539195;7647.273509016634;6746.9325306746305;7241.927580724336;7362.079740032496;7362.3373896349585;7457.888131677921;5843.824685259449;7018.5788852669;7075;7083.716651333889;7103.396211322096;4725.40932383452;4794.328793968917;4796.9760151199025;4837.685550439211;4873.366462359871;4847.854564363075;4913.091078150554;4943.530364615356;4970.204767237225;5003.974980125076 19:29:12 INFO - PROCESS | 1657 | |4;prototype.html;263.27074005006136;296.9272528230584;301.3972055888223;307.99593325758025;313.72549019607845;5472.482657977325;5576.609637325379;5711.600657838825;5720.742566584503;5745.310562732473;4700.213918710893;4742.97628511857;5601.943980560203;5704;5741.45456181662;4258.936115958263;4373.846915357964;4376.19040477511;4380.540043295456;4423.712458690191;4016.337304344794;4242.639375653058;4296.0548679290505;4344.109457561192;4423.469183697961;3562.928741425183;3745.8127093645344;4263.744175349473;4300;4307.879951212692;3382.932341353184;3951.723379363446;4035.8385664573384;4324.664681072233;4354.542773008852;2929.8681559329666;3745.0637340664834;3749.15643980105;3758.624137586247;3769.9057523561855;5289.709066001368;5503.587230957694;5554.77780888768;5585.413531579166;5636.718164091779;4476.6418686505;4864.878378040542;4964.60283177345;5013.824516141917;5019.196928491424;4914.950850491485;5025.99480103977;5600.411956744524;6036.4686658304945;6070.908936365958;3332.9833350833333;3364.1253274148653;3483.425234836249;3909.198614284065;3995.5405128410316;5006.872079366255;5390.460953904618;5551.1118221084835;5888.5289176865745;6323.154580438821;3792.639699228569;3848.980020294624;4037.0916543778003;4038.353863381845;4059.3505039193587;3987.501562304712;4065.634092931591;4090.427340172378;4091.3453847384276;4098.647446342699;3998.6001399859783;4733.243090693831;4883.389576302962;4886.436340371047;4889.975550122226;5811.3316968548315;6037.54718396122;6048.576599637983;6096;6106.6336019838955;1080.6920027792041;1372.2246930484444;1383.1631862722907;1403.4386245501678;1410.4710733474947;819.3035919468405;822.4078663362369;851.7402192331399;857.9957100214584;866.6013633728555;4226.598473145046;4246.957530424718;4378.868633940987;4442.600165985077;4476.440444944382;4641.698289611165;4675.604931364506;4711.363965864564;5087.720175390315;5196.531647467423;4005.4592629994577;4257.659387249013;4373.310414095308;4738.597219236403;4785.569298763058;2369.218158007853;2444.523317953018;2498.462830491453;2545.440003199293;2732.289604702752;4867.76083001816;5281.445448227958;5311.7078560678765;5411;5412.458754124556;4536.750478723636;4754.812786118424;4910.656254062182;5208.322918020633;5261.684858662176;4287.292596721506;4594.609458196024;4840.588549973291;5258.8948221036135;5474.808381706621;4219.767912764827;4289;4692.436907571113;5188.7405629719115;5236.659617124875;4169.665706973739;4757.381540399726;5118.257852611276;5130.384353877558;5152.742362881766;4440.5355027959795;4563.338315944103;5274.657147285414;5327.786888524415;5359.678419294854;3378.054144839449;3454.481827725761;3515.4375299951885;3536.7701099428455;3547.4324108142573;4412.867613971586;4619.897946434297;5046.823361182341;5101.540861322499;5139.582177851837;4251.426972020372;5715.428457154251;5997.460228579449;6007.639541627516;6032.638041717511;5776.508996735157;5865.618734782225;5931.851703707442;6073;6073.514118870568;5108.642395032312;5755.802139965071;5776.682282474504;5780.306363236438;5912.645241285537;4891.364122664031;5475.561955043508;6060.545459090674;6063.636181829104;6097;5049.469805670352;5913.349531551612;5924.734191382198;5949.940500595112;5992.970035149797 19:29:12 INFO - PROCESS | 1657 | |5;yui.html;598.7515181199802;719.309462915601;738.471992525345;790.12690976471;826.4462809917356;15245.161516116608;15769.896107272496;16148.434804781806;16262.674746505078;16295.266712997915;14832.332545035473;14836.184009879453;14867.92566037171;14967.25163741814;15006.549803505884;840.7141571865579;849.3332733803934;857.3612658569343;859.0893652728097;859.7377799771067;673.4275865514322;832.5379414424991;857.2627540315324;857.6440777077505;865.8441480533502;747.9065116860393;900.1358695652182;911.1526280559077;915.4370062411602;917.2111983694018;854.3805740837873;903.783092057908;908.7546362482093;910.8815853939012;915.4187091197072;665.6771465839064;670.0318040431579;678.3453966921944;681.7784220128478;683.3166833166833;15229;15354.692906141814;15365.692686146214;15396.615084622974;15413.152276624782;13424.93287533556;14763.557093287218;14813.888958328169;14941.551753447415;14958.47645332419;12054.578089766816;12111.939440302831;12132.454039568152;12216.450259738243;12386.071044671686;3883.930350241075;3927.7446965947124;4026.053877338823;4097.774622395767;4099.364598487239;123813.38093309566;123880.38059809734;125819;127180;127255;11166;11440.485178167002;11455.369954652408;11504.482298296596;11844.407779610985;24044.75955240425;24094;24116;24129.536035833426;24191.27426177182;7352.5956072415465;7720.845583088307;8219.136990616018;8364.707235246737;8476.745697629081;4499.960282786516;4569.442784880715;4586.781792137519;4587.931181032287;4659.207934651117;3588.4079126944284;3680.5031320771886;3694.7967861767324;3721.14413684854;3738.1962877981364;658.4896705053526;667.8630880669451;669.715370967337;670.2392784189882;671.1342368344781;483.8330775882315;587.4742105815271;639.2041907824788;645.7998020613625;652.4551999080726;9452.43285402878;9587.568559414844;9633.951830240803;9743.561539730586;9896.911339752765;550.9449055094539;621.1733053739372;634.6985182038587;668.8628831089615;679.7126579142928;4383.473983122046;4606.493285738566;4627.167109920247;4710.599599034052;4711.201649566506;90493.54753226324;101389;165340;166767;169679.1516042412;113629.86370136193;133735.66264337426;137037.25925481634;138867.30566347102;142413.28793355968;71698.56602867914;73946.8907966381;96144.03855961491;102988.48505757573;104269;9464.621415143318;9953.552090155816;10079.244056695923;10128.79742405133;10171.7457063574;59883.01169882977;61207.38792612195;62204.377956221666;63792.362076378646;64875.86365499886;92500.53749731208;96375;97884.57403990826;99097.50451247698;103051;11293.322400655987;11457.59898403552;13137.94896408266;13263.734725305632;13308.134971226838;9716.562754675915;12243.775622437684;13441.260730659516;13670.769630733283;13906.721865562835;10966.616168434066;11803.527858885549;12610.49558017669;12700.301483418501;12883.935580322039;13844.653883652989;13928.373223204777;13951.651208719863;13957.511487097903;14624.268786560417;11203.21577489568;13347;13588.456461741815;13910;14178.007539472137;10371.844422333521;11252.774944501229;11395.373254471084;11658.6502404928;11787.351695656822;9670.854937175807;10487.423191724529;11514.88485115138;11622.76754464889;11670.183087183816 19:29:12 INFO - PROCESS | 1657 | __end_tp_report 19:29:12 INFO - PROCESS | 1657 | __start_cc_report 19:29:12 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,413 19:29:12 INFO - PROCESS | 1657 | __end_cc_report 19:29:12 INFO - PROCESS | 1657 | __startTimestamp1471487352624__endTimestamp 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | ------- Summary: start ------- 19:29:12 INFO - PROCESS | 1657 | Number of tests: 6 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5675.53 Median:5831.91 stddev:697.59 (12.0%) stddev-sans-first:651.64 19:29:12 INFO - PROCESS | 1657 | Values: 2430.7 3124.3 3234.1 3369.5 3385.7 5525.3 5608.3 5634.5 5706.4 5748.3 4535.8 5648.8 5662.0 5684.5 5764.7 5080.2 5143.9 5161.3 5234.9 5290.1 4715.3 5028.3 5125.2 5233.5 5343.8 5055.7 5107.1 5128.6 5180.8 5206.3 5210.1 5222.5 5224.3 5232.8 5249.8 5157.4 5194.5 5201.6 5202.5 5216.7 4627.3 5253.4 5657.7 5704.5 5765.2 6158.4 6220.3 6228.3 6238.6 6263.3 6216.0 6229.0 6229.4 6240.5 6246.2 5589.9 5677.7 5706.8 5743.3 5778.0 6148.9 6176.0 6228.0 6274.2 6283.2 6114.7 6144.1 6148.7 6183.8 6187.0 6075.4 6242.1 6249.7 6254.2 6268.3 6103.4 6159.9 6170.7 6197.7 6228.2 6186.8 6216.2 6224.7 6226.8 6245.3 3992.2 4886.6 4891.7 4913.7 4929.3 4311.6 4324.4 4357.8 4360.3 4428.6 5677.2 5742.3 5760.3 5788.1 5796.5 6123.6 6190.4 6194.5 6195.3 6201.3 5699.4 5720.5 5787.9 5831.9 5875.1 5437.9 5443.3 5451.0 5451.9 5460.6 6151.3 6257.2 6298.3 6300.6 6351.3 6161.6 6171.5 6206.1 6224.3 6252.9 5045.3 6247.7 6251.7 6321.1 6333.6 5389.3 6052.8 6076.5 6210.2 6227.1 6176.8 6178.7 6196.6 6234.9 6238.9 5383.2 5759.3 6062.8 6136.9 6146.2 5783.4 6126.4 6154.7 6165.5 6180.6 4959.0 5724.9 5830.9 5951.6 5992.9 6114.2 6130.4 6132.5 6138.7 6154.0 5807.9 5933.6 5990.8 5998.0 6000.0 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:67323.56 Median:37329.91 stddev:151385.88 (405.5%) stddev-sans-first:151727.30 19:29:12 INFO - PROCESS | 1657 | Values: 456.4 472.7 530.9 541.9 543.0 37307.0 39562.4 39566.8 39597.4 39667.8 40519.4 40896.6 41043.0 41147.4 41165.8 9684.5 9901.1 9916.7 9937.9 9942.7 9822.5 9925.3 9935.1 9939.7 9959.9 9925.7 9986.8 9995.5 10002.2 10014.3 9955.8 9959.2 9974.8 9990.5 10011.6 9787.4 9819.9 9822.0 9837.6 9852.5 38807.0 39026.4 39131.4 39163.0 39220.0 2566.6 3224.8 3482.7 3598.7 4117.4 22118.0 24814.9 25388.5 28186.7 30243.5 3206.8 3231.9 3249.3 3344.4 3346.7 439925.0 440467.0 441099.0 444822.0 445204.0 32643.3 32727.8 32741.0 32765.0 32825.7 27561.3 34417.5 34983.0 35663.0 35721.3 14522.3 16085.3 16142.9 16206.6 16224.8 10262.1 11866.6 12471.9 12490.8 12502.7 16585.1 17939.9 18894.2 18914.7 18959.3 6994.9 8125.9 8298.5 8319.5 8393.4 858.4 975.9 1002.3 1089.9 1099.1 26068.3 30493.4 30909.9 31329.2 32116.4 857.5 914.8 968.7 1029.5 1073.5 14633.4 15343.5 15582.0 15625.8 15706.4 560843.0 625895.0 626853.8 626880.0 627462.0 54715.0 55290.0 55451.4 57641.4 59100.7 1362.7 1377.2 1419.9 1422.4 1426.5 28972.5 30108.5 30211.1 30496.2 30680.7 41076.4 49746.3 50155.5 50163.2 50370.7 611912.0 622070.0 622967.0 623331.0 624730.0 24426.4 24794.5 26611.7 26991.9 27084.6 45203.3 45533.8 45562.8 46036.0 46659.5 34294.3 34866.7 37352.8 37484.1 38423.8 36297.3 37276.1 37294.8 38413.0 38753.0 34692.8 36537.8 36723.8 37808.3 38484.6 32006.7 33163.4 33595.8 33598.6 33748.2 23541.8 24638.0 24672.6 24786.0 24916.1 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34936.94 Median:2874.17 stddev:99643.76 (3466.9%) stddev-sans-first:99889.46 19:29:12 INFO - PROCESS | 1657 | Values: 354.7 370.7 376.8 382.8 399.2 20488.9 20489.2 20844.0 21156.0 21315.8 19716.8 20770.6 21020.8 21340.0 21713.3 5933.8 5958.8 6158.8 6159.6 6183.9 3781.2 5190.1 6036.3 6115.1 6243.8 5866.8 6698.7 6847.5 6857.7 6874.2 6587.0 6769.3 6845.5 6846.0 6854.0 4342.9 5851.1 5941.7 5947.2 5962.5 24575.0 25688.0 25850.9 25914.0 26125.5 2109.8 2148.6 2245.1 2822.2 2926.2 9961.4 10043.4 10066.5 10120.1 10182.3 1841.0 1865.3 1906.5 1926.9 2093.2 114953.3 116313.0 118878.0 123107.0 124269.0 9273.8 10927.5 11316.5 11450.5 11451.7 14096.1 14191.4 14211.7 14222.6 14229.9 8154.5 8302.9 8367.7 8463.3 8483.1 6810.6 7209.5 7245.6 8332.4 8485.4 3680.7 4478.6 4481.4 4494.7 4573.2 1577.7 1653.3 1902.6 1942.4 1960.1 767.8 840.9 876.2 909.2 985.1 20525.3 21218.7 21224.0 21249.9 21288.8 906.7 915.5 931.8 947.2 971.0 10693.8 10795.7 11160.2 11404.3 11430.8 575809.0 586448.0 598116.0 612878.0 615383.0 81042.0 84340.6 128131.0 130696.0 135516.3 1020.8 1029.1 1063.5 1069.5 1070.3 19375.2 19432.1 19477.6 19690.8 19720.9 55104.9 55115.2 55327.7 58986.7 59661.1 84037.6 84685.0 85209.6 85385.0 85620.3 7208.1 7313.2 7767.6 8147.6 8219.1 9937.0 12631.2 12964.4 13013.5 13421.9 8214.3 11218.9 11362.7 11593.6 11621.5 9400.2 10671.9 11244.2 11345.0 11411.5 11414.2 11659.6 11758.0 11820.5 11930.5 7069.0 7111.8 7322.1 7450.1 8399.9 9430.9 11257.7 11645.4 11797.2 11892.1 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5626.88 Median:4900.85 stddev:3150.12 (64.3%) stddev-sans-first:3143.96 19:29:12 INFO - PROCESS | 1657 | Values: 1536.1 1565.9 1764.4 1851.4 1853.0 7853.4 8329.9 8488.5 8878.6 8930.8 8523.4 8723.7 8740.8 8749.8 8760.8 1986.6 2294.6 2329.8 2344.6 2368.0 2160.0 2295.2 2314.6 2356.4 2363.3 2131.9 2144.7 2196.6 2273.6 2390.7 1993.6 2019.4 2376.6 2390.0 2392.1 1946.3 2101.6 2191.8 2380.8 2393.4 7580.8 8816.0 8905.9 8918.6 8931.3 5210.7 5301.4 5360.2 5389.6 5391.2 3504.5 3601.2 3688.8 3728.9 3741.4 1108.5 1113.4 1117.6 1135.8 1142.5 11408.5 11473.4 11560.2 11582.2 11617.0 4606.5 4640.8 4852.9 4889.1 4912.6 9060.1 9907.5 9925.4 9936.8 9945.2 5315.1 5324.3 5343.5 5347.8 5353.3 3845.9 3973.2 4677.7 4843.3 4879.6 3896.5 3939.6 4061.6 4089.2 4099.0 1297.2 1301.1 1314.3 1318.6 1320.6 859.6 860.0 911.2 915.3 943.2 5327.6 5449.1 5688.8 5894.3 6044.0 965.4 966.1 983.3 987.6 1033.8 3907.0 3950.4 4021.5 4101.9 4117.6 10349.6 10625.9 10658.3 10664.6 10675.1 8860.8 10179.2 10637.1 10641.9 10672.1 7094.8 8051.8 8101.6 8248.9 8249.1 4937.6 5701.2 5824.3 5867.8 5912.9 9848.1 9976.6 10027.0 10060.2 10096.0 9662.7 9929.7 10069.7 10188.2 10279.4 5606.9 6863.4 6964.9 7040.2 7079.9 8415.7 8468.9 8490.1 8497.1 8509.4 7410.6 7493.7 7512.5 7581.6 7647.3 6746.9 7241.9 7362.1 7362.3 7457.9 5843.8 7018.6 7075.0 7083.7 7103.4 4725.4 4794.3 4797.0 4837.7 4873.4 4847.9 4913.1 4943.5 4970.2 5004.0 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4456.62 Median:4771.48 stddev:1388.85 (29.1%) stddev-sans-first:1356.61 19:29:12 INFO - PROCESS | 1657 | Values: 263.3 296.9 301.4 308.0 313.7 5472.5 5576.6 5711.6 5720.7 5745.3 4700.2 4743.0 5601.9 5704.0 5741.5 4258.9 4373.8 4376.2 4380.5 4423.7 4016.3 4242.6 4296.1 4344.1 4423.5 3562.9 3745.8 4263.7 4300.0 4307.9 3382.9 3951.7 4035.8 4324.7 4354.5 2929.9 3745.1 3749.2 3758.6 3769.9 5289.7 5503.6 5554.8 5585.4 5636.7 4476.6 4864.9 4964.6 5013.8 5019.2 4915.0 5026.0 5600.4 6036.5 6070.9 3333.0 3364.1 3483.4 3909.2 3995.5 5006.9 5390.5 5551.1 5888.5 6323.2 3792.6 3849.0 4037.1 4038.4 4059.4 3987.5 4065.6 4090.4 4091.3 4098.6 3998.6 4733.2 4883.4 4886.4 4890.0 5811.3 6037.5 6048.6 6096.0 6106.6 1080.7 1372.2 1383.2 1403.4 1410.5 819.3 822.4 851.7 858.0 866.6 4226.6 4247.0 4378.9 4442.6 4476.4 4641.7 4675.6 4711.4 5087.7 5196.5 4005.5 4257.7 4373.3 4738.6 4785.6 2369.2 2444.5 2498.5 2545.4 2732.3 4867.8 5281.4 5311.7 5411.0 5412.5 4536.8 4754.8 4910.7 5208.3 5261.7 4287.3 4594.6 4840.6 5258.9 5474.8 4219.8 4289.0 4692.4 5188.7 5236.7 4169.7 4757.4 5118.3 5130.4 5152.7 4440.5 4563.3 5274.7 5327.8 5359.7 3378.1 3454.5 3515.4 3536.8 3547.4 4412.9 4619.9 5046.8 5101.5 5139.6 4251.4 5715.4 5997.5 6007.6 6032.6 5776.5 5865.6 5931.9 6073.0 6073.5 5108.6 5755.8 5776.7 5780.3 5912.6 4891.4 5475.6 6060.5 6063.6 6097.0 5049.5 5913.3 5924.7 5949.9 5993.0 19:29:12 INFO - PROCESS | 1657 | 19:29:12 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24837.82 Median:3707.97 stddev:39840.25 (1074.4%) stddev-sans-first:39910.44 19:29:12 INFO - PROCESS | 1657 | Values: 598.8 719.3 738.5 790.1 826.4 15245.2 15769.9 16148.4 16262.7 16295.3 14832.3 14836.2 14867.9 14967.3 15006.5 840.7 849.3 857.4 859.1 859.7 673.4 832.5 857.3 857.6 865.8 747.9 900.1 911.2 915.4 917.2 854.4 903.8 908.8 910.9 915.4 665.7 670.0 678.3 681.8 683.3 15229.0 15354.7 15365.7 15396.6 15413.2 13424.9 14763.6 14813.9 14941.6 14958.5 12054.6 12111.9 12132.5 12216.5 12386.1 3883.9 3927.7 4026.1 4097.8 4099.4 123813.4 123880.4 125819.0 127180.0 127255.0 11166.0 11440.5 11455.4 11504.5 11844.4 24044.8 24094.0 24116.0 24129.5 24191.3 7352.6 7720.8 8219.1 8364.7 8476.7 4500.0 4569.4 4586.8 4587.9 4659.2 3588.4 3680.5 3694.8 3721.1 3738.2 658.5 667.9 669.7 670.2 671.1 483.8 587.5 639.2 645.8 652.5 9452.4 9587.6 9634.0 9743.6 9896.9 550.9 621.2 634.7 668.9 679.7 4383.5 4606.5 4627.2 4710.6 4711.2 90493.5 101389.0 165340.0 166767.0 169679.2 113629.9 133735.7 137037.3 138867.3 142413.3 71698.6 73946.9 96144.0 102988.5 104269.0 9464.6 9953.6 10079.2 10128.8 10171.7 59883.0 61207.4 62204.4 63792.4 64875.9 92500.5 96375.0 97884.6 99097.5 103051.0 11293.3 11457.6 13137.9 13263.7 13308.1 9716.6 12243.8 13441.3 13670.8 13906.7 10966.6 11803.5 12610.5 12700.3 12883.9 13844.7 13928.4 13951.7 13957.5 14624.3 11203.2 13347.0 13588.5 13910.0 14178.0 10371.8 11252.8 11395.4 11658.7 11787.4 9670.9 10487.4 11514.9 11622.8 11670.2 19:29:12 INFO - PROCESS | 1657 | -------- Summary: end -------- 19:29:12 INFO - PROCESS | 1657 | 19:29:13 INFO - TEST-INFO | 1657: exit 0 19:29:13 INFO - TEST-OK | dromaeo_css | took 1113107ms 19:29:13 INFO - TEST-START | kraken 19:29:13 INFO - operating with platform_type : mac_ 19:29:13 INFO - Initialising browser for kraken test... 19:29:13 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpeZFTzh/profile http://localhost:49263/getInfo.html) 19:29:15 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 19:29:15 INFO - PROCESS | 1665 | colorDepth:24 19:29:15 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 19:29:15 INFO - PROCESS | 1665 | __metrics 19:29:15 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:29:16 INFO - TEST-INFO | 1665: exit 0 19:29:16 INFO - Browser initialized. 19:29:16 INFO - Running cycle 1/1 for kraken test... 19:29:16 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/tmpeZFTzh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:28 INFO - PROCESS | 1667 | RSS: Main: 239263744 19:29:28 INFO - PROCESS | 1667 | 19:29:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:32 INFO - PROCESS | 1667 | RSS: Main: 252313600 19:29:32 INFO - PROCESS | 1667 | 19:29:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 19:29:35 INFO - PROCESS | 1667 | RSS: Main: 260960256 19:29:35 INFO - PROCESS | 1667 | 19:29:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 19:29:39 INFO - PROCESS | 1667 | RSS: Main: 263950336 19:29:39 INFO - PROCESS | 1667 | 19:29:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 19:29:42 INFO - PROCESS | 1667 | RSS: Main: 265236480 19:29:42 INFO - PROCESS | 1667 | 19:29:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:29:45 INFO - PROCESS | 1667 | RSS: Main: 265592832 19:29:45 INFO - PROCESS | 1667 | 19:29:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 19:29:48 INFO - PROCESS | 1667 | RSS: Main: 265691136 19:29:48 INFO - PROCESS | 1667 | 19:29:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 19:29:52 INFO - PROCESS | 1667 | RSS: Main: 267210752 19:29:52 INFO - PROCESS | 1667 | 19:29:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 19:29:56 INFO - PROCESS | 1667 | RSS: Main: 267542528 19:29:56 INFO - PROCESS | 1667 | 19:29:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:29:58 INFO - PROCESS | 1667 | RSS: Main: 267108352 19:29:58 INFO - PROCESS | 1667 | 19:30:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:01 INFO - PROCESS | 1667 | RSS: Main: 267227136 19:30:01 INFO - PROCESS | 1667 | 19:30:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:04 INFO - PROCESS | 1667 | RSS: Main: 267485184 19:30:04 INFO - PROCESS | 1667 | 19:30:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:07 INFO - PROCESS | 1667 | RSS: Main: 267857920 19:30:07 INFO - PROCESS | 1667 | 19:30:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:11 INFO - PROCESS | 1667 | RSS: Main: 267599872 19:30:11 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 19:30:13 INFO - PROCESS | 1667 | RSS: Main: 268795904 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | __start_tp_report 19:30:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 19:30:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 19:30:13 INFO - PROCESS | 1667 | |i|pagename|runs| 19:30:13 INFO - PROCESS | 1667 | |0;ai-astar;106;170;110;117;113;117;119;113;126;117 19:30:13 INFO - PROCESS | 1667 | |1;audio-beat-detection;141;109;130;172;139;143;152;145;175;105 19:30:13 INFO - PROCESS | 1667 | |2;audio-dft;206;211;227;263;274;196;194;203;196;196 19:30:13 INFO - PROCESS | 1667 | |3;audio-fft;67;82;74;142;59;61;79;86;160;53 19:30:13 INFO - PROCESS | 1667 | |4;audio-oscillator;70;74;122;73;72;78;115;71;72;150 19:30:13 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;91;88;90;97;90;124;82;130;132;86 19:30:13 INFO - PROCESS | 1667 | |6;imaging-darkroom;151;126;138;151;92;153;129;96;135;150 19:30:13 INFO - PROCESS | 1667 | |7;imaging-desaturate;90;78;148;149;92;91;94;99;95;108 19:30:13 INFO - PROCESS | 1667 | |8;json-parse-financial;55;56;58;56;56;57;56;76;51;49 19:30:13 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;62;71;66;73;75;76;92;62;68;89 19:30:13 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;110;76;79;75;82;79;83;103;107;108 19:30:13 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;158;155;155;150;158;133;158;164;227;164 19:30:13 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;175;171;180;170;169;173;235;173;175;237 19:30:13 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;70;67;67;66;90;87;86;81;68;68 19:30:13 INFO - PROCESS | 1667 | __end_tp_report 19:30:13 INFO - PROCESS | 1667 | __start_cc_report 19:30:13 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1043 19:30:13 INFO - PROCESS | 1667 | __end_cc_report 19:30:13 INFO - PROCESS | 1667 | __startTimestamp1471487413540__endTimestamp 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | ------- Summary: start ------- 19:30:13 INFO - PROCESS | 1667 | Number of tests: 14 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:120.80 Median:117.00 stddev:18.11 (15.5%) stddev-sans-first:18.40 19:30:13 INFO - PROCESS | 1667 | Values: 106.0 170.0 110.0 117.0 113.0 117.0 119.0 113.0 126.0 117.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:144.00 stddev:22.86 (15.9%) stddev-sans-first:24.25 19:30:13 INFO - PROCESS | 1667 | Values: 141.0 109.0 130.0 172.0 139.0 143.0 152.0 145.0 175.0 105.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:216.60 Median:208.50 stddev:29.19 (14.0%) stddev-sans-first:30.71 19:30:13 INFO - PROCESS | 1667 | Values: 206.0 211.0 227.0 263.0 274.0 196.0 194.0 203.0 196.0 196.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:86.30 Median:70.50 stddev:35.94 (51.0%) stddev-sans-first:37.43 19:30:13 INFO - PROCESS | 1667 | Values: 67.0 82.0 74.0 142.0 59.0 61.0 79.0 86.0 160.0 53.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:72.00 stddev:28.57 (39.7%) stddev-sans-first:29.40 19:30:13 INFO - PROCESS | 1667 | Values: 70.0 74.0 122.0 73.0 72.0 78.0 115.0 71.0 72.0 150.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:89.00 stddev:19.56 (22.0%) stddev-sans-first:20.41 19:30:13 INFO - PROCESS | 1667 | Values: 91.0 88.0 90.0 97.0 90.0 124.0 82.0 130.0 132.0 86.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:132.10 Median:151.00 stddev:22.29 (14.8%) stddev-sans-first:22.57 19:30:13 INFO - PROCESS | 1667 | Values: 151.0 126.0 138.0 151.0 92.0 153.0 129.0 96.0 135.0 150.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:104.40 Median:91.50 stddev:24.42 (26.7%) stddev-sans-first:25.34 19:30:13 INFO - PROCESS | 1667 | Values: 90.0 78.0 148.0 149.0 92.0 91.0 94.0 99.0 95.0 108.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:7.23 (12.9%) stddev-sans-first:7.63 19:30:13 INFO - PROCESS | 1667 | Values: 55.0 56.0 58.0 56.0 56.0 57.0 56.0 76.0 51.0 49.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:74.00 stddev:10.27 (13.9%) stddev-sans-first:10.02 19:30:13 INFO - PROCESS | 1667 | Values: 62.0 71.0 66.0 73.0 75.0 76.0 92.0 62.0 68.0 89.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:77.50 stddev:14.75 (19.0%) stddev-sans-first:13.79 19:30:13 INFO - PROCESS | 1667 | Values: 110.0 76.0 79.0 75.0 82.0 79.0 83.0 103.0 107.0 108.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:162.20 Median:158.00 stddev:24.41 (15.5%) stddev-sans-first:25.85 19:30:13 INFO - PROCESS | 1667 | Values: 158.0 155.0 155.0 150.0 158.0 133.0 158.0 164.0 227.0 164.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:175.00 stddev:26.64 (15.2%) stddev-sans-first:27.97 19:30:13 INFO - PROCESS | 1667 | Values: 175.0 171.0 180.0 170.0 169.0 173.0 235.0 173.0 175.0 237.0 19:30:13 INFO - PROCESS | 1667 | 19:30:13 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.50 stddev:9.76 (12.9%) stddev-sans-first:10.19 19:30:13 INFO - PROCESS | 1667 | Values: 70.0 67.0 67.0 66.0 90.0 87.0 86.0 81.0 68.0 68.0 19:30:13 INFO - PROCESS | 1667 | -------- Summary: end -------- 19:30:13 INFO - PROCESS | 1667 | 19:30:14 INFO - TEST-INFO | 1667: exit 0 19:30:14 INFO - TEST-OK | kraken | took 61132ms 19:30:14 INFO - SUITE-END | took 1174s 19:30:14 INFO - Completed test suite (00:19:34) 19:30:14 INFO - javascript benchmark 19:30:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7265.8204592592565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2430.6597076409307, 3124.297033167539, 3234.0782876880094, 3369.494575813629, 3385.7122144617697, 5525.281713377255, 5608.327000759909, 5634.521065709415, 5706.3722990471015, 5748.252727145476, 4535.795889184987, 5648.830535083954, 5661.971690141543, 5684.516816070639, 5764.682942438164, 5080.187170052783, 5143.897122057557, 5161.251618515313, 5234.947650523484, 5290.074237008508, 4715.269133284346, 5028.321176641143, 5125.234111624422, 5233.528982391584, 5343.759530821122, 5055.747212639353, 5107.131787596118, 5128.5640720538795, 5180.766865491024, 5206.297149884774, 5210.062188806013, 5222.503862133091, 5224.294720212761, 5232.764525596357, 5249.842504724865, 5157.355330583677, 5194.480551944813, 5201.635885488017, 5202.505761952609, 5216.686998780086, 4627.334159702505, 5253.3958594761325, 5657.688827114507, 5704.543636509111, 5765.1928729977835, 6158.353372895826, 6220.315765265817, 6228.252609686821, 6238.625682459067, 6263.34234905333, 6216.0, 6228.96885515574, 6229.408206220402, 6240.500759939194, 6246.219222597176, 5589.916151257735, 5677.659340439504, 5706.771729130788, 5743.310802703702, 5777.959967205901, 6148.907766383508, 6176.042713379434, 6227.96886015567, 6274.247090349188, 6283.2460104787715, 6114.663693496811, 6144.139820425144, 6148.6925653717135, 6183.783567575113, 6187.0, 6075.362086980892, 6242.1261023456755, 6249.6562689051625, 6254.21822272216, 6268.341824108494, 6103.389661033861, 6159.907601385983, 6170.691465426711, 6197.659128747962, 6228.159198508143, 6186.81439556814, 6216.222972128484, 6224.688765561704, 6226.813195604139, 6245.28179259391, 3992.181602771425, 4886.633502487328, 4891.706497610084, 4913.65604407688, 4929.260610908321, 4311.590398912098, 4324.394584758136, 4357.847475338348, 4360.258756011485, 4428.645708343325, 5677.17680936262, 5742.339630942495, 5760.308762948389, 5788.131780232999, 5796.478316951495, 6123.571350005457, 6190.41191086846, 6194.473469755031, 6195.349488303663, 6201.255849298113, 5699.373068962411, 5720.456556627114, 5787.855303617359, 5831.912521312183, 5875.059990401515, 5437.891242175135, 5443.292371991616, 5450.972745136249, 5451.945480545223, 5460.563154947595, 6151.292601350902, 6257.186565746424, 6298.338674439209, 6300.558960872787, 6351.269603995507, 6161.568690191643, 6171.475424588781, 6206.131141640084, 6224.315325314121, 6252.874942501034, 5045.293658887832, 6247.718852651551, 6251.749930002749, 6321.115043893767, 6333.588316759396, 5389.27244821944, 6052.75788968454, 6076.544259180668, 6210.192674952227, 6227.1282020516255, 6176.81469555914, 6178.7219575120125, 6196.597221180609, 6234.906476402948, 6238.937610624017, 5383.219433182245, 5759.337676167127, 6062.848428789315, 6136.938630613815, 6146.231721034871, 5783.392743761844, 6126.448619624255, 6154.661493617894, 6165.537584681257, 6180.6291622502795, 4958.975205124096, 5724.885502289848, 5830.883382332415, 5951.642901425928, 5992.943598764574, 6114.2357205349335, 6130.386961303834, 6132.478739307209, 6138.662373569497, 6154.046122850965, 5807.94192058074, 5933.643981361132, 5990.760369585168, 5998.040313549811, 6000.009998350223], "value": 5627.721673057239, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.35881586371147, 472.69511165298405, 530.9203619457084, 541.9295491586095, 542.9701366424847, 37307.0, 39562.406563901495, 39566.80216598913, 39597.40603890944, 39667.80166099169, 40519.392209116886, 40896.59103408965, 41042.97392565187, 41147.38278925811, 41165.79417102918, 9684.467354295528, 9901.10890019898, 9916.702498925044, 9937.850932236022, 9942.65200717975, 9822.508874556279, 9925.305228633963, 9935.105840474356, 9939.652112176076, 9959.900400996006, 9925.702228933143, 9986.750331241705, 9995.500224988758, 10002.249831262649, 10014.298999070068, 9955.800883982352, 9959.153471954893, 9974.750631234205, 9990.45052522111, 10011.59953601855, 9787.412755234709, 9819.852702209473, 9822.0, 9837.606495740161, 9852.50737463124, 38807.0, 39026.41460378097, 39131.41302880431, 39163.0, 39220.0, 2566.5508536006123, 3224.8387580620874, 3482.7387945904156, 3598.712103031751, 4117.444145040411, 22118.0, 24814.875925620436, 25388.49223015548, 28186.718132818616, 30243.546346804815, 3206.7594930380315, 3231.8710832587194, 3249.2689144942437, 3344.3980083584943, 3346.7489938254485, 439925.0, 440467.0, 441099.0, 444822.0, 445203.99999999674, 32643.347133057207, 32727.836360818044, 32741.0, 32765.017049488553, 32825.67174328226, 27561.31096722598, 34417.483737743954, 34983.0, 35663.0, 35721.28557428837, 14522.346494407777, 16085.276162572713, 16142.919285403732, 16206.594835129215, 16224.756628650579, 10262.127719143808, 11866.644000679993, 12471.875281247072, 12490.81263781044, 12502.687432814253, 16585.087820170007, 17939.923604583768, 18894.24423023091, 18914.716279255823, 18959.336423225122, 6994.860102797916, 8125.878111828328, 8298.54358010303, 8319.542425166554, 8393.370497212734, 858.4248553469066, 975.9414435133915, 1002.293383164867, 1089.8746644135867, 1099.120703437263, 26068.34829129287, 30493.390132197233, 30909.918152864993, 31329.216769580944, 32116.39739355517, 857.4989120544353, 914.8364118858851, 968.6851773173606, 1029.4955471818755, 1073.4793625091825, 14633.414663413558, 15343.539693809204, 15582.0, 15625.765613515807, 15706.371745130067, 560843.0, 625895.0, 626853.79157938, 626880.0, 627462.0, 54715.0, 55290.0, 55451.44548554543, 57641.423585764445, 59100.70449647724, 1362.7206422683325, 1377.2425166158573, 1419.9432022718975, 1422.3883729995994, 1426.522115091456, 28972.522980104724, 30108.548371774003, 30211.09366719002, 30496.23759405944, 30680.693193067782, 41076.383854242806, 49746.25380619221, 50155.49844501508, 50163.24755128603, 50370.74814625904, 611912.0, 622070.0, 622967.0, 623331.0, 624730.0, 24426.389340266636, 24794.50410991806, 26611.7338826617, 26991.865040675457, 27084.593731094443, 45203.32195017012, 45533.772331138134, 45562.77218614018, 46036.0, 46659.53340466688, 34294.31411371709, 34866.65133348735, 37352.813235933645, 37484.06289842776, 38423.84728458039, 36297.27405451929, 37276.06809829776, 37294.81352593219, 38413.0, 38753.0, 34692.826535867156, 36537.81731091434, 36723.816380917924, 37808.29862656242, 38484.61515384923, 32006.6799332013, 33163.414428739845, 33595.83202083974, 33598.64013598621, 33748.15629609279, 23541.764582353957, 24638.0, 24672.629910551714, 24786.0, 24916.12793552217], "value": 19040.074467482744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.6825591095968, 370.6867696796206, 376.785232417522, 382.82772752261457, 399.20956506117886, 20488.89755551222, 20489.18043278269, 20843.95780210991, 21156.047977840997, 21315.786842131572, 19716.802831971676, 20770.584588308226, 21020.789792102074, 21340.0, 21713.348599541998, 5933.792317268896, 5958.821235362935, 6158.799346178607, 6159.568830181889, 6183.876322473548, 3781.2059467511854, 5190.11767999441, 6036.275646922353, 6115.143879856823, 6243.843903902393, 5866.794662186824, 6698.73205071799, 6847.520673552854, 6857.725690972356, 6874.243833178346, 6586.967065164691, 6769.323067693241, 6845.520813543054, 6846.0, 6853.965730171367, 4342.935980684721, 5851.093080572518, 5941.673207973559, 5947.167396564484, 5962.463378295931, 24575.0, 25688.0, 25850.870745646152, 25914.0, 26125.477490450274, 2109.789021097893, 2148.5917675641576, 2245.113180293791, 2822.195674232834, 2926.1514160893316, 9961.40231586107, 10043.447610381427, 10066.547005384775, 10120.089191972684, 10182.338148020355, 1841.0, 1865.2818664814145, 1906.5424298168477, 1926.8940208288539, 2093.2359688713664, 114953.27570086539, 116313.0, 118878.0, 123107.0, 124269.0, 9273.768155796024, 10927.508262128064, 11316.490757915913, 11450.54197832094, 11451.656450306504, 14096.08375455592, 14191.361388737532, 14211.715765684836, 14222.573322800332, 14229.85770142306, 8154.469959452616, 8302.875456868152, 8367.748967530984, 8463.280621147149, 8483.066862645104, 6810.5913645181445, 7209.459290553229, 7245.601491917995, 8332.416730828783, 8485.406021578554, 3680.705543556509, 4478.641708663299, 4481.395011673382, 4494.70784399013, 4573.245414506569, 1577.7081239970412, 1653.330401187521, 1902.6480101181048, 1942.4172748175774, 1960.11794692389, 767.781182363035, 840.9411341206179, 876.2114097312469, 909.1953621045423, 985.0887928666099, 20525.281615143398, 21218.681719774217, 21224.0, 21249.893750531148, 21288.78711212899, 906.7143849687459, 915.455304094063, 931.7717159296016, 947.1759569174862, 970.9805803883883, 10693.83959240612, 10795.676129716121, 11160.16298777595, 11404.258723182966, 11430.828537571942, 575809.0, 586448.0, 598116.0, 612878.0, 615383.0, 81042.0, 84340.57829710812, 128131.0, 130696.0, 135516.32241838926, 1020.7805321855836, 1029.1098200056897, 1063.5320458998171, 1069.5454431866426, 1070.3310430980637, 19375.224991000203, 19432.125554350372, 19477.61044779068, 19690.80309196947, 19720.901395492932, 55104.89790204254, 55115.17327240014, 55327.72336138294, 58986.705066474395, 59661.10508342292, 84037.57981210055, 84685.0, 85209.57395212984, 85385.0, 85620.29417352469, 7208.098987626547, 7313.23211062852, 7767.611619419119, 8147.592620369076, 8219.054808697076, 9936.950315248378, 12631.242125472501, 12964.416601253155, 13013.479460821462, 13421.865781342452, 8214.301784348158, 11218.934201250868, 11362.659120226406, 11593.594224202112, 11621.535138594361, 9400.200982916529, 10671.89328106709, 11244.212905096565, 11345.0, 11411.486483108114, 11414.201005929504, 11659.591914283299, 11758.0, 11820.468078936641, 11930.522779088738, 7069.0, 7111.7866464006165, 7322.121345438582, 7450.0687414073245, 8399.874001890099, 9430.905690943277, 11257.662270131908, 11645.359505227294, 11797.227651502062, 11892.108091893315], "value": 9585.182406237966, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.0937047142183, 1565.9217039148043, 1764.4001039646525, 1851.3797877710974, 1852.9629407411844, 7853.37173026158, 8329.91670083299, 8488.490690558556, 8878.600462979166, 8930.776730581738, 8523.360747943898, 8723.694670686527, 8740.781480462992, 8749.825003499942, 8760.78098047549, 1986.5629561496448, 2294.6443301288286, 2329.801966832821, 2344.6248600223967, 2368.0409434179187, 2160.0495781855934, 2295.185209250717, 2314.6065168921323, 2356.4226764442737, 2363.3382652857226, 2131.912724510495, 2144.6782982552586, 2196.626573482512, 2273.6021196290667, 2390.7131144262626, 1993.601279744057, 2019.3538067818304, 2376.560336337766, 2390.0, 2392.102961389479, 1946.250693483005, 2101.569178318441, 2191.80273775361, 2380.797632201265, 2393.401649587603, 7580.810479737996, 8815.955920220422, 8905.866412003825, 8918.598663060178, 8931.285497160212, 5210.687358758487, 5301.363836339626, 5360.16917377807, 5389.649672771257, 5391.16436952273, 3504.5093686883856, 3601.1717305019993, 3688.79711615861, 3728.9254214915823, 3741.4013757798893, 1108.5050121756276, 1113.3653817324127, 1117.6479408986143, 1135.7955567997758, 1142.5429828068757, 11408.54365825366, 11473.426328683616, 11560.190786644855, 11582.247153934968, 11616.954474097287, 4606.470255920612, 4640.767961601974, 4852.927206091911, 4889.119958407449, 4912.582430493448, 9060.093990600888, 9907.455089969977, 9925.3548519346, 9936.751581210528, 9945.154661853823, 5315.069862773999, 5324.281222035053, 5343.492368225013, 5347.839564813062, 5353.277307563507, 3845.9038524037123, 3973.205358928226, 4677.7193368398, 4843.2735089736825, 4879.609631229493, 3896.4544963705102, 3939.625735555118, 4061.634452899253, 4089.1821635672986, 4099.0162361033135, 1297.228149251194, 1301.069735139361, 1314.2640121531972, 1318.558282975195, 1320.6434262749003, 859.6002858670748, 859.9914000860036, 911.2300106410073, 915.3272344826547, 943.1605870775015, 5327.600429967768, 5449.128139497661, 5688.772449102073, 5894.322152952465, 6043.969780151071, 965.3725078698902, 966.120830044656, 983.2969426859829, 987.5605355616682, 1033.8087453821067, 3906.9609303906595, 3950.4469374287623, 4021.4571032910767, 4101.8974525637095, 4117.608827161415, 10349.586016559404, 10625.946870265754, 10658.307210031324, 10664.573417063386, 10675.092617127475, 8860.822783544421, 10179.236557258087, 10637.149028077734, 10641.946790266, 10672.092872105957, 7094.8293531566715, 8051.838963220703, 8101.6354264058255, 8248.876266856121, 8249.05135909366, 4937.580305673914, 5701.201831743476, 5824.330202026652, 5867.823965281048, 5912.852178695567, 9848.113669769755, 9976.60093596248, 10027.04743049409, 10060.195184385086, 10096.0, 9662.71011869645, 9929.702108936743, 10069.748256293651, 10188.184945204217, 10279.383237005804, 5606.887862242651, 6863.416609588241, 6964.860702786017, 7040.190378106583, 7079.8938015930835, 8415.705450309455, 8468.872966905625, 8490.06609272967, 8497.107803680772, 8509.404341696269, 7410.592417417094, 7493.700251990077, 7512.511686740344, 7581.6209189539195, 7647.273509016634, 6746.9325306746305, 7241.927580724336, 7362.079740032496, 7362.3373896349585, 7457.888131677921, 5843.824685259449, 7018.5788852669, 7075.0, 7083.716651333889, 7103.396211322096, 4725.40932383452, 4794.328793968917, 4796.9760151199025, 4837.685550439211, 4873.366462359871, 4847.854564363075, 4913.091078150554, 4943.530364615356, 4970.204767237225, 5003.974980125076], "value": 4540.7989118231335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.27074005006136, 296.9272528230584, 301.3972055888223, 307.99593325758025, 313.72549019607845, 5472.482657977325, 5576.609637325379, 5711.600657838825, 5720.742566584503, 5745.310562732473, 4700.213918710893, 4742.97628511857, 5601.943980560203, 5704.0, 5741.45456181662, 4258.936115958263, 4373.846915357964, 4376.19040477511, 4380.540043295456, 4423.712458690191, 4016.337304344794, 4242.639375653058, 4296.0548679290505, 4344.109457561192, 4423.469183697961, 3562.928741425183, 3745.8127093645344, 4263.744175349473, 4300.0, 4307.879951212692, 3382.932341353184, 3951.723379363446, 4035.8385664573384, 4324.664681072233, 4354.542773008852, 2929.8681559329666, 3745.0637340664834, 3749.15643980105, 3758.624137586247, 3769.9057523561855, 5289.709066001368, 5503.587230957694, 5554.77780888768, 5585.413531579166, 5636.718164091779, 4476.6418686505, 4864.878378040542, 4964.60283177345, 5013.824516141917, 5019.196928491424, 4914.950850491485, 5025.99480103977, 5600.411956744524, 6036.4686658304945, 6070.908936365958, 3332.9833350833333, 3364.1253274148653, 3483.425234836249, 3909.198614284065, 3995.5405128410316, 5006.872079366255, 5390.460953904618, 5551.1118221084835, 5888.5289176865745, 6323.154580438821, 3792.639699228569, 3848.980020294624, 4037.0916543778003, 4038.353863381845, 4059.3505039193587, 3987.501562304712, 4065.634092931591, 4090.427340172378, 4091.3453847384276, 4098.647446342699, 3998.6001399859783, 4733.243090693831, 4883.389576302962, 4886.436340371047, 4889.975550122226, 5811.3316968548315, 6037.54718396122, 6048.576599637983, 6096.0, 6106.6336019838955, 1080.6920027792041, 1372.2246930484444, 1383.1631862722907, 1403.4386245501678, 1410.4710733474947, 819.3035919468405, 822.4078663362369, 851.7402192331399, 857.9957100214584, 866.6013633728555, 4226.598473145046, 4246.957530424718, 4378.868633940987, 4442.600165985077, 4476.440444944382, 4641.698289611165, 4675.604931364506, 4711.363965864564, 5087.720175390315, 5196.531647467423, 4005.4592629994577, 4257.659387249013, 4373.310414095308, 4738.597219236403, 4785.569298763058, 2369.218158007853, 2444.523317953018, 2498.462830491453, 2545.440003199293, 2732.289604702752, 4867.76083001816, 5281.445448227958, 5311.7078560678765, 5411.0, 5412.458754124556, 4536.750478723636, 4754.812786118424, 4910.656254062182, 5208.322918020633, 5261.684858662176, 4287.292596721506, 4594.609458196024, 4840.588549973291, 5258.8948221036135, 5474.808381706621, 4219.767912764827, 4289.0, 4692.436907571113, 5188.7405629719115, 5236.659617124875, 4169.665706973739, 4757.381540399726, 5118.257852611276, 5130.384353877558, 5152.742362881766, 4440.5355027959795, 4563.338315944103, 5274.657147285414, 5327.786888524415, 5359.678419294854, 3378.054144839449, 3454.481827725761, 3515.4375299951885, 3536.7701099428455, 3547.4324108142573, 4412.867613971586, 4619.897946434297, 5046.823361182341, 5101.540861322499, 5139.582177851837, 4251.426972020372, 5715.428457154251, 5997.460228579449, 6007.639541627516, 6032.638041717511, 5776.508996735157, 5865.618734782225, 5931.851703707442, 6073.0, 6073.514118870568, 5108.642395032312, 5755.802139965071, 5776.682282474504, 5780.306363236438, 5912.645241285537, 4891.364122664031, 5475.561955043508, 6060.545459090674, 6063.636181829104, 6097.0, 5049.469805670352, 5913.349531551612, 5924.734191382198, 5949.940500595112, 5992.970035149797], "value": 4014.3250427048915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7515181199802, 719.309462915601, 738.471992525345, 790.12690976471, 826.4462809917356, 15245.161516116608, 15769.896107272496, 16148.434804781806, 16262.674746505078, 16295.266712997915, 14832.332545035473, 14836.184009879453, 14867.92566037171, 14967.25163741814, 15006.549803505884, 840.7141571865579, 849.3332733803934, 857.3612658569343, 859.0893652728097, 859.7377799771067, 673.4275865514322, 832.5379414424991, 857.2627540315324, 857.6440777077505, 865.8441480533502, 747.9065116860393, 900.1358695652182, 911.1526280559077, 915.4370062411602, 917.2111983694018, 854.3805740837873, 903.783092057908, 908.7546362482093, 910.8815853939012, 915.4187091197072, 665.6771465839064, 670.0318040431579, 678.3453966921944, 681.7784220128478, 683.3166833166833, 15229.0, 15354.692906141814, 15365.692686146214, 15396.615084622974, 15413.152276624782, 13424.93287533556, 14763.557093287218, 14813.888958328169, 14941.551753447415, 14958.47645332419, 12054.578089766816, 12111.939440302831, 12132.454039568152, 12216.450259738243, 12386.071044671686, 3883.930350241075, 3927.7446965947124, 4026.053877338823, 4097.774622395767, 4099.364598487239, 123813.38093309566, 123880.38059809734, 125819.0, 127180.0, 127255.0, 11166.0, 11440.485178167002, 11455.369954652408, 11504.482298296596, 11844.407779610985, 24044.75955240425, 24094.0, 24116.0, 24129.536035833426, 24191.27426177182, 7352.5956072415465, 7720.845583088307, 8219.136990616018, 8364.707235246737, 8476.745697629081, 4499.960282786516, 4569.442784880715, 4586.781792137519, 4587.931181032287, 4659.207934651117, 3588.4079126944284, 3680.5031320771886, 3694.7967861767324, 3721.14413684854, 3738.1962877981364, 658.4896705053526, 667.8630880669451, 669.715370967337, 670.2392784189882, 671.1342368344781, 483.8330775882315, 587.4742105815271, 639.2041907824788, 645.7998020613625, 652.4551999080726, 9452.43285402878, 9587.568559414844, 9633.951830240803, 9743.561539730586, 9896.911339752765, 550.9449055094539, 621.1733053739372, 634.6985182038587, 668.8628831089615, 679.7126579142928, 4383.473983122046, 4606.493285738566, 4627.167109920247, 4710.599599034052, 4711.201649566506, 90493.54753226324, 101389.0, 165340.0, 166767.0, 169679.1516042412, 113629.86370136193, 133735.66264337426, 137037.25925481634, 138867.30566347102, 142413.28793355968, 71698.56602867914, 73946.8907966381, 96144.03855961491, 102988.48505757573, 104269.0, 9464.621415143318, 9953.552090155816, 10079.244056695923, 10128.79742405133, 10171.7457063574, 59883.01169882977, 61207.38792612195, 62204.377956221666, 63792.362076378646, 64875.86365499886, 92500.53749731208, 96375.0, 97884.57403990826, 99097.50451247698, 103051.0, 11293.322400655987, 11457.59898403552, 13137.94896408266, 13263.734725305632, 13308.134971226838, 9716.562754675915, 12243.775622437684, 13441.260730659516, 13670.769630733283, 13906.721865562835, 10966.616168434066, 11803.527858885549, 12610.49558017669, 12700.301483418501, 12883.935580322039, 13844.653883652989, 13928.373223204777, 13951.651208719863, 13957.511487097903, 14624.268786560417, 11203.21577489568, 13347.0, 13588.456461741815, 13910.0, 14178.007539472137, 10371.844422333521, 11252.774944501229, 11395.373254471084, 11658.6502404928, 11787.351695656822, 9670.854937175807, 10487.423191724529, 11514.88485115138, 11622.76754464889, 11670.183087183816], "value": 7858.068204310925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1635.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 170.0, 110.0, 117.0, 113.0, 117.0, 119.0, 113.0, 126.0, 117.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 130.0, 172.0, 139.0, 143.0, 152.0, 145.0, 175.0, 105.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 211.0, 227.0, 263.0, 274.0, 196.0, 194.0, 203.0, 196.0, 196.0], "value": 216.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 82.0, 74.0, 142.0, 59.0, 61.0, 79.0, 86.0, 160.0, 53.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 122.0, 73.0, 72.0, 78.0, 115.0, 71.0, 72.0, 150.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 97.0, 90.0, 124.0, 82.0, 130.0, 132.0, 86.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 138.0, 151.0, 92.0, 153.0, 129.0, 96.0, 135.0, 150.0], "value": 132.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 78.0, 148.0, 149.0, 92.0, 91.0, 94.0, 99.0, 95.0, 108.0], "value": 104.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 58.0, 56.0, 56.0, 57.0, 56.0, 76.0, 51.0, 49.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 66.0, 73.0, 75.0, 76.0, 92.0, 62.0, 68.0, 89.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 76.0, 79.0, 75.0, 82.0, 79.0, 83.0, 103.0, 107.0, 108.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 155.0, 150.0, 158.0, 133.0, 158.0, 164.0, 227.0, 164.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 180.0, 170.0, 169.0, 173.0, 235.0, 173.0, 175.0, 237.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 66.0, 90.0, 87.0, 86.0, 81.0, 68.0, 68.0], "value": 75.0, "unit": "score"}]}]} 19:30:14 INFO - Return code: 0 19:30:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:30:14 ERROR - # TBPL SUCCESS # 19:30:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:30:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:30:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:30:14 INFO - 2016-08-17 19:30:14.875 screenresolution[1673:10526] starting screenresolution argv=screenresolution get 19:30:14 INFO - 2016-08-17 19:30:14.878 screenresolution[1673:10526] Display 0: 1600x1200x32@60 19:30:14 INFO - 2016-08-17 19:30:14.883 screenresolution[1674:10529] starting screenresolution argv=screenresolution list 19:30:14 INFO - Available Modes on Display 0 19:30:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:30:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:30:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:30:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:30:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:30:15 INFO - Intel Iris: 19:30:15 INFO - Chipset Model: Intel Iris 19:30:15 INFO - Type: GPU 19:30:15 INFO - Bus: Built-In 19:30:15 INFO - VRAM (Dynamic, Max): 1536 MB 19:30:15 INFO - Vendor: Intel (0x8086) 19:30:15 INFO - Device ID: 0x0a2e 19:30:15 INFO - Revision ID: 0x0009 19:30:15 INFO - Displays: 19:30:15 INFO - Display: 19:30:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:30:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:30:15 INFO - Display Serial Number: 1600x1200 60 19:30:15 INFO - Main Display: Yes 19:30:15 INFO - Mirror: Off 19:30:15 INFO - Online: Yes 19:30:15 INFO - Rotation: Supported 19:30:15 INFO - Return code: 0 19:30:15 INFO - Running post-action listener: _resource_record_post_action 19:30:15 INFO - [mozharness: 2016-08-18 02:30:15.117680Z] Finished run-tests step (success) 19:30:15 INFO - Running post-run listener: _resource_record_post_run 19:30:15 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37090304; Write bytes: 706775040; Read time: 240; Write time: 2030 19:30:15 INFO - TinderboxPrint: CPU usage
54.6% 19:30:15 INFO - TinderboxPrint: I/O read bytes / time
37,090,304 / 240 19:30:15 INFO - TinderboxPrint: I/O write bytes / time
706,775,040 / 2,030 19:30:15 INFO - TinderboxPrint: CPU idle
2,194.7 (45.4%) 19:30:15 INFO - TinderboxPrint: CPU system
978.2 (20.2%) 19:30:15 INFO - TinderboxPrint: CPU user
1,664.8 (34.4%) 19:30:15 INFO - TinderboxPrint: Swap in / out
442,175,488 / 0 19:30:15 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 410354176; Write bytes: 398559232; Read time: 29947; Write time: 866 19:30:15 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 29092864; Write bytes: 298254336; Read time: 175; Write time: 1130 19:30:15 INFO - Running post-run listener: _upload_blobber_files 19:30:15 INFO - Blob upload gear active. 19:30:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:30:15 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'] 19:30:15 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 19:30:16 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:17 INFO - (blobuploader) - INFO - Done attempting. 19:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:18 INFO - (blobuploader) - INFO - Done attempting. 19:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:20 INFO - (blobuploader) - INFO - Done attempting. 19:30:20 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:20 INFO - Return code: 0 19:30:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c15da96ebb5905505bb20ca745cf409683178354e1c15ca8e3a8ebaf67d6b938483db7e06be8a2035d970a53045df2aa0bd541240ccb2229f4a4d8e708bf7066", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfe5cec66ec1967e8b0a46467994c0097d2b3c48af16e81e955248955448660603e84c76899898fee8f2c4981332bb5501be68ddb52fd173709e8848f3c89f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf15aa5708285eb9a4e42ed22011fdacd84350b49c1e2af0883443203354e5e14a1d90ce5efacbc16f0d01e412828531d8e873bfa8c41fde50ba62471dfd07e1"} 19:30:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:20 INFO - Contents: 19:30:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c15da96ebb5905505bb20ca745cf409683178354e1c15ca8e3a8ebaf67d6b938483db7e06be8a2035d970a53045df2aa0bd541240ccb2229f4a4d8e708bf7066", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfe5cec66ec1967e8b0a46467994c0097d2b3c48af16e81e955248955448660603e84c76899898fee8f2c4981332bb5501be68ddb52fd173709e8848f3c89f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf15aa5708285eb9a4e42ed22011fdacd84350b49c1e2af0883443203354e5e14a1d90ce5efacbc16f0d01e412828531d8e873bfa8c41fde50ba62471dfd07e1"} 19:30:20 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:20 INFO - Copying logs to upload dir... 19:30:20 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.280817 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-17 19:30:20.539595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 19:30:20.543402) ========= 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.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c15da96ebb5905505bb20ca745cf409683178354e1c15ca8e3a8ebaf67d6b938483db7e06be8a2035d970a53045df2aa0bd541240ccb2229f4a4d8e708bf7066", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfe5cec66ec1967e8b0a46467994c0097d2b3c48af16e81e955248955448660603e84c76899898fee8f2c4981332bb5501be68ddb52fd173709e8848f3c89f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf15aa5708285eb9a4e42ed22011fdacd84350b49c1e2af0883443203354e5e14a1d90ce5efacbc16f0d01e412828531d8e873bfa8c41fde50ba62471dfd07e1"} build_url:https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011049 build_url: 'https://queue.taskcluster.net/v1/task/LylvI2fTQ2mYP6W4feAOvQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c15da96ebb5905505bb20ca745cf409683178354e1c15ca8e3a8ebaf67d6b938483db7e06be8a2035d970a53045df2aa0bd541240ccb2229f4a4d8e708bf7066", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfe5cec66ec1967e8b0a46467994c0097d2b3c48af16e81e955248955448660603e84c76899898fee8f2c4981332bb5501be68ddb52fd173709e8848f3c89f05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf15aa5708285eb9a4e42ed22011fdacd84350b49c1e2af0883443203354e5e14a1d90ce5efacbc16f0d01e412828531d8e873bfa8c41fde50ba62471dfd07e1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 19:30:20.579634) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:30:20.580123) ========= 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.lypa3I7jUO/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.UxYAsGe5G7/Listeners TMPDIR=/var/folders/5f/d96dwhw95lj7vr7m4fjjlh4w00000w/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.005041 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 19:30:20.630721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 19:30:20.631157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 19:30:20.631596) ========= ========= Total master_lag: 0.18 =========