builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0068 starttime: 1472596982.21 results: success (0) buildid: 20160830142820 builduid: 37cdf555d4314cac82640a5f5a9c5051 revision: fa6f91ffb4965302f316635e91d456c8103e08c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.210094) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.210530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.210852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.233797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.234076) ========= 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.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-30 15:43:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.92M=0.002s 2016-08-30 15:43:02 (5.92 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.402144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.402458) ========= 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.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.020582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:02.450275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 15:43:02.450623) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fa6f91ffb4965302f316635e91d456c8103e08c2 --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 fa6f91ffb4965302f316635e91d456c8103e08c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-30 15:43:02,528 truncating revision to first 12 chars 2016-08-30 15:43:02,528 Setting DEBUG logging. 2016-08-30 15:43:02,528 attempt 1/10 2016-08-30 15:43:02,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fa6f91ffb496?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 15:43:03,590 unpacking tar archive at: mozilla-central-fa6f91ffb496/testing/mozharness/ program finished with exit code 0 elapsedTime=1.315471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 15:43:03.788053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:03.788378) ========= script_repo_revision: fa6f91ffb4965302f316635e91d456c8103e08c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:03.788790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:03.789072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 15:43:03.807548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-08-30 15:43:03.807850) ========= /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.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:03 INFO - MultiFileLogger online at 20160830 15:43:03 in /builds/slave/test 15:43:03 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 15:43:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:03 INFO - {'append_to_log': False, 15:43:03 INFO - 'base_work_dir': '/builds/slave/test', 15:43:03 INFO - 'blob_upload_branch': 'Firefox', 15:43:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:03 INFO - 'branch': 'Firefox', 15:43:03 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:03 INFO - 'config_files': ('talos/mac_config.py',), 15:43:03 INFO - 'default_actions': ('clobber', 15:43:03 INFO - 'read-buildbot-config', 15:43:03 INFO - 'download-and-extract', 15:43:03 INFO - 'populate-webroot', 15:43:03 INFO - 'create-virtualenv', 15:43:03 INFO - 'install', 15:43:03 INFO - 'run-tests'), 15:43:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:03 INFO - 'download_minidump_stackwalk': True, 15:43:03 INFO - 'download_symbols': 'ondemand', 15:43:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:03 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:03 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:03 INFO - 'installer_path': 'installer.exe', 15:43:03 INFO - 'log_level': 'info', 15:43:03 INFO - 'log_name': 'talos', 15:43:03 INFO - 'log_to_console': True, 15:43:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:43:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:43:03 INFO - 'opt_config_files': (), 15:43:03 INFO - 'pip_index': False, 15:43:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:03 INFO - 'cmd': ('bash', 15:43:03 INFO - '-c', 15:43:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:03 INFO - 'enabled': True, 15:43:03 INFO - 'halt_on_failure': False, 15:43:03 INFO - 'name': 'check_screen_resolution'},), 15:43:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:04 INFO - 'cmd': ('bash', 15:43:04 INFO - '-c', 15:43:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:04 INFO - 'enabled': True, 15:43:04 INFO - 'halt_on_failure': False, 15:43:04 INFO - 'name': 'check_screen_resolution'},), 15:43:04 INFO - 'run_cmd_checks_enabled': True, 15:43:04 INFO - 'sps_profile': False, 15:43:04 INFO - 'sps_profile_interval': 0, 15:43:04 INFO - 'suite': 'dromaeojs-e10s', 15:43:04 INFO - 'system_bits': '32', 15:43:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:04 INFO - 'title': 't-yosemite-r7-0068', 15:43:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:04 INFO - 'use_talos_json': True, 15:43:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:04 INFO - 'work_dir': 'build'} 15:43:04 INFO - [mozharness: 2016-08-30 22:43:04.002013Z] Running clobber step. 15:43:04 INFO - Running pre-action listener: _resource_record_pre_action 15:43:04 INFO - Running main action method: clobber 15:43:04 INFO - rmtree: /builds/slave/test/build 15:43:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:04 INFO - Running post-action listener: _resource_record_post_action 15:43:04 INFO - [mozharness: 2016-08-30 22:43:04.890169Z] Finished clobber step (success) 15:43:04 INFO - [mozharness: 2016-08-30 22:43:04.890332Z] Running read-buildbot-config step. 15:43:04 INFO - Running pre-action listener: _resource_record_pre_action 15:43:04 INFO - Running main action method: read_buildbot_config 15:43:04 INFO - Using buildbot properties: 15:43:04 INFO - { 15:43:04 INFO - "project": "", 15:43:04 INFO - "product": "firefox", 15:43:04 INFO - "script_repo_revision": "production", 15:43:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:43:04 INFO - "repository": "", 15:43:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:43:04 INFO - "buildid": "20160830142820", 15:43:04 INFO - "pgo_build": "False", 15:43:04 INFO - "basedir": "/builds/slave/test", 15:43:04 INFO - "buildnumber": 51, 15:43:04 INFO - "slavename": "t-yosemite-r7-0068", 15:43:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 15:43:04 INFO - "platform": "yosemite_r7", 15:43:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:43:04 INFO - "branch": "mozilla-central", 15:43:04 INFO - "repo_path": "mozilla-central", 15:43:04 INFO - "revision": "fa6f91ffb4965302f316635e91d456c8103e08c2", 15:43:04 INFO - "stage_platform": "macosx64", 15:43:04 INFO - "builduid": "37cdf555d4314cac82640a5f5a9c5051", 15:43:04 INFO - "slavebuilddir": "test" 15:43:04 INFO - } 15:43:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:43:04 INFO - Running post-action listener: _resource_record_post_action 15:43:04 INFO - [mozharness: 2016-08-30 22:43:04.893571Z] Finished read-buildbot-config step (success) 15:43:04 INFO - [mozharness: 2016-08-30 22:43:04.893693Z] Running download-and-extract step. 15:43:04 INFO - Running pre-action listener: _resource_record_pre_action 15:43:04 INFO - Running main action method: download_and_extract 15:43:04 INFO - mkdir: /builds/slave/test/build/tests 15:43: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')]} 15:43:04 INFO - trying https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:43:04 INFO - Downloading https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:06 INFO - Downloaded 1199 bytes. 15:43:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:43:06 INFO - Using the following test package requirements: 15:43:06 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:43:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:43:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:43:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'jsshell-mac.zip'], 15:43:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:43:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:43:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:43:06 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:43:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:43:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:43:06 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:43:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:43:06 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')]} 15:43:06 INFO - trying https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:43:06 INFO - Downloading https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:07 INFO - Downloaded 16380082 bytes. 15:43:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 15:43:14 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 15:43: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')]} 15:43:14 INFO - trying https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:43:14 INFO - Downloading https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:15 INFO - Downloaded 16380082 bytes. 15:43: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 15:43: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')]} 15:43:22 INFO - trying https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:43:22 INFO - Downloading https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:23 INFO - Downloaded 14413998 bytes. 15:43:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 15:43:23 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')]} 15:43:23 INFO - trying https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:43:23 INFO - Downloading https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:43:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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 15:43:26 INFO - Downloaded 111578048 bytes. 15:43:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:43:26 INFO - mkdir: /builds/slave/test/properties 15:43:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:26 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:26 INFO - Contents: 15:43:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:43:27 INFO - Running post-action listener: _resource_record_post_action 15:43:27 INFO - Running post-action listener: set_extra_try_arguments 15:43:27 INFO - [mozharness: 2016-08-30 22:43:27.183313Z] Finished download-and-extract step (success) 15:43:27 INFO - [mozharness: 2016-08-30 22:43:27.183452Z] Running populate-webroot step. 15:43:27 INFO - Running pre-action listener: _resource_record_pre_action 15:43:27 INFO - Running main action method: populate_webroot 15:43:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:27 INFO - '--tppagecycles', 15:43:27 INFO - '7'], 15:43:27 INFO - 'tests': ['tsvgm']}}, 15:43:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:43:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['damp', 'tps']}, 15:43:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'tests': ['damp', 'tps']}, 15:43:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['dromaeo_dom']}, 15:43:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['basic_compositor_video']}, 15:43:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:43:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['a11yr', 15:43:27 INFO - 'ts_paint', 15:43:27 INFO - 'tpaint', 15:43:27 INFO - 'sessionrestore', 15:43:27 INFO - 'sessionrestore_no_auto_restore', 15:43:27 INFO - 'tabpaint']}, 15:43:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['tsvgx', 15:43:27 INFO - 'tsvgr_opacity', 15:43:27 INFO - 'tart', 15:43:27 INFO - 'tscrollx', 15:43:27 INFO - 'cart']}, 15:43:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:27 INFO - 'tsvgr_opacity', 15:43:27 INFO - 'tart', 15:43:27 INFO - 'tscrollx', 15:43:27 INFO - 'cart']}, 15:43:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'talos_options': ['--disable-e10s'], 15:43:27 INFO - 'tests': ['tp5o']}, 15:43:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'tests': ['tp5o']}, 15:43:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'talos_options': ['--disable-e10s', 15:43:27 INFO - '--xperf_path', 15:43:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:27 INFO - 'tests': ['tp5n']}, 15:43:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:27 INFO - 'talos_options': ['--xperf_path', 15:43:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:27 INFO - 'tests': ['tp5n']}}, 15:43:27 INFO - 'talos.zip': {'path': '', 15:43:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:27 INFO - Running post-action listener: _resource_record_post_action 15:43:27 INFO - [mozharness: 2016-08-30 22:43:27.202157Z] Finished populate-webroot step (success) 15:43:27 INFO - [mozharness: 2016-08-30 22:43:27.202290Z] Running create-virtualenv step. 15:43:27 INFO - Running pre-action listener: _resource_record_pre_action 15:43:27 INFO - Running main action method: create_virtualenv 15:43:27 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:27 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 15:43:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:43:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:27 INFO - Using real prefix '/tools/python27' 15:43:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:30 INFO - Installing pip.................done. 15:43:30 INFO - Return code: 0 15:43:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:30 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:30 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 15:43:30 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 15:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:30 INFO - 'HOME': '/Users/cltbld', 15:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:30 INFO - 'LOGNAME': 'cltbld', 15:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:30 INFO - 'MOZ_NO_REMOTE': '1', 15:43:30 INFO - 'NO_EM_RESTART': '1', 15:43:30 INFO - 'PAGER': '/bin/cat', 15:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:30 INFO - 'PWD': '/builds/slave/test', 15:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:30 INFO - 'SHELL': '/bin/bash', 15:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:30 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:30 INFO - 'USER': 'cltbld', 15:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:30 INFO - 'XPC_FLAGS': '0x0', 15:43:30 INFO - 'XPC_SERVICE_NAME': '0', 15:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:31 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 15:43:31 INFO - Cleaning up... 15:43:31 INFO - Return code: 0 15:43:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:31 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:31 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 15:43:31 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 15:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:31 INFO - 'HOME': '/Users/cltbld', 15:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:31 INFO - 'LOGNAME': 'cltbld', 15:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:31 INFO - 'MOZ_NO_REMOTE': '1', 15:43:31 INFO - 'NO_EM_RESTART': '1', 15:43:31 INFO - 'PAGER': '/bin/cat', 15:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:31 INFO - 'PWD': '/builds/slave/test', 15:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:31 INFO - 'SHELL': '/bin/bash', 15:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:31 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:31 INFO - 'USER': 'cltbld', 15:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:31 INFO - 'XPC_FLAGS': '0x0', 15:43:31 INFO - 'XPC_SERVICE_NAME': '0', 15:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:31 INFO - Downloading/unpacking psutil>=3.1.1 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:34 INFO - Installing collected packages: psutil 15:43:34 INFO - Running setup.py install for psutil 15:43:34 INFO - building 'psutil._psutil_osx' extension 15:43:34 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 15:43:35 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 15:43:35 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 15:43:35 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 15:43:35 INFO - building 'psutil._psutil_posix' extension 15:43:35 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 15:43:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:43:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:43:35 INFO - ^ 15:43:35 INFO - 1 warning generated. 15:43:35 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 15:43:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:35 INFO - Successfully installed psutil 15:43:35 INFO - Cleaning up... 15:43:35 INFO - Return code: 0 15:43:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:35 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:35 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 15:43:35 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 15:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:35 INFO - 'HOME': '/Users/cltbld', 15:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:35 INFO - 'LOGNAME': 'cltbld', 15:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:35 INFO - 'MOZ_NO_REMOTE': '1', 15:43:35 INFO - 'NO_EM_RESTART': '1', 15:43:35 INFO - 'PAGER': '/bin/cat', 15:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:35 INFO - 'PWD': '/builds/slave/test', 15:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:35 INFO - 'SHELL': '/bin/bash', 15:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:35 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:35 INFO - 'USER': 'cltbld', 15:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:35 INFO - 'XPC_FLAGS': '0x0', 15:43:35 INFO - 'XPC_SERVICE_NAME': '0', 15:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:35 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 15:43:35 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 15:43:35 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 15:43:35 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 15:43:35 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 15:43:35 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 15:43:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:38 INFO - Installing collected packages: mozsystemmonitor 15:43:38 INFO - Running setup.py install for mozsystemmonitor 15:43:38 INFO - Successfully installed mozsystemmonitor 15:43:38 INFO - Cleaning up... 15:43:38 INFO - Return code: 0 15:43:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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', '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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:43: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 jsonschema==2.5.1 15:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:38 INFO - 'HOME': '/Users/cltbld', 15:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:38 INFO - 'LOGNAME': 'cltbld', 15:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:38 INFO - 'MOZ_NO_REMOTE': '1', 15:43:38 INFO - 'NO_EM_RESTART': '1', 15:43:38 INFO - 'PAGER': '/bin/cat', 15:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:38 INFO - 'PWD': '/builds/slave/test', 15:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:38 INFO - 'SHELL': '/bin/bash', 15:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:38 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:38 INFO - 'USER': 'cltbld', 15:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:38 INFO - 'XPC_FLAGS': '0x0', 15:43:38 INFO - 'XPC_SERVICE_NAME': '0', 15:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:39 INFO - Downloading/unpacking jsonschema==2.5.1 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:41 INFO - warning: no files found matching '*.txt' 15:43:41 INFO - no previously-included directories found matching 'build' 15:43:41 INFO - no previously-included directories found matching 'dist' 15:43:41 INFO - no previously-included directories found matching '.git*' 15:43:41 INFO - Installing collected packages: jsonschema, functools32 15:43:41 INFO - Running setup.py install for functools32 15:43:42 INFO - warning: no files found matching '*.txt' 15:43:42 INFO - no previously-included directories found matching 'build' 15:43:42 INFO - no previously-included directories found matching 'dist' 15:43:42 INFO - no previously-included directories found matching '.git*' 15:43:42 INFO - Successfully installed jsonschema functools32 15:43:42 INFO - Cleaning up... 15:43:42 INFO - Return code: 0 15:43:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:42 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 15:43:42 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 15:43:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:42 INFO - 'HOME': '/Users/cltbld', 15:43:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:42 INFO - 'LOGNAME': 'cltbld', 15:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:42 INFO - 'MOZ_NO_REMOTE': '1', 15:43:42 INFO - 'NO_EM_RESTART': '1', 15:43:42 INFO - 'PAGER': '/bin/cat', 15:43:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:42 INFO - 'PWD': '/builds/slave/test', 15:43:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:42 INFO - 'SHELL': '/bin/bash', 15:43:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:42 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:42 INFO - 'USER': 'cltbld', 15:43:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:42 INFO - 'XPC_FLAGS': '0x0', 15:43:42 INFO - 'XPC_SERVICE_NAME': '0', 15:43:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:43:42 INFO - Cleaning up... 15:43:42 INFO - Return code: 0 15:43:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:42 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:42 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 15:43:42 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 15:43:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:42 INFO - 'HOME': '/Users/cltbld', 15:43:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:42 INFO - 'LOGNAME': 'cltbld', 15:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:42 INFO - 'MOZ_NO_REMOTE': '1', 15:43:42 INFO - 'NO_EM_RESTART': '1', 15:43:42 INFO - 'PAGER': '/bin/cat', 15:43:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:42 INFO - 'PWD': '/builds/slave/test', 15:43:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:42 INFO - 'SHELL': '/bin/bash', 15:43:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:42 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:42 INFO - 'USER': 'cltbld', 15:43:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:42 INFO - 'XPC_FLAGS': '0x0', 15:43:42 INFO - 'XPC_SERVICE_NAME': '0', 15:43:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:42 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 15:43:45 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:46 INFO - Downloading docopt-0.6.1.tar.gz 15:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:46 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:46 INFO - Running setup.py install for blobuploader 15:43:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:46 INFO - Running setup.py install for requests 15:43:46 INFO - Running setup.py install for docopt 15:43:47 INFO - Successfully installed blobuploader requests docopt 15:43:47 INFO - Cleaning up... 15:43:47 INFO - Return code: 0 15:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:47 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')]} 15:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:47 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')]} 15:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:47 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:47 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 15:43:47 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 15:43:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:47 INFO - 'HOME': '/Users/cltbld', 15:43:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:47 INFO - 'LOGNAME': 'cltbld', 15:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:47 INFO - 'MOZ_NO_REMOTE': '1', 15:43:47 INFO - 'NO_EM_RESTART': '1', 15:43:47 INFO - 'PAGER': '/bin/cat', 15:43:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:47 INFO - 'PWD': '/builds/slave/test', 15:43:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:47 INFO - 'SHELL': '/bin/bash', 15:43:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:47 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:47 INFO - 'USER': 'cltbld', 15:43:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:47 INFO - 'XPC_FLAGS': '0x0', 15:43:47 INFO - 'XPC_SERVICE_NAME': '0', 15:43:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:47 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-LKXCI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:47 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-0AT7li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:47 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-AZikmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:47 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-5q9srb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:47 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kF58BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-LvAwPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-lWTs9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-grGPaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-_7L7IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Mt3qxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Ipkrz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-zdnIoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-fUxo6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-nWsNXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:48 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-9NSUnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-N0KhG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:49 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-pIhMRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:49 INFO - Running setup.py install for manifestparser 15:43:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:49 INFO - Running setup.py install for mozcrash 15:43:49 INFO - Running setup.py install for mozdebug 15:43:49 INFO - Running setup.py install for mozdevice 15:43:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:49 INFO - Running setup.py install for mozfile 15:43:50 INFO - Running setup.py install for mozhttpd 15:43:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Running setup.py install for mozinfo 15:43:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Running setup.py install for mozInstall 15:43:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Running setup.py install for mozleak 15:43:50 INFO - Running setup.py install for mozlog 15:43:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Running setup.py install for moznetwork 15:43:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:50 INFO - Running setup.py install for mozprocess 15:43:51 INFO - Running setup.py install for mozprofile 15:43:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:51 INFO - Running setup.py install for mozrunner 15:43:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:51 INFO - Running setup.py install for mozscreenshot 15:43:51 INFO - Running setup.py install for moztest 15:43:51 INFO - Running setup.py install for mozversion 15:43:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:51 INFO - Cleaning up... 15:43:51 INFO - Return code: 0 15:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:51 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:51 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 15:43:51 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 15:43:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:51 INFO - 'HOME': '/Users/cltbld', 15:43:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:51 INFO - 'LOGNAME': 'cltbld', 15:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:51 INFO - 'MOZ_NO_REMOTE': '1', 15:43:51 INFO - 'NO_EM_RESTART': '1', 15:43:51 INFO - 'PAGER': '/bin/cat', 15:43:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:51 INFO - 'PWD': '/builds/slave/test', 15:43:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:51 INFO - 'SHELL': '/bin/bash', 15:43:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:51 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:51 INFO - 'USER': 'cltbld', 15:43:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:51 INFO - 'XPC_FLAGS': '0x0', 15:43:51 INFO - 'XPC_SERVICE_NAME': '0', 15:43:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-f5j0Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-C4diLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-pbZrws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-0mEXcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kHIqza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-HHqB6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-syhfAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-BOEpdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:52 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)) 15:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:52 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Wrfcb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-5JftJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-vfyY3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-wJhrLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-tFLu6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-SZ2fjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-MWF4xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-AsEvwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:53 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)) 15:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:53 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-KVLcqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:53 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)) 15:43:53 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)) 15:43:53 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)) 15:43:53 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)) 15:43:53 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)) 15:43:53 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)) 15:43:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:56 INFO - Downloading blessings-1.6.tar.gz 15:43:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:56 INFO - Installing collected packages: blessings 15:43:56 INFO - Running setup.py install for blessings 15:43:56 INFO - Successfully installed blessings 15:43:56 INFO - Cleaning up... 15:43:56 INFO - Return code: 0 15:43:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:56 INFO - Reading from file tmpfile_stdout 15:43:56 INFO - Current package versions: 15:43:56 INFO - blessings == 1.6 15:43:56 INFO - blobuploader == 1.2.4 15:43:56 INFO - docopt == 0.6.1 15:43:56 INFO - functools32 == 3.2.3-2 15:43:56 INFO - jsonschema == 2.5.1 15:43:56 INFO - manifestparser == 1.1 15:43:56 INFO - mozInstall == 1.12 15:43:56 INFO - mozcrash == 0.17 15:43:56 INFO - mozdebug == 0.1 15:43:56 INFO - mozdevice == 0.48 15:43:56 INFO - mozfile == 1.2 15:43:56 INFO - mozhttpd == 0.7 15:43:56 INFO - mozinfo == 0.9 15:43:56 INFO - mozleak == 0.1 15:43:56 INFO - mozlog == 3.3 15:43:56 INFO - moznetwork == 0.27 15:43:56 INFO - mozprocess == 0.23 15:43:56 INFO - mozprofile == 0.28 15:43:56 INFO - mozrunner == 6.12 15:43:56 INFO - mozscreenshot == 0.1 15:43:56 INFO - mozsystemmonitor == 0.3 15:43:56 INFO - moztest == 0.7 15:43:56 INFO - mozversion == 1.4 15:43:56 INFO - psutil == 3.1.1 15:43:56 INFO - requests == 1.2.3 15:43:56 INFO - wsgiref == 0.1.2 15:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:56 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:56 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 15:43:56 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 15:43:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:56 INFO - 'HOME': '/Users/cltbld', 15:43:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:56 INFO - 'LOGNAME': 'cltbld', 15:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:56 INFO - 'MOZ_NO_REMOTE': '1', 15:43:56 INFO - 'NO_EM_RESTART': '1', 15:43:56 INFO - 'PAGER': '/bin/cat', 15:43:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:56 INFO - 'PWD': '/builds/slave/test', 15:43:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:56 INFO - 'SHELL': '/bin/bash', 15:43:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:56 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:56 INFO - 'USER': 'cltbld', 15:43:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:56 INFO - 'XPC_FLAGS': '0x0', 15:43:57 INFO - 'XPC_SERVICE_NAME': '0', 15:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 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)) 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:57 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')]} 15:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 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')]} 15:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:57 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 0x10299da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3a24b2100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, '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.ECYWyin7wX/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.U38YMVj9Ce/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 15:43:57 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 15:43:57 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 15:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:57 INFO - 'HOME': '/Users/cltbld', 15:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:57 INFO - 'LOGNAME': 'cltbld', 15:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:57 INFO - 'MOZ_NO_REMOTE': '1', 15:43:57 INFO - 'NO_EM_RESTART': '1', 15:43:57 INFO - 'PAGER': '/bin/cat', 15:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:57 INFO - 'PWD': '/builds/slave/test', 15:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:57 INFO - 'SHELL': '/bin/bash', 15:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:43:57 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:57 INFO - 'USER': 'cltbld', 15:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:57 INFO - 'XPC_FLAGS': '0x0', 15:43:57 INFO - 'XPC_SERVICE_NAME': '0', 15:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:57 INFO - Cleaning up... 15:43:57 INFO - Return code: 0 15:43:57 INFO - Running post-action listener: _resource_record_post_action 15:43:57 INFO - Running post-action listener: _start_resource_monitoring 15:43:57 INFO - Starting resource monitoring. 15:43:57 INFO - [mozharness: 2016-08-30 22:43:57.554066Z] Finished create-virtualenv step (success) 15:43:57 INFO - [mozharness: 2016-08-30 22:43:57.555056Z] Running install step. 15:43:57 INFO - Running pre-action listener: _resource_record_pre_action 15:43:57 INFO - Running main action method: install 15:43:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:57 INFO - Reading from file tmpfile_stdout 15:43:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:57 INFO - Reading from file tmpfile_stdout 15:43:57 INFO - Output received: 15:43:57 INFO - Usage: mozinstall [options] installer 15:43:57 INFO - Options: 15:43:57 INFO - -h, --help show this help message and exit 15:43:57 INFO - -d DEST, --destination=DEST 15:43:57 INFO - Directory to install application into. [default: 15:43:57 INFO - "/builds/slave/test"] 15:43:57 INFO - --app=APP Application being installed. [default: firefox] 15:43:57 INFO - mkdir: /builds/slave/test/build/application 15:43:57 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'] 15:43:57 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 15:44:32 INFO - Reading from file tmpfile_stdout 15:44:32 INFO - Output received: 15:44:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:44:32 INFO - Running post-action listener: _resource_record_post_action 15:44:32 INFO - [mozharness: 2016-08-30 22:44:32.191089Z] Finished install step (success) 15:44:32 INFO - [mozharness: 2016-08-30 22:44:32.191281Z] Running run-tests step. 15:44:32 INFO - Running pre-action listener: _resource_record_pre_action 15:44:32 INFO - Running main action method: run_tests 15:44:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:44:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:44:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:44:32 INFO - 2016-08-30 15:44:32.206 screenresolution[1940:12052] starting screenresolution argv=screenresolution get 15:44:32 INFO - 2016-08-30 15:44:32.208 screenresolution[1940:12052] Display 0: 1600x1200x32@60 15:44:32 INFO - 2016-08-30 15:44:32.214 screenresolution[1941:12054] starting screenresolution argv=screenresolution list 15:44:32 INFO - Available Modes on Display 0 15:44:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:44:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:44:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:44:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:44:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:44:32 INFO - Intel Iris: 15:44:32 INFO - Chipset Model: Intel Iris 15:44:32 INFO - Type: GPU 15:44:32 INFO - Bus: Built-In 15:44:32 INFO - VRAM (Dynamic, Max): 1536 MB 15:44:32 INFO - Vendor: Intel (0x8086) 15:44:32 INFO - Device ID: 0x0a2e 15:44:32 INFO - Revision ID: 0x0009 15:44:32 INFO - Displays: 15:44:32 INFO - Display: 15:44:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:44:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:44:32 INFO - Display Serial Number: 1600x1200 60 15:44:32 INFO - Main Display: Yes 15:44:32 INFO - Mirror: Off 15:44:32 INFO - Online: Yes 15:44:32 INFO - Rotation: Supported 15:44:32 INFO - Return code: 0 15:44:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:32 INFO - Python 2.7.3 15:44:32 INFO - Return code: 0 15:44:32 INFO - grabbing minidump binary from tooltool 15:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102901d30>, '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 0x102666db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1028f9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:44:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:44:32 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 15:44:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:32 INFO - Return code: 0 15:44:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:44:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:32 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/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 15:44:32 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/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0068 --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 15:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ECYWyin7wX/Render', 15:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:32 INFO - 'HOME': '/Users/cltbld', 15:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:32 INFO - 'LOGNAME': 'cltbld', 15:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:32 INFO - 'MOZ_NO_REMOTE': '1', 15:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:32 INFO - 'NO_EM_RESTART': '1', 15:44:32 INFO - 'PAGER': '/bin/cat', 15:44:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:32 INFO - 'PWD': '/builds/slave/test', 15:44:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:32 INFO - 'SHELL': '/bin/bash', 15:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U38YMVj9Ce/Listeners', 15:44:32 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 15:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:32 INFO - 'USER': 'cltbld', 15:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:32 INFO - 'XPC_FLAGS': '0x0', 15:44:32 INFO - 'XPC_SERVICE_NAME': '0', 15:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:32 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/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 15:44:32 INFO - mozversion application_buildid: 20160830142820 15:44:32 INFO - mozversion application_changeset: fa6f91ffb4965302f316635e91d456c8103e08c2 15:44:32 INFO - mozversion application_display_name: Nightly 15:44:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:32 INFO - mozversion application_name: Firefox 15:44:32 INFO - mozversion application_remotingname: firefox 15:44:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:44:32 INFO - mozversion application_vendor: Mozilla 15:44:32 INFO - mozversion application_version: 51.0a1 15:44:32 INFO - mozversion platform_buildid: 20160830142820 15:44:32 INFO - mozversion platform_changeset: fa6f91ffb4965302f316635e91d456c8103e08c2 15:44:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:44:32 INFO - mozversion platform_version: 51.0a1 15:44:32 INFO - using testdate: 1472597072 15:44:32 INFO - actual date: 1472597072 15:44:32 INFO - starting webserver on 'localhost:51831' 15:44:32 INFO - SUITE-START | Running 2 tests 15:44:32 INFO - TEST-START | dromaeo_css 15:44:32 INFO - operating with platform_type : mac_ 15:44:32 INFO - Initialising browser for dromaeo_css test... 15:44:32 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpE8qcnG/profile http://localhost:51831/getInfo.html) 15:44:35 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 15:44:35 INFO - PROCESS | 1951 | colorDepth:24 15:44:35 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 15:44:35 INFO - PROCESS | 1951 | __metrics 15:44:35 ERROR - PROCESS | 1951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 15:44:36 INFO - TEST-INFO | 1951: exit 0 15:44:36 INFO - Browser initialized. 15:44:36 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:36 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpE8qcnG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:48 INFO - PROCESS | 1954 | RSS: Main: 244142080 15:44:48 INFO - PROCESS | 1954 | 15:45:38 INFO - PROCESS | 1954 | 1472597138107 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] 15:47:49 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51831/tests/dromaeo/cssquery-ext.html) 15:47:51 INFO - PROCESS | 1954 | RSS: Main: 256536576 15:47:51 INFO - PROCESS | 1954 | 15:50:53 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-ext.html (next: http://localhost:51831/tests/dromaeo/cssquery-jquery.html) 15:50:54 INFO - PROCESS | 1954 | RSS: Main: 266473472 15:50:54 INFO - PROCESS | 1954 | 15:53:56 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51831/tests/dromaeo/cssquery-mootools.html) 15:53:57 INFO - PROCESS | 1954 | RSS: Main: 269111296 15:53:57 INFO - PROCESS | 1954 | 15:56:58 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51831/tests/dromaeo/cssquery-prototype.html) 15:56:59 INFO - PROCESS | 1954 | RSS: Main: 268570624 15:56:59 INFO - PROCESS | 1954 | 16:00:02 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51831/tests/dromaeo/cssquery-yui.html) 16:00:03 INFO - PROCESS | 1954 | RSS: Main: 273735680 16:00:03 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51831/tests/dromaeo/cssquery-yui.html (next: http://localhost:51831/tests/dromaeo/cssquery-dojo.html) 16:03:06 INFO - PROCESS | 1954 | RSS: Main: 276664320 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | __start_tp_report 16:03:06 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 16:03:06 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 16:03:06 INFO - PROCESS | 1954 | |i|pagename|runs| 16:03:06 INFO - PROCESS | 1954 | |0;dojo.html;2713.986430067849;2860.2706309890973;3218.4045951498965;3455.585329760429;3496.388132076886;5728.742206600703;5766.538676905842;5870.236869207002;5874.618149820259;5922.407759224076;4990.500949905017;5849.590528662995;5886.470217680408;5950.375210602879;6038.818835434933;5283.762230699618;5399.919001214985;5407.918881216785;5445;5453.15476101205;5236.162214045753;5287.471252874701;5378.489043540857;5426.728663566825;5468.808591699291;5327.121025030885;5332.120200166968;5350.197470379435;5350.491703288181;5364.168553874156;5344.118220493614;5348.903474787659;5365.061114304981;5376.78492860289;5426.864328391783;5211.557017653504;5284.920726189111;5325.573954083664;5355.758990845421;5363.6245462817615;5828.41715828418;5854.590178687494;5894.410558944114;5906.527477801766;5911.704414779287;6237.1891654084675;6299.9370006299805;6311.715972781236;6314.02132669437;6329.36706329368;6260.78087266948;6270.435660790551;6272.40412160844;6398.744050237985;6420.711068001951;6031.698415079272;6038.849028774316;6039.335673075958;6052;6070.484008859252;6450.451711604473;6473.77341793035;6500.577462464925;6501.0573466847045;6518.217813862367;6138.969305153446;6216.347283535254;6235;6267.0286105653695;6296.307406185316;6351.364863513704;6355.332690067568;6364.554481186365;6367;6398.71205795731;6263.6241825490615;6285.685715714196;6302.810915672446;6308.432241098231;6309.08518264849;6184.381561843779;6188.319284878659;6193.566450348432;6235.812925612148;6256.061590761422;5008.57427118699;5036.118679231193;5038;5043.52086551777;5065.645404821627;4520.2315606347;4528.682992190581;4530.909381812346;4550.658700597469;4555.9772201138785;5919.970400148058;5933.732982015733;6049.153118563405;6072.180255665428;6117.418845209698;6388.297287298394;6388.329225431356;6388.977763557901;6390.105385246069;6393.200849893763;6094.360092190344;6104.725287362079;6107.908381374283;6125.050617154348;6129.295131059896;5463.508284254436;5489.972550137224;5509.47659972302;5522.088855338904;5553.6390134641115;6501;6510.381513756186;6511.772087976898;6524.151860258231;6527.15147030883;6299.716512756845;6320.367963203643;6335.239771227482;6359.777407790705;6365.8726825464155;6319.715612797343;6443.387878151568;6459;6471.417572418317;6526.151600291932;4596.402467679314;5214.869628259172;5581.6371935824045;6198.473129784019;6324.462420694293;6278.6860656966055;6308.116863639002;6344.429001389897;6346.460550853045;6360.300366959723;6108.402780883668;6187.566870319034;6222.439980401786;6236.126942228001;6269.623822570478;5241.741981924387;6287.497000240061;6291.150694656163;6297.559170857996;6302.180716506825;5324.881774827175;5833.9790536656765;6122.326544080237;6171.259448865985;6191.349908259568;5138.563222126161;5974.910376344272;6141.416565426277;6143.542582966849;6251.124842521959;6142.815715528542;6156.29202641702;6184.690765461799;6186.350433204449;6221.751129954751 16:03:06 INFO - PROCESS | 1954 | |1;ext.html;420.7391417321261;453.41962288271003;547.7891011960396;563.6280055163592;604.7036951893573;37165.814170929145;39700.60299397005;39762.2047559049;39783.40324895129;39894.401583976265;40240.79277621669;40877;40916.38625420621;41025.58974410255;41101.58898411015;9531.666391676292;9775.56009979549;9781.945791383818;9784.902150978505;9808.852867206997;9636.662716804913;9636.759081022961;9697.563609637584;9759.170470510015;9784.55969481375;9751.75620609487;9757.609695612202;9795;9813.214942804594;9819.754506137333;9628.47043412612;9671.274654400913;9705.75735606612;9753.122219000254;9759.512024398751;9601.087896649877;9711.223102151811;9719.368241064309;9726.465044422624;9733.2213422926;26907.86546067277;35526.822365888;36166.819165904264;38635.806820965714;38979;3308.9007329780147;3438.707709844666;3711.66595006448;3761.492198553215;3973.086190176247;24986.750132498622;30502.542461862868;31036.603352849175;31500.684993150004;31710;3133.9216519586967;3245.2535916739284;3268.3299923515624;3319.037479131049;3348.5479460272795;490618;493908;502609;503061;504972.47513762565;32114.678853211637;32987.6804927805;55637.721811390686;55720.72139639276;55899.161512577346;33305.33389332248;33328.1667958303;33383.16542086467;33774;33781.83109084488;14292;14355.928220359041;14458.710825783426;14474.348654310581;14518.346674399678;11915.821262681067;12305.32320722351;12314.50741970329;12433.75132497345;12447.626571202698;7501.774946751606;7523.8495230095095;7578.772636820904;7586.468947173756;7600.1639819619795;3140.262038420969;3171;3183.570218020584;3189.3142974260645;3195.2999715240585;839.588601585231;1021.1422405179685;1028.753099256188;1048.3488505603552;1072.4798472740715;28410.00564980216;29910.850445748067;30093.548596771067;30179.849100754356;30573.69426305753;1030.9896901030893;1057.6404022632341;1060.4432672846817;1070.2775626452114;1075.0700643942932;14000.719985600232;15347.462838800811;15380.393839460814;15478.226088695521;15831.604209894846;604891;684950;690698;694815;695474.0452595409;56618.150727739114;56987.430125699044;57005;57080.42919570751;57091.42908570861;1237.4864431261105;1243.5088140184575;1251.7308778612642;1331.0815537279245;1391.4712409284407;27812.58281125744;29272.853635731684;29399.11802645924;30029;30068.398632027674;48146.55560333196;48788;48837.51162488329;48852.755736221094;48921;635615;637279.6272037405;638327.8083609738;638353;639576;20115.899420502803;25999;26046.479070418107;26058.218253452425;26205.606915896657;46243.76878115588;46809.765951170026;47275;47430.52569474261;47477.52522474731;38860.80569597247;38920;39388.803055984536;40106.598934011454;40244.59755402408;38411.847644570706;38616.61383386242;38798.03004924899;39906.40140397838;40091.1981760369;32304.869329573354;37442.62557374391;37953.62046379501;38141.618583813804;38235.80882095572;33400.83299583486;33684.98945031653;34410.655893440744;34573.48139777855;34638;25612.9754809813;25622.359441013377;25725.614115788652;25853.482930340913;26147.477050458503 16:03:06 INFO - PROCESS | 1954 | |2;jquery.html;372.31865685795;377.9924401511969;381.458329172575;387.3647218561561;404.91699201663664;15472.765130621017;20417.387478375655;21069.05189266483;21764.89117554414;21939.561208775816;20131.29540466084;20525.4868628284;20723.585528289426;20782.896085519587;21220.57558848822;5835.270591176103;6023.036314189731;6137.079438084301;6445.097686323918;6490.707918143695;5893.174955506232;5934.465898069195;6227.097070924713;6382.170317858672;6552.410283074522;5076.466970968032;5901.380355062721;5910.970445147768;5930.792422265222;5937.346891841894;5598.300212473441;5907.6750778707155;5915.438033386843;5930;5939.762409503614;5786.07422812348;5793.333766616809;5802.65184088956;5802.767889284423;5855.473007429309;9355.672551460666;11373.805750396172;13155.86844131556;21948.34154975353;23833.88083059591;1970.9704354434696;2111.4088055344528;2111.5460176062065;2115.5719889074967;2367.9289621311386;8806.295496360275;9731.270154738422;9737.56180971858;9754;10097.444640544767;1415.9575212743634;1797.757302764123;1819.0813639112296;1856.7400563921062;1871.0644677661169;105512.47243763732;110516;110637.9999999992;110781;112202.43898780453;10887.564497420173;10932.945335273273;11148.665540033811;11250.324980501196;11275.293929457035;13736.519221827188;13851.238181900093;13894.652633684036;13902.957278204176;13907.652308692364;8225.465344752572;8382.49705017701;8392.622331995075;8510.74467765968;8546;7694.146710762207;8429.199226073513;8449.197326253996;8605.182507661762;8625.827483450421;3780.8865734028022;3884.7086468514976;3969.0077480629843;4013.2374848779223;4420.160169567836;1860.8325250727228;1942.4366933589383;1945.6303302372503;1967.5572996075769;1968.9606207875763;765.1239330966013;799.4324029938692;923.9445633262026;952.8808898887639;987.2398253345028;18249;19376.321828735927;19557.31549395764;20840.895795521228;20861;898.6180873128894;923.7136487688838;936.0779632062413;957.2581249531529;980.5783513089298;10351.275410721177;10394.376337419779;10795.676129716121;10800.135989120852;10834.187435942336;496774;595386;605217.9478205162;617306;618069;112322.39808824801;114304;116349.6730065394;127548.72451275554;136524.31737841247;953.6900507335005;957.7557722780647;986.7878406142714;988.663854289545;1022.0750221049962;16670.16649167561;17736.11319434049;18470.538236544195;18513.629727405645;18742.188671699354;46331.53668463272;54501.72749136229;56791;59517.70241148766;59961.70019149876;82262.88685565579;83839.5808020956;85966.30721065497;86686.09912553824;87074.56462717646;6322.462590679844;7892.816077588408;8041.587523742971;8162.83674326522;8175.386845986456;9185.219256363016;9490.861096668445;10830.67507974762;11474.311541307548;12627.30549819732;9242.798436203251;9704.883938346899;9780.608775648894;10468.895311046792;11213.271137376045;8576.828463430571;10995.395253260827;11126.944365278121;11189.440527973731;11559.133065019989;11136.276142050741;11254.94372528132;11413;11539.88460115388;11554.42227888619;8031.959840200761;8066.516009039477;8107.351411887153;8125.431219814556;8137.3318469712385;10816;10914.399708016135;11081.556737730723;11085.05777008931;11264.211505194886 16:03:06 INFO - PROCESS | 1954 | |3;mootools.html;1371.2800779590714;1455.5560554031024;1643.7753873364345;1793.6771381151405;1836.1278392763431;7013.333733295335;7824.530528168314;8534.402591818574;8867.201951824334;8874.733757987255;8503.319734421248;8731.214190722834;8731.432456890314;8751.431156974792;8763;1957.765068191819;2358.492924021335;2363.0665886974634;2364.6334818103223;2370.229675355508;2338;2354.493783836475;2381.30942026812;2386.331827088418;2392.437777122375;1946.9902650486729;2344.9062037518565;2360.409897525619;2378.0725517048363;2380.8571485710913;2138.5295235048343;2169.3708824440973;2329.0683726509533;2340.1926335414255;2350.635651474024;2090.3937858021154;2188.0153930731076;2333.953320933572;2340.028888011473;2348.1664009276633;8706.695265665672;8745.431546949492;8751.168638979287;8761.299096072298;8766.211041006276;5180.6373553851245;5290.39160496544;5295.549878260353;5336.626436149471;5365.436629153922;3468.757186996911;3531.2054787672823;3600.6219346968714;3641.745077844552;3658.0306218852024;1096.819024860897;1114.832775083736;1741.5646088477881;1804.6841802684478;1855.6938105212623;9356.953215233949;11406.42967851604;11449.656510304705;11470.942645286721;11472.770544589144;3860.6718428933295;4334.761588112621;4578.931316030262;4637.814487420533;4670.299455081765;8824.558772061371;8899;8935.195832375117;8947.239484643747;8948;5189.818356357509;5235.973820130951;5237.921431178535;5265.815696450606;5273.868153296122;4432.82268709248;4789.521047895182;4917.065757506062;4959;4964.404271487372;3742.251549690073;3810.8285127169343;3841.7887016213817;3876.534815822063;3913.745606535566;1163.697438665936;1170.2744298534792;1174.8472698549133;1176.335370515656;1182.3497076607832;832.7418500264937;839.7984483723984;892.8616064510011;913.9314551408671;928.874601928731;5790.739416726257;5962.552808539377;6016.278046634345;6107.053406721965;6208.844778880564;792;901.3510272603714;913.2055112052424;915.663131827526;987.3631507677651;3940.6059394060367;3974;4037.7981100944835;4132.504099508018;4168.791560421967;7934.920650793418;10679.412632305297;10714.41070741101;10725.463726813628;10779;10598.841017384746;10621.468926553642;10625;10685.893141068645;10767.730806729895;8029.799255018671;8162.347012239125;8163.183681631789;8174.9182508175345;8177.223163799429;5596.832095037155;5731.283589551306;5876.236089308533;5887.470127688529;5946.940530594812;8581.01318348398;9861.457619830979;9926.751831204278;9974.251931105051;9984.500774961078;8170.7957301067945;9249.815003700023;10076;10177.440240786531;10197.54111064989;5913.172155898264;6462;6925.411340036153;6946.409555187865;7052.2242553318065;8211.425200236165;8265.46274492156;8274.007119145741;8298.460600060977;8305.916940830515;7256.2743725627015;7409.407247420301;7486.4759466836795;7494.662740176596;7560.508566943131;7178.389836863925;7285.854282914206;7342.19235884063;7363.926360736324;7384.966104745233;6902.378785909293;6939.271376505394;6993.580385176906;7001.404880585003;7020.508564400648;4772.928406073842;4810.759462026955;4844.927326090182;4862.197737373293;4905.264210368473;5022.924656130234;5034.521720436553;5076.746162691777;5142.151544995184;5168.922466162935 16:03:06 INFO - PROCESS | 1954 | |4;prototype.html;232.55697895509056;303.7994923350589;307.3146882452132;314.6758838396451;318.20766291933063;4922.704637721735;5387.299651045359;5520.537057679718;5689.63017403869;5758.596898217126;4723.433188017434;4910.312556242129;4953.504649535044;5585.888282234353;5628.32460104788;3508.71930245581;4111.568285330042;4329.437173167499;4339.349097635356;4379.408779814716;3929.5481019682675;4228.471441069866;4341.739495630272;4345.348197770344;4366.8253269869165;4168.7290326128705;4169.666426685873;4174.102567947891;4176.310908700061;4202.726822756511;3491.7381196410115;4144.91710165795;4188.4136220929095;4210.010647497836;4211.473565804275;2810.6789808789836;3171.668823414788;3319.618243901958;3628.4738712886747;3642.763220390666;4821;5027;5322.988632159877;5330.604298230264;5365.222042803811;4013.5350597031875;4336.111097225062;4530;4788.712677239377;4875.196177414379;5946.643201407886;5957.821265362046;5958;5963.403659634046;5982.401759824026;3282.8030318180986;3681.6134305897763;3886.514185726784;3923.3330333843314;3943.0339566806315;4669.6184945677605;5783.971080144573;6005.978983572803;6142.590862071548;6166.938330616681;4017.31705610047;4019.256437559061;4021.939670904939;4032.3749818778138;4037.9810094952522;3733.7946412947003;3906.43356713275;4032.838686452509;4065.617689985419;4076.510818701775;4694.647901407408;4761.785719642625;4775.235962246094;4784.30627559002;4804.8798780030775;4427.078128435217;4952.439981405845;5667.659940403589;5932.822015339547;5960.76156953717;1158.6408213453687;1298.7142828577698;1301.9283939383236;1376.0254035459147;1382.6612479942478;751.3988808952815;784.3920961254959;861.4443683823898;895.583553647557;925.6482536636036;4772.76136193189;5341.406390504163;5495.505404513613;5580.972095139579;5586.636868603528;5319.069162896478;5773.422657734277;6032.879342413127;6034;6064.272287325461;4831.7437466259025;5206.427292997767;5469.917951230735;5550.611457198038;5556.6943818089585;2360.704911886014;2702.3919618086165;2713.430179662293;2726.5364887969095;2726.859415358934;4646.605038571759;4947.851564453073;4958.8181200271765;5204.661696989683;5317.016351974897;4221.6200541951375;5056.078690097739;5216.765245563959;5299.3895311079605;5308.893822123536;4628.282616194495;4630.560096790799;4642.121884431674;4697.8725105973635;5232.424433312332;4036.7174297798874;4563.589276965089;4980.5019498049905;5109.799197188732;5169.379674439091;3873.7869417182324;4177.976395783053;4592.862214133581;5068.6451948363265;5079.822206222764;4469.776511174363;4593.438231001475;4675.76621168947;4909.3372394727685;5064.569511591409;3493.934350023267;3519.6832285094465;3539.3275277697153;3541.327147841902;3574.7318951078255;4374.58441448062;4786.569208771088;5003.54968052877;5084.186530155157;5124.538791508782;4539.415190657526;4754.4770075291;4889.315495830658;4986.526280003394;4989.906258119844;4581.702189357681;4888.7311197884455;4974.9751251243515;4982.676126051795;5003.299538064601;4172.039141603442;4184.886632250694;4594.839180628662;4869.31829543857;4906.239532872411;3987.6809855212095;4695.835645752519;4961.578265847444;4984.4517103117905;5000.674821172465;4209.221913537173;4283.464566929134;4709.7174169549935;4880.877978050577;4926.827561035347 16:03:06 INFO - PROCESS | 1954 | |5;yui.html;679.9014142949269;707.8619669164511;711.4450728431823;762.3177256355561;797.4856217739556;14898.329575169117;15811.367545298202;15835.84164158358;15843.762343564827;15876.603084922883;14308.785368219485;14529.200893950829;14532.782008269884;14533;14536.709265814703;660.1253339325389;813.9430239883196;825.4345773145385;837.9706710265142;853.7694822397949;693.2443636436284;850.2432834777022;851.6337974670889;853.8292341531718;855.0936007831688;874.9194744490549;888.5779254853925;904.8054668246326;908.0193391137556;909.3679892474732;890.3678388344283;898.1647068226547;898.1736802142045;900.2348004196446;900.5272232078212;638.4732595608641;663.6947004377992;671.4259308291438;673.2392396591869;673.249327000396;14597.6350591235;14770.852291477055;14790.18653974031;14797.92601036988;14817.333220005017;14056.71886562263;14072.648183795385;14253.50112746049;14276.286185690778;14407.711845763131;9898.90101098987;11819.881801181964;11961.700957476045;12188.939055304756;12405.3011373858;3739.906502337436;3787.3372159872188;3840.807959602009;3939.980300098481;3943.842246310144;114397.42801286024;114947.2757908632;115833;116263;121909;10337.623762376237;10445.895541044492;11055;11058;11589.710257243467;23239.186628467924;23274;23275.88362058179;23305.53388932212;23356.532869342856;6538.545404087443;7636.847263054708;7752.341051010727;7909.920900791033;8064.798380040546;4356.629686476622;4425.557444255549;4459.152760975404;4502.459704835441;4610.124076425468;3563.4120370138635;3651.2514934438377;3664.908377290589;3665.4318580619515;3806.619338066171;705.6401235369896;720.4740539406263;728.9635518224173;730.831908661011;739.1979702023365;589.4665327878276;625.5308518611042;652.8596351784295;653.3792896748108;664.6278084272823;8738.519381433955;9399.624015039459;9440.763980900532;9495.620175193053;9741.902580974242;617.2346290599714;655.9376859198369;664.3920812456548;667.3226674924955;680.9003459413012;4396.714213576107;4581.175388430048;4598.494165641777;4601.907961840811;4607.631389488833;155620;161729;163012;171456;176184;129155.70844291625;141121;142796.28601856926;146940.26529867284;147162.26418867838;116756;122816.38591806983;124132.37933810454;125040;126900;6570.277269500256;7173.780457322164;8243.804648326079;8858.114188581349;8923.41997770143;60574;63726.044109339324;63940.68029659822;64435.71128577496;65580;82602;102309.48845255726;105179;106170.46914765377;107402.46298768456;11680.130289905017;11822.822657660314;11823.881761182278;12012.099092567918;12441.751164976831;13151.473941042252;13227.735445290848;13405.597832065054;13407.396667149807;13578.185308881499;12004.459799308877;12219.816702749644;12334.938325308316;12602.046682764187;12769;11857.762844743229;11971.401429928643;12341.197822141532;12611.74776504483;12698.619041428772;11803;12286.201396909173;12467.5012999479;12493.875061249271;12569.811452828399;9413.82327209099;9775.315727898978;9914.950425247827;9979.750506237111;9997.850032249376;8089.555074470725;8317.916820831715;9904.25718071133;9939.850902236616;9965.053319934595 16:03:06 INFO - PROCESS | 1954 | __end_tp_report 16:03:06 INFO - PROCESS | 1954 | __start_cc_report 16:03:06 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,379 16:03:06 INFO - PROCESS | 1954 | __end_cc_report 16:03:06 INFO - PROCESS | 1954 | __startTimestamp1472598186256__endTimestamp 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | ------- Summary: start ------- 16:03:06 INFO - PROCESS | 1954 | Number of tests: 6 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#0] dojo.html Cycles:165 Average:5841.95 Median:6122.33 stddev:694.32 (11.3%) stddev-sans-first:651.65 16:03:06 INFO - PROCESS | 1954 | Values: 2714.0 2860.3 3218.4 3455.6 3496.4 5728.7 5766.5 5870.2 5874.6 5922.4 4990.5 5849.6 5886.5 5950.4 6038.8 5283.8 5399.9 5407.9 5445.0 5453.2 5236.2 5287.5 5378.5 5426.7 5468.8 5327.1 5332.1 5350.2 5350.5 5364.2 5344.1 5348.9 5365.1 5376.8 5426.9 5211.6 5284.9 5325.6 5355.8 5363.6 5828.4 5854.6 5894.4 5906.5 5911.7 6237.2 6299.9 6311.7 6314.0 6329.4 6260.8 6270.4 6272.4 6398.7 6420.7 6031.7 6038.8 6039.3 6052.0 6070.5 6450.5 6473.8 6500.6 6501.1 6518.2 6139.0 6216.3 6235.0 6267.0 6296.3 6351.4 6355.3 6364.6 6367.0 6398.7 6263.6 6285.7 6302.8 6308.4 6309.1 6184.4 6188.3 6193.6 6235.8 6256.1 5008.6 5036.1 5038.0 5043.5 5065.6 4520.2 4528.7 4530.9 4550.7 4556.0 5920.0 5933.7 6049.2 6072.2 6117.4 6388.3 6388.3 6389.0 6390.1 6393.2 6094.4 6104.7 6107.9 6125.1 6129.3 5463.5 5490.0 5509.5 5522.1 5553.6 6501.0 6510.4 6511.8 6524.2 6527.2 6299.7 6320.4 6335.2 6359.8 6365.9 6319.7 6443.4 6459.0 6471.4 6526.2 4596.4 5214.9 5581.6 6198.5 6324.5 6278.7 6308.1 6344.4 6346.5 6360.3 6108.4 6187.6 6222.4 6236.1 6269.6 5241.7 6287.5 6291.2 6297.6 6302.2 5324.9 5834.0 6122.3 6171.3 6191.3 5138.6 5974.9 6141.4 6143.5 6251.1 6142.8 6156.3 6184.7 6186.4 6221.8 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#1] ext.html Cycles:180 Average:71125.35 Median:38626.21 stddev:163407.35 (423.0%) stddev-sans-first:163779.52 16:03:06 INFO - PROCESS | 1954 | Values: 420.7 453.4 547.8 563.6 604.7 37165.8 39700.6 39762.2 39783.4 39894.4 40240.8 40877.0 40916.4 41025.6 41101.6 9531.7 9775.6 9781.9 9784.9 9808.9 9636.7 9636.8 9697.6 9759.2 9784.6 9751.8 9757.6 9795.0 9813.2 9819.8 9628.5 9671.3 9705.8 9753.1 9759.5 9601.1 9711.2 9719.4 9726.5 9733.2 26907.9 35526.8 36166.8 38635.8 38979.0 3308.9 3438.7 3711.7 3761.5 3973.1 24986.8 30502.5 31036.6 31500.7 31710.0 3133.9 3245.3 3268.3 3319.0 3348.5 490618.0 493908.0 502609.0 503061.0 504972.5 32114.7 32987.7 55637.7 55720.7 55899.2 33305.3 33328.2 33383.2 33774.0 33781.8 14292.0 14355.9 14458.7 14474.3 14518.3 11915.8 12305.3 12314.5 12433.8 12447.6 7501.8 7523.8 7578.8 7586.5 7600.2 3140.3 3171.0 3183.6 3189.3 3195.3 839.6 1021.1 1028.8 1048.3 1072.5 28410.0 29910.9 30093.5 30179.8 30573.7 1031.0 1057.6 1060.4 1070.3 1075.1 14000.7 15347.5 15380.4 15478.2 15831.6 604891.0 684950.0 690698.0 694815.0 695474.0 56618.2 56987.4 57005.0 57080.4 57091.4 1237.5 1243.5 1251.7 1331.1 1391.5 27812.6 29272.9 29399.1 30029.0 30068.4 48146.6 48788.0 48837.5 48852.8 48921.0 635615.0 637279.6 638327.8 638353.0 639576.0 20115.9 25999.0 26046.5 26058.2 26205.6 46243.8 46809.8 47275.0 47430.5 47477.5 38860.8 38920.0 39388.8 40106.6 40244.6 38411.8 38616.6 38798.0 39906.4 40091.2 32304.9 37442.6 37953.6 38141.6 38235.8 33400.8 33685.0 34410.7 34573.5 34638.0 25613.0 25622.4 25725.6 25853.5 26147.5 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#2] jquery.html Cycles:180 Average:34098.98 Median:3926.86 stddev:98162.10 (2499.8%) stddev-sans-first:98404.80 16:03:06 INFO - PROCESS | 1954 | Values: 372.3 378.0 381.5 387.4 404.9 15472.8 20417.4 21069.1 21764.9 21939.6 20131.3 20525.5 20723.6 20782.9 21220.6 5835.3 6023.0 6137.1 6445.1 6490.7 5893.2 5934.5 6227.1 6382.2 6552.4 5076.5 5901.4 5911.0 5930.8 5937.3 5598.3 5907.7 5915.4 5930.0 5939.8 5786.1 5793.3 5802.7 5802.8 5855.5 9355.7 11373.8 13155.9 21948.3 23833.9 1971.0 2111.4 2111.5 2115.6 2367.9 8806.3 9731.3 9737.6 9754.0 10097.4 1416.0 1797.8 1819.1 1856.7 1871.1 105512.5 110516.0 110638.0 110781.0 112202.4 10887.6 10932.9 11148.7 11250.3 11275.3 13736.5 13851.2 13894.7 13903.0 13907.7 8225.5 8382.5 8392.6 8510.7 8546.0 7694.1 8429.2 8449.2 8605.2 8625.8 3780.9 3884.7 3969.0 4013.2 4420.2 1860.8 1942.4 1945.6 1967.6 1969.0 765.1 799.4 923.9 952.9 987.2 18249.0 19376.3 19557.3 20840.9 20861.0 898.6 923.7 936.1 957.3 980.6 10351.3 10394.4 10795.7 10800.1 10834.2 496774.0 595386.0 605217.9 617306.0 618069.0 112322.4 114304.0 116349.7 127548.7 136524.3 953.7 957.8 986.8 988.7 1022.1 16670.2 17736.1 18470.5 18513.6 18742.2 46331.5 54501.7 56791.0 59517.7 59961.7 82262.9 83839.6 85966.3 86686.1 87074.6 6322.5 7892.8 8041.6 8162.8 8175.4 9185.2 9490.9 10830.7 11474.3 12627.3 9242.8 9704.9 9780.6 10468.9 11213.3 8576.8 10995.4 11126.9 11189.4 11559.1 11136.3 11254.9 11413.0 11539.9 11554.4 8032.0 8066.5 8107.4 8125.4 8137.3 10816.0 10914.4 11081.6 11085.1 11264.2 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#3] mootools.html Cycles:180 Average:5583.76 Median:5174.78 stddev:3065.95 (59.2%) stddev-sans-first:3058.20 16:03:06 INFO - PROCESS | 1954 | Values: 1371.3 1455.6 1643.8 1793.7 1836.1 7013.3 7824.5 8534.4 8867.2 8874.7 8503.3 8731.2 8731.4 8751.4 8763.0 1957.8 2358.5 2363.1 2364.6 2370.2 2338.0 2354.5 2381.3 2386.3 2392.4 1947.0 2344.9 2360.4 2378.1 2380.9 2138.5 2169.4 2329.1 2340.2 2350.6 2090.4 2188.0 2334.0 2340.0 2348.2 8706.7 8745.4 8751.2 8761.3 8766.2 5180.6 5290.4 5295.5 5336.6 5365.4 3468.8 3531.2 3600.6 3641.7 3658.0 1096.8 1114.8 1741.6 1804.7 1855.7 9357.0 11406.4 11449.7 11470.9 11472.8 3860.7 4334.8 4578.9 4637.8 4670.3 8824.6 8899.0 8935.2 8947.2 8948.0 5189.8 5236.0 5237.9 5265.8 5273.9 4432.8 4789.5 4917.1 4959.0 4964.4 3742.3 3810.8 3841.8 3876.5 3913.7 1163.7 1170.3 1174.8 1176.3 1182.3 832.7 839.8 892.9 913.9 928.9 5790.7 5962.6 6016.3 6107.1 6208.8 792.0 901.4 913.2 915.7 987.4 3940.6 3974.0 4037.8 4132.5 4168.8 7934.9 10679.4 10714.4 10725.5 10779.0 10598.8 10621.5 10625.0 10685.9 10767.7 8029.8 8162.3 8163.2 8174.9 8177.2 5596.8 5731.3 5876.2 5887.5 5946.9 8581.0 9861.5 9926.8 9974.3 9984.5 8170.8 9249.8 10076.0 10177.4 10197.5 5913.2 6462.0 6925.4 6946.4 7052.2 8211.4 8265.5 8274.0 8298.5 8305.9 7256.3 7409.4 7486.5 7494.7 7560.5 7178.4 7285.9 7342.2 7363.9 7385.0 6902.4 6939.3 6993.6 7001.4 7020.5 4772.9 4810.8 4844.9 4862.2 4905.3 5022.9 5034.5 5076.7 5142.2 5168.9 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#4] prototype.html Cycles:180 Average:4341.77 Median:4716.58 stddev:1310.10 (27.8%) stddev-sans-first:1276.96 16:03:06 INFO - PROCESS | 1954 | Values: 232.6 303.8 307.3 314.7 318.2 4922.7 5387.3 5520.5 5689.6 5758.6 4723.4 4910.3 4953.5 5585.9 5628.3 3508.7 4111.6 4329.4 4339.3 4379.4 3929.5 4228.5 4341.7 4345.3 4366.8 4168.7 4169.7 4174.1 4176.3 4202.7 3491.7 4144.9 4188.4 4210.0 4211.5 2810.7 3171.7 3319.6 3628.5 3642.8 4821.0 5027.0 5323.0 5330.6 5365.2 4013.5 4336.1 4530.0 4788.7 4875.2 5946.6 5957.8 5958.0 5963.4 5982.4 3282.8 3681.6 3886.5 3923.3 3943.0 4669.6 5784.0 6006.0 6142.6 6166.9 4017.3 4019.3 4021.9 4032.4 4038.0 3733.8 3906.4 4032.8 4065.6 4076.5 4694.6 4761.8 4775.2 4784.3 4804.9 4427.1 4952.4 5667.7 5932.8 5960.8 1158.6 1298.7 1301.9 1376.0 1382.7 751.4 784.4 861.4 895.6 925.6 4772.8 5341.4 5495.5 5581.0 5586.6 5319.1 5773.4 6032.9 6034.0 6064.3 4831.7 5206.4 5469.9 5550.6 5556.7 2360.7 2702.4 2713.4 2726.5 2726.9 4646.6 4947.9 4958.8 5204.7 5317.0 4221.6 5056.1 5216.8 5299.4 5308.9 4628.3 4630.6 4642.1 4697.9 5232.4 4036.7 4563.6 4980.5 5109.8 5169.4 3873.8 4178.0 4592.9 5068.6 5079.8 4469.8 4593.4 4675.8 4909.3 5064.6 3493.9 3519.7 3539.3 3541.3 3574.7 4374.6 4786.6 5003.5 5084.2 5124.5 4539.4 4754.5 4889.3 4986.5 4989.9 4581.7 4888.7 4975.0 4982.7 5003.3 4172.0 4184.9 4594.8 4869.3 4906.2 3987.7 4695.8 4961.6 4984.5 5000.7 4209.2 4283.5 4709.7 4880.9 4926.8 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - PROCESS | 1954 | [#5] yui.html Cycles:180 Average:26272.82 Median:3890.39 stddev:43796.88 (1125.8%) stddev-sans-first:43877.59 16:03:06 INFO - PROCESS | 1954 | Values: 679.9 707.9 711.4 762.3 797.5 14898.3 15811.4 15835.8 15843.8 15876.6 14308.8 14529.2 14532.8 14533.0 14536.7 660.1 813.9 825.4 838.0 853.8 693.2 850.2 851.6 853.8 855.1 874.9 888.6 904.8 908.0 909.4 890.4 898.2 898.2 900.2 900.5 638.5 663.7 671.4 673.2 673.2 14597.6 14770.9 14790.2 14797.9 14817.3 14056.7 14072.6 14253.5 14276.3 14407.7 9898.9 11819.9 11961.7 12188.9 12405.3 3739.9 3787.3 3840.8 3940.0 3943.8 114397.4 114947.3 115833.0 116263.0 121909.0 10337.6 10445.9 11055.0 11058.0 11589.7 23239.2 23274.0 23275.9 23305.5 23356.5 6538.5 7636.8 7752.3 7909.9 8064.8 4356.6 4425.6 4459.2 4502.5 4610.1 3563.4 3651.3 3664.9 3665.4 3806.6 705.6 720.5 729.0 730.8 739.2 589.5 625.5 652.9 653.4 664.6 8738.5 9399.6 9440.8 9495.6 9741.9 617.2 655.9 664.4 667.3 680.9 4396.7 4581.2 4598.5 4601.9 4607.6 155620.0 161729.0 163012.0 171456.0 176184.0 129155.7 141121.0 142796.3 146940.3 147162.3 116756.0 122816.4 124132.4 125040.0 126900.0 6570.3 7173.8 8243.8 8858.1 8923.4 60574.0 63726.0 63940.7 64435.7 65580.0 82602.0 102309.5 105179.0 106170.5 107402.5 11680.1 11822.8 11823.9 12012.1 12441.8 13151.5 13227.7 13405.6 13407.4 13578.2 12004.5 12219.8 12334.9 12602.0 12769.0 11857.8 11971.4 12341.2 12611.7 12698.6 11803.0 12286.2 12467.5 12493.9 12569.8 9413.8 9775.3 9915.0 9979.8 9997.9 8089.6 8317.9 9904.3 9939.9 9965.1 16:03:06 INFO - PROCESS | 1954 | -------- Summary: end -------- 16:03:06 INFO - PROCESS | 1954 | 16:03:06 INFO - TEST-INFO | 1954: exit 0 16:03:06 INFO - TEST-OK | dromaeo_css | took 1114028ms 16:03:06 INFO - TEST-START | kraken 16:03:06 INFO - operating with platform_type : mac_ 16:03:06 INFO - Initialising browser for kraken test... 16:03:06 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpv14U0Y/profile http://localhost:51831/getInfo.html) 16:03:09 INFO - PROCESS | 1959 | __metrics Screen width/height:1600/1200 16:03:09 INFO - PROCESS | 1959 | colorDepth:24 16:03:09 INFO - PROCESS | 1959 | Browser inner width/height: 1024/689 16:03:09 INFO - PROCESS | 1959 | __metrics 16:03:09 ERROR - PROCESS | 1959 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 16:03:10 INFO - TEST-INFO | 1959: exit 0 16:03:10 INFO - Browser initialized. 16:03:10 INFO - Running cycle 1/1 for kraken test... 16:03:10 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpv14U0Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:22 INFO - PROCESS | 1961 | RSS: Main: 244338688 16:03:22 INFO - PROCESS | 1961 | 16:03:25 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51831/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:26 INFO - PROCESS | 1961 | RSS: Main: 256999424 16:03:26 INFO - PROCESS | 1961 | 16:03:28 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51831/tests/kraken/driver.html?testName=audio-dft) 16:03:29 INFO - PROCESS | 1961 | RSS: Main: 265752576 16:03:29 INFO - PROCESS | 1961 | 16:03:32 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51831/tests/kraken/driver.html?testName=audio-fft) 16:03:33 INFO - PROCESS | 1961 | RSS: Main: 263303168 16:03:33 INFO - PROCESS | 1961 | 16:03:35 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51831/tests/kraken/driver.html?testName=audio-oscillator) 16:03:36 INFO - PROCESS | 1961 | RSS: Main: 265641984 16:03:36 INFO - PROCESS | 1961 | 16:03:38 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:39 INFO - PROCESS | 1961 | RSS: Main: 266289152 16:03:39 INFO - PROCESS | 1961 | 16:03:41 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51831/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:42 INFO - PROCESS | 1961 | RSS: Main: 266575872 16:03:42 INFO - PROCESS | 1961 | 16:03:45 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51831/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:46 INFO - PROCESS | 1961 | RSS: Main: 266891264 16:03:46 INFO - PROCESS | 1961 | 16:03:49 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51831/tests/kraken/driver.html?testName=json-parse-financial) 16:03:50 INFO - PROCESS | 1961 | RSS: Main: 266948608 16:03:50 INFO - PROCESS | 1961 | 16:03:51 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:52 INFO - PROCESS | 1961 | RSS: Main: 266747904 16:03:52 INFO - PROCESS | 1961 | 16:03:54 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:54 INFO - PROCESS | 1961 | RSS: Main: 266657792 16:03:54 INFO - PROCESS | 1961 | 16:03:56 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:57 INFO - PROCESS | 1961 | RSS: Main: 267010048 16:03:57 INFO - PROCESS | 1961 | 16:04:00 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:01 INFO - PROCESS | 1961 | RSS: Main: 267272192 16:04:01 INFO - PROCESS | 1961 | 16:04:04 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:04 INFO - PROCESS | 1961 | RSS: Main: 267108352 16:04:04 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | Cycle 1(1): loaded http://localhost:51831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51831/tests/kraken/driver.html?testName=ai-astar) 16:04:06 INFO - PROCESS | 1961 | RSS: Main: 268951552 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | __start_tp_report 16:04:06 INFO - PROCESS | 1961 | _x_x_mozilla_page_load 16:04:06 INFO - PROCESS | 1961 | _x_x_mozilla_page_load_details 16:04:06 INFO - PROCESS | 1961 | |i|pagename|runs| 16:04:06 INFO - PROCESS | 1961 | |0;ai-astar;109;116;116;114;115;116;116;116;116;132 16:04:06 INFO - PROCESS | 1961 | |1;audio-beat-detection;146;110;138;189;99;162;160;120;198;138 16:04:06 INFO - PROCESS | 1961 | |2;audio-dft;202;210;260;272;274;249;201;200;192;193 16:04:06 INFO - PROCESS | 1961 | |3;audio-fft;72;82;83;164;93;86;86;79;134;60 16:04:06 INFO - PROCESS | 1961 | |4;audio-oscillator;68;74;126;70;70;75;107;94;105;148 16:04:06 INFO - PROCESS | 1961 | |5;imaging-gaussian-blur;98;116;89;85;89;92;135;86;88;85 16:04:06 INFO - PROCESS | 1961 | |6;imaging-darkroom;95;96;128;133;105;154;108;153;153;94 16:04:06 INFO - PROCESS | 1961 | |7;imaging-desaturate;91;94;75;145;151;92;91;90;127;147 16:04:06 INFO - PROCESS | 1961 | |8;json-parse-financial;58;58;59;57;59;58;60;58;57;57 16:04:06 INFO - PROCESS | 1961 | |9;json-stringify-tinderbox;68;70;76;71;75;82;75;70;71;73 16:04:06 INFO - PROCESS | 1961 | |10;stanford-crypto-aes;90;87;90;87;86;89;88;86;93;84 16:04:06 INFO - PROCESS | 1961 | |11;stanford-crypto-ccm;155;165;157;141;140;165;158;170;194;173 16:04:06 INFO - PROCESS | 1961 | |12;stanford-crypto-pbkdf2;172;169;170;158;218;169;170;170;173;171 16:04:06 INFO - PROCESS | 1961 | |13;stanford-crypto-sha256-iterative;68;68;69;67;69;67;68;78;79;69 16:04:06 INFO - PROCESS | 1961 | __end_tp_report 16:04:06 INFO - PROCESS | 1961 | __start_cc_report 16:04:06 INFO - PROCESS | 1961 | _x_x_mozilla_cycle_collect,958 16:04:06 INFO - PROCESS | 1961 | __end_cc_report 16:04:06 INFO - PROCESS | 1961 | __startTimestamp1472598246816__endTimestamp 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | ------- Summary: start ------- 16:04:06 INFO - PROCESS | 1961 | Number of tests: 14 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.00 stddev:5.83 (5.0%) stddev-sans-first:5.50 16:04:06 INFO - PROCESS | 1961 | Values: 109.0 116.0 116.0 114.0 115.0 116.0 116.0 116.0 116.0 132.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:161.00 stddev:32.17 (20.0%) stddev-sans-first:34.12 16:04:06 INFO - PROCESS | 1961 | Values: 146.0 110.0 138.0 189.0 99.0 162.0 160.0 120.0 198.0 138.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#2] audio-dft Cycles:10 Average:225.30 Median:229.50 stddev:34.12 (14.9%) stddev-sans-first:35.13 16:04:06 INFO - PROCESS | 1961 | Values: 202.0 210.0 260.0 272.0 274.0 249.0 201.0 200.0 192.0 193.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#3] audio-fft Cycles:10 Average:93.90 Median:82.50 stddev:31.20 (37.8%) stddev-sans-first:32.07 16:04:06 INFO - PROCESS | 1961 | Values: 72.0 82.0 83.0 164.0 93.0 86.0 86.0 79.0 134.0 60.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:70.00 stddev:27.52 (39.3%) stddev-sans-first:27.58 16:04:06 INFO - PROCESS | 1961 | Values: 68.0 74.0 126.0 70.0 70.0 75.0 107.0 94.0 105.0 148.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.50 stddev:16.48 (18.6%) stddev-sans-first:17.47 16:04:06 INFO - PROCESS | 1961 | Values: 98.0 116.0 89.0 85.0 89.0 92.0 135.0 86.0 88.0 85.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#6] imaging-darkroom Cycles:10 Average:121.90 Median:153.50 stddev:25.34 (16.5%) stddev-sans-first:24.93 16:04:06 INFO - PROCESS | 1961 | Values: 95.0 96.0 128.0 133.0 105.0 154.0 108.0 153.0 153.0 94.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:90.50 stddev:28.85 (31.9%) stddev-sans-first:29.74 16:04:06 INFO - PROCESS | 1961 | Values: 91.0 94.0 75.0 145.0 151.0 92.0 91.0 90.0 127.0 147.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 16:04:06 INFO - PROCESS | 1961 | Values: 58.0 58.0 59.0 57.0 59.0 58.0 60.0 58.0 57.0 57.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:74.00 stddev:4.07 (5.5%) stddev-sans-first:3.87 16:04:06 INFO - PROCESS | 1961 | Values: 68.0 70.0 76.0 71.0 75.0 82.0 75.0 70.0 71.0 73.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.50 stddev:2.58 (2.9%) stddev-sans-first:2.64 16:04:06 INFO - PROCESS | 1961 | Values: 90.0 87.0 90.0 87.0 86.0 89.0 88.0 86.0 93.0 84.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:165.00 stddev:15.78 (9.6%) stddev-sans-first:16.55 16:04:06 INFO - PROCESS | 1961 | Values: 155.0 165.0 157.0 141.0 140.0 165.0 158.0 170.0 194.0 173.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:170.50 stddev:16.00 (9.4%) stddev-sans-first:16.95 16:04:06 INFO - PROCESS | 1961 | Values: 172.0 169.0 170.0 158.0 218.0 169.0 170.0 170.0 173.0 171.0 16:04:06 INFO - PROCESS | 1961 | 16:04:06 INFO - PROCESS | 1961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.00 stddev:4.44 (6.4%) stddev-sans-first:4.64 16:04:06 INFO - PROCESS | 1961 | Values: 68.0 68.0 69.0 67.0 69.0 67.0 68.0 78.0 79.0 69.0 16:04:06 INFO - PROCESS | 1961 | -------- Summary: end -------- 16:04:06 INFO - PROCESS | 1961 | 16:04:07 INFO - TEST-INFO | 1961: exit 0 16:04:07 INFO - TEST-OK | kraken | took 60798ms 16:04:07 INFO - SUITE-END | took 1174s 16:04:07 INFO - Completed test suite (00:19:35) 16:04:07 INFO - javascript benchmark 16:04:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7176.76698563764, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.986430067849, 2860.2706309890973, 3218.4045951498965, 3455.585329760429, 3496.388132076886, 5728.742206600703, 5766.538676905842, 5870.236869207002, 5874.618149820259, 5922.407759224076, 4990.500949905017, 5849.590528662995, 5886.470217680408, 5950.375210602879, 6038.818835434933, 5283.762230699618, 5399.919001214985, 5407.918881216785, 5445.0, 5453.15476101205, 5236.162214045753, 5287.471252874701, 5378.489043540857, 5426.728663566825, 5468.808591699291, 5327.121025030885, 5332.120200166968, 5350.197470379435, 5350.491703288181, 5364.168553874156, 5344.118220493614, 5348.903474787659, 5365.061114304981, 5376.78492860289, 5426.864328391783, 5211.557017653504, 5284.920726189111, 5325.573954083664, 5355.758990845421, 5363.6245462817615, 5828.41715828418, 5854.590178687494, 5894.410558944114, 5906.527477801766, 5911.704414779287, 6237.1891654084675, 6299.9370006299805, 6311.715972781236, 6314.02132669437, 6329.36706329368, 6260.78087266948, 6270.435660790551, 6272.40412160844, 6398.744050237985, 6420.711068001951, 6031.698415079272, 6038.849028774316, 6039.335673075958, 6052.0, 6070.484008859252, 6450.451711604473, 6473.77341793035, 6500.577462464925, 6501.0573466847045, 6518.217813862367, 6138.969305153446, 6216.347283535254, 6235.0, 6267.0286105653695, 6296.307406185316, 6351.364863513704, 6355.332690067568, 6364.554481186365, 6367.0, 6398.71205795731, 6263.6241825490615, 6285.685715714196, 6302.810915672446, 6308.432241098231, 6309.08518264849, 6184.381561843779, 6188.319284878659, 6193.566450348432, 6235.812925612148, 6256.061590761422, 5008.57427118699, 5036.118679231193, 5038.0, 5043.52086551777, 5065.645404821627, 4520.2315606347, 4528.682992190581, 4530.909381812346, 4550.658700597469, 4555.9772201138785, 5919.970400148058, 5933.732982015733, 6049.153118563405, 6072.180255665428, 6117.418845209698, 6388.297287298394, 6388.329225431356, 6388.977763557901, 6390.105385246069, 6393.200849893763, 6094.360092190344, 6104.725287362079, 6107.908381374283, 6125.050617154348, 6129.295131059896, 5463.508284254436, 5489.972550137224, 5509.47659972302, 5522.088855338904, 5553.6390134641115, 6501.0, 6510.381513756186, 6511.772087976898, 6524.151860258231, 6527.15147030883, 6299.716512756845, 6320.367963203643, 6335.239771227482, 6359.777407790705, 6365.8726825464155, 6319.715612797343, 6443.387878151568, 6459.0, 6471.417572418317, 6526.151600291932, 4596.402467679314, 5214.869628259172, 5581.6371935824045, 6198.473129784019, 6324.462420694293, 6278.6860656966055, 6308.116863639002, 6344.429001389897, 6346.460550853045, 6360.300366959723, 6108.402780883668, 6187.566870319034, 6222.439980401786, 6236.126942228001, 6269.623822570478, 5241.741981924387, 6287.497000240061, 6291.150694656163, 6297.559170857996, 6302.180716506825, 5324.881774827175, 5833.9790536656765, 6122.326544080237, 6171.259448865985, 6191.349908259568, 5138.563222126161, 5974.910376344272, 6141.416565426277, 6143.542582966849, 6251.124842521959, 6142.815715528542, 6156.29202641702, 6184.690765461799, 6186.350433204449, 6221.751129954751], "value": 5794.500518246719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.7391417321261, 453.41962288271003, 547.7891011960396, 563.6280055163592, 604.7036951893573, 37165.814170929145, 39700.60299397005, 39762.2047559049, 39783.40324895129, 39894.401583976265, 40240.79277621669, 40877.0, 40916.38625420621, 41025.58974410255, 41101.58898411015, 9531.666391676292, 9775.56009979549, 9781.945791383818, 9784.902150978505, 9808.852867206997, 9636.662716804913, 9636.759081022961, 9697.563609637584, 9759.170470510015, 9784.55969481375, 9751.75620609487, 9757.609695612202, 9795.0, 9813.214942804594, 9819.754506137333, 9628.47043412612, 9671.274654400913, 9705.75735606612, 9753.122219000254, 9759.512024398751, 9601.087896649877, 9711.223102151811, 9719.368241064309, 9726.465044422624, 9733.2213422926, 26907.86546067277, 35526.822365888, 36166.819165904264, 38635.806820965714, 38979.0, 3308.9007329780147, 3438.707709844666, 3711.66595006448, 3761.492198553215, 3973.086190176247, 24986.750132498622, 30502.542461862868, 31036.603352849175, 31500.684993150004, 31710.0, 3133.9216519586967, 3245.2535916739284, 3268.3299923515624, 3319.037479131049, 3348.5479460272795, 490618.0, 493908.0, 502609.0, 503061.0, 504972.47513762565, 32114.678853211637, 32987.6804927805, 55637.721811390686, 55720.72139639276, 55899.161512577346, 33305.33389332248, 33328.1667958303, 33383.16542086467, 33774.0, 33781.83109084488, 14292.0, 14355.928220359041, 14458.710825783426, 14474.348654310581, 14518.346674399678, 11915.821262681067, 12305.32320722351, 12314.50741970329, 12433.75132497345, 12447.626571202698, 7501.774946751606, 7523.8495230095095, 7578.772636820904, 7586.468947173756, 7600.1639819619795, 3140.262038420969, 3171.0, 3183.570218020584, 3189.3142974260645, 3195.2999715240585, 839.588601585231, 1021.1422405179685, 1028.753099256188, 1048.3488505603552, 1072.4798472740715, 28410.00564980216, 29910.850445748067, 30093.548596771067, 30179.849100754356, 30573.69426305753, 1030.9896901030893, 1057.6404022632341, 1060.4432672846817, 1070.2775626452114, 1075.0700643942932, 14000.719985600232, 15347.462838800811, 15380.393839460814, 15478.226088695521, 15831.604209894846, 604891.0, 684950.0, 690698.0, 694815.0, 695474.0452595409, 56618.150727739114, 56987.430125699044, 57005.0, 57080.42919570751, 57091.42908570861, 1237.4864431261105, 1243.5088140184575, 1251.7308778612642, 1331.0815537279245, 1391.4712409284407, 27812.58281125744, 29272.853635731684, 29399.11802645924, 30029.0, 30068.398632027674, 48146.55560333196, 48788.0, 48837.51162488329, 48852.755736221094, 48921.0, 635615.0, 637279.6272037405, 638327.8083609738, 638353.0, 639576.0, 20115.899420502803, 25999.0, 26046.479070418107, 26058.218253452425, 26205.606915896657, 46243.76878115588, 46809.765951170026, 47275.0, 47430.52569474261, 47477.52522474731, 38860.80569597247, 38920.0, 39388.803055984536, 40106.598934011454, 40244.59755402408, 38411.847644570706, 38616.61383386242, 38798.03004924899, 39906.40140397838, 40091.1981760369, 32304.869329573354, 37442.62557374391, 37953.62046379501, 38141.618583813804, 38235.80882095572, 33400.83299583486, 33684.98945031653, 34410.655893440744, 34573.48139777855, 34638.0, 25612.9754809813, 25622.359441013377, 25725.614115788652, 25853.482930340913, 26147.477050458503], "value": 18459.876278876287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.31865685795, 377.9924401511969, 381.458329172575, 387.3647218561561, 404.91699201663664, 15472.765130621017, 20417.387478375655, 21069.05189266483, 21764.89117554414, 21939.561208775816, 20131.29540466084, 20525.4868628284, 20723.585528289426, 20782.896085519587, 21220.57558848822, 5835.270591176103, 6023.036314189731, 6137.079438084301, 6445.097686323918, 6490.707918143695, 5893.174955506232, 5934.465898069195, 6227.097070924713, 6382.170317858672, 6552.410283074522, 5076.466970968032, 5901.380355062721, 5910.970445147768, 5930.792422265222, 5937.346891841894, 5598.300212473441, 5907.6750778707155, 5915.438033386843, 5930.0, 5939.762409503614, 5786.07422812348, 5793.333766616809, 5802.65184088956, 5802.767889284423, 5855.473007429309, 9355.672551460666, 11373.805750396172, 13155.86844131556, 21948.34154975353, 23833.88083059591, 1970.9704354434696, 2111.4088055344528, 2111.5460176062065, 2115.5719889074967, 2367.9289621311386, 8806.295496360275, 9731.270154738422, 9737.56180971858, 9754.0, 10097.444640544767, 1415.9575212743634, 1797.757302764123, 1819.0813639112296, 1856.7400563921062, 1871.0644677661169, 105512.47243763732, 110516.0, 110637.9999999992, 110781.0, 112202.43898780453, 10887.564497420173, 10932.945335273273, 11148.665540033811, 11250.324980501196, 11275.293929457035, 13736.519221827188, 13851.238181900093, 13894.652633684036, 13902.957278204176, 13907.652308692364, 8225.465344752572, 8382.49705017701, 8392.622331995075, 8510.74467765968, 8546.0, 7694.146710762207, 8429.199226073513, 8449.197326253996, 8605.182507661762, 8625.827483450421, 3780.8865734028022, 3884.7086468514976, 3969.0077480629843, 4013.2374848779223, 4420.160169567836, 1860.8325250727228, 1942.4366933589383, 1945.6303302372503, 1967.5572996075769, 1968.9606207875763, 765.1239330966013, 799.4324029938692, 923.9445633262026, 952.8808898887639, 987.2398253345028, 18249.0, 19376.321828735927, 19557.31549395764, 20840.895795521228, 20861.0, 898.6180873128894, 923.7136487688838, 936.0779632062413, 957.2581249531529, 980.5783513089298, 10351.275410721177, 10394.376337419779, 10795.676129716121, 10800.135989120852, 10834.187435942336, 496774.0, 595386.0, 605217.9478205162, 617306.0, 618069.0, 112322.39808824801, 114304.0, 116349.6730065394, 127548.72451275554, 136524.31737841247, 953.6900507335005, 957.7557722780647, 986.7878406142714, 988.663854289545, 1022.0750221049962, 16670.16649167561, 17736.11319434049, 18470.538236544195, 18513.629727405645, 18742.188671699354, 46331.53668463272, 54501.72749136229, 56791.0, 59517.70241148766, 59961.70019149876, 82262.88685565579, 83839.5808020956, 85966.30721065497, 86686.09912553824, 87074.56462717646, 6322.462590679844, 7892.816077588408, 8041.587523742971, 8162.83674326522, 8175.386845986456, 9185.219256363016, 9490.861096668445, 10830.67507974762, 11474.311541307548, 12627.30549819732, 9242.798436203251, 9704.883938346899, 9780.608775648894, 10468.895311046792, 11213.271137376045, 8576.828463430571, 10995.395253260827, 11126.944365278121, 11189.440527973731, 11559.133065019989, 11136.276142050741, 11254.94372528132, 11413.0, 11539.88460115388, 11554.42227888619, 8031.959840200761, 8066.516009039477, 8107.351411887153, 8125.431219814556, 8137.3318469712385, 10816.0, 10914.399708016135, 11081.556737730723, 11085.05777008931, 11264.211505194886], "value": 9250.501500986564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.2800779590714, 1455.5560554031024, 1643.7753873364345, 1793.6771381151405, 1836.1278392763431, 7013.333733295335, 7824.530528168314, 8534.402591818574, 8867.201951824334, 8874.733757987255, 8503.319734421248, 8731.214190722834, 8731.432456890314, 8751.431156974792, 8763.0, 1957.765068191819, 2358.492924021335, 2363.0665886974634, 2364.6334818103223, 2370.229675355508, 2338.0, 2354.493783836475, 2381.30942026812, 2386.331827088418, 2392.437777122375, 1946.9902650486729, 2344.9062037518565, 2360.409897525619, 2378.0725517048363, 2380.8571485710913, 2138.5295235048343, 2169.3708824440973, 2329.0683726509533, 2340.1926335414255, 2350.635651474024, 2090.3937858021154, 2188.0153930731076, 2333.953320933572, 2340.028888011473, 2348.1664009276633, 8706.695265665672, 8745.431546949492, 8751.168638979287, 8761.299096072298, 8766.211041006276, 5180.6373553851245, 5290.39160496544, 5295.549878260353, 5336.626436149471, 5365.436629153922, 3468.757186996911, 3531.2054787672823, 3600.6219346968714, 3641.745077844552, 3658.0306218852024, 1096.819024860897, 1114.832775083736, 1741.5646088477881, 1804.6841802684478, 1855.6938105212623, 9356.953215233949, 11406.42967851604, 11449.656510304705, 11470.942645286721, 11472.770544589144, 3860.6718428933295, 4334.761588112621, 4578.931316030262, 4637.814487420533, 4670.299455081765, 8824.558772061371, 8899.0, 8935.195832375117, 8947.239484643747, 8948.0, 5189.818356357509, 5235.973820130951, 5237.921431178535, 5265.815696450606, 5273.868153296122, 4432.82268709248, 4789.521047895182, 4917.065757506062, 4959.0, 4964.404271487372, 3742.251549690073, 3810.8285127169343, 3841.7887016213817, 3876.534815822063, 3913.745606535566, 1163.697438665936, 1170.2744298534792, 1174.8472698549133, 1176.335370515656, 1182.3497076607832, 832.7418500264937, 839.7984483723984, 892.8616064510011, 913.9314551408671, 928.874601928731, 5790.739416726257, 5962.552808539377, 6016.278046634345, 6107.053406721965, 6208.844778880564, 792.0, 901.3510272603714, 913.2055112052424, 915.663131827526, 987.3631507677651, 3940.6059394060367, 3974.0, 4037.7981100944835, 4132.504099508018, 4168.791560421967, 7934.920650793418, 10679.412632305297, 10714.41070741101, 10725.463726813628, 10779.0, 10598.841017384746, 10621.468926553642, 10625.0, 10685.893141068645, 10767.730806729895, 8029.799255018671, 8162.347012239125, 8163.183681631789, 8174.9182508175345, 8177.223163799429, 5596.832095037155, 5731.283589551306, 5876.236089308533, 5887.470127688529, 5946.940530594812, 8581.01318348398, 9861.457619830979, 9926.751831204278, 9974.251931105051, 9984.500774961078, 8170.7957301067945, 9249.815003700023, 10076.0, 10177.440240786531, 10197.54111064989, 5913.172155898264, 6462.0, 6925.411340036153, 6946.409555187865, 7052.2242553318065, 8211.425200236165, 8265.46274492156, 8274.007119145741, 8298.460600060977, 8305.916940830515, 7256.2743725627015, 7409.407247420301, 7486.4759466836795, 7494.662740176596, 7560.508566943131, 7178.389836863925, 7285.854282914206, 7342.19235884063, 7363.926360736324, 7384.966104745233, 6902.378785909293, 6939.271376505394, 6993.580385176906, 7001.404880585003, 7020.508564400648, 4772.928406073842, 4810.759462026955, 4844.927326090182, 4862.197737373293, 4905.264210368473, 5022.924656130234, 5034.521720436553, 5076.746162691777, 5142.151544995184, 5168.922466162935], "value": 4534.702239316922, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [232.55697895509056, 303.7994923350589, 307.3146882452132, 314.6758838396451, 318.20766291933063, 4922.704637721735, 5387.299651045359, 5520.537057679718, 5689.63017403869, 5758.596898217126, 4723.433188017434, 4910.312556242129, 4953.504649535044, 5585.888282234353, 5628.32460104788, 3508.71930245581, 4111.568285330042, 4329.437173167499, 4339.349097635356, 4379.408779814716, 3929.5481019682675, 4228.471441069866, 4341.739495630272, 4345.348197770344, 4366.8253269869165, 4168.7290326128705, 4169.666426685873, 4174.102567947891, 4176.310908700061, 4202.726822756511, 3491.7381196410115, 4144.91710165795, 4188.4136220929095, 4210.010647497836, 4211.473565804275, 2810.6789808789836, 3171.668823414788, 3319.618243901958, 3628.4738712886747, 3642.763220390666, 4821.0, 5027.0, 5322.988632159877, 5330.604298230264, 5365.222042803811, 4013.5350597031875, 4336.111097225062, 4530.0, 4788.712677239377, 4875.196177414379, 5946.643201407886, 5957.821265362046, 5958.0, 5963.403659634046, 5982.401759824026, 3282.8030318180986, 3681.6134305897763, 3886.514185726784, 3923.3330333843314, 3943.0339566806315, 4669.6184945677605, 5783.971080144573, 6005.978983572803, 6142.590862071548, 6166.938330616681, 4017.31705610047, 4019.256437559061, 4021.939670904939, 4032.3749818778138, 4037.9810094952522, 3733.7946412947003, 3906.43356713275, 4032.838686452509, 4065.617689985419, 4076.510818701775, 4694.647901407408, 4761.785719642625, 4775.235962246094, 4784.30627559002, 4804.8798780030775, 4427.078128435217, 4952.439981405845, 5667.659940403589, 5932.822015339547, 5960.76156953717, 1158.6408213453687, 1298.7142828577698, 1301.9283939383236, 1376.0254035459147, 1382.6612479942478, 751.3988808952815, 784.3920961254959, 861.4443683823898, 895.583553647557, 925.6482536636036, 4772.76136193189, 5341.406390504163, 5495.505404513613, 5580.972095139579, 5586.636868603528, 5319.069162896478, 5773.422657734277, 6032.879342413127, 6034.0, 6064.272287325461, 4831.7437466259025, 5206.427292997767, 5469.917951230735, 5550.611457198038, 5556.6943818089585, 2360.704911886014, 2702.3919618086165, 2713.430179662293, 2726.5364887969095, 2726.859415358934, 4646.605038571759, 4947.851564453073, 4958.8181200271765, 5204.661696989683, 5317.016351974897, 4221.6200541951375, 5056.078690097739, 5216.765245563959, 5299.3895311079605, 5308.893822123536, 4628.282616194495, 4630.560096790799, 4642.121884431674, 4697.8725105973635, 5232.424433312332, 4036.7174297798874, 4563.589276965089, 4980.5019498049905, 5109.799197188732, 5169.379674439091, 3873.7869417182324, 4177.976395783053, 4592.862214133581, 5068.6451948363265, 5079.822206222764, 4469.776511174363, 4593.438231001475, 4675.76621168947, 4909.3372394727685, 5064.569511591409, 3493.934350023267, 3519.6832285094465, 3539.3275277697153, 3541.327147841902, 3574.7318951078255, 4374.58441448062, 4786.569208771088, 5003.54968052877, 5084.186530155157, 5124.538791508782, 4539.415190657526, 4754.4770075291, 4889.315495830658, 4986.526280003394, 4989.906258119844, 4581.702189357681, 4888.7311197884455, 4974.9751251243515, 4982.676126051795, 5003.299538064601, 4172.039141603442, 4184.886632250694, 4594.839180628662, 4869.31829543857, 4906.239532872411, 3987.6809855212095, 4695.835645752519, 4961.578265847444, 4984.4517103117905, 5000.674821172465, 4209.221913537173, 4283.464566929134, 4709.7174169549935, 4880.877978050577, 4926.827561035347], "value": 3926.824933206864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.9014142949269, 707.8619669164511, 711.4450728431823, 762.3177256355561, 797.4856217739556, 14898.329575169117, 15811.367545298202, 15835.84164158358, 15843.762343564827, 15876.603084922883, 14308.785368219485, 14529.200893950829, 14532.782008269884, 14533.0, 14536.709265814703, 660.1253339325389, 813.9430239883196, 825.4345773145385, 837.9706710265142, 853.7694822397949, 693.2443636436284, 850.2432834777022, 851.6337974670889, 853.8292341531718, 855.0936007831688, 874.9194744490549, 888.5779254853925, 904.8054668246326, 908.0193391137556, 909.3679892474732, 890.3678388344283, 898.1647068226547, 898.1736802142045, 900.2348004196446, 900.5272232078212, 638.4732595608641, 663.6947004377992, 671.4259308291438, 673.2392396591869, 673.249327000396, 14597.6350591235, 14770.852291477055, 14790.18653974031, 14797.92601036988, 14817.333220005017, 14056.71886562263, 14072.648183795385, 14253.50112746049, 14276.286185690778, 14407.711845763131, 9898.90101098987, 11819.881801181964, 11961.700957476045, 12188.939055304756, 12405.3011373858, 3739.906502337436, 3787.3372159872188, 3840.807959602009, 3939.980300098481, 3943.842246310144, 114397.42801286024, 114947.2757908632, 115833.0, 116263.0, 121909.0, 10337.623762376237, 10445.895541044492, 11055.0, 11058.0, 11589.710257243467, 23239.186628467924, 23274.0, 23275.88362058179, 23305.53388932212, 23356.532869342856, 6538.545404087443, 7636.847263054708, 7752.341051010727, 7909.920900791033, 8064.798380040546, 4356.629686476622, 4425.557444255549, 4459.152760975404, 4502.459704835441, 4610.124076425468, 3563.4120370138635, 3651.2514934438377, 3664.908377290589, 3665.4318580619515, 3806.619338066171, 705.6401235369896, 720.4740539406263, 728.9635518224173, 730.831908661011, 739.1979702023365, 589.4665327878276, 625.5308518611042, 652.8596351784295, 653.3792896748108, 664.6278084272823, 8738.519381433955, 9399.624015039459, 9440.763980900532, 9495.620175193053, 9741.902580974242, 617.2346290599714, 655.9376859198369, 664.3920812456548, 667.3226674924955, 680.9003459413012, 4396.714213576107, 4581.175388430048, 4598.494165641777, 4601.907961840811, 4607.631389488833, 155620.0, 161729.0, 163012.0, 171456.0, 176184.0, 129155.70844291625, 141121.0, 142796.28601856926, 146940.26529867284, 147162.26418867838, 116756.0, 122816.38591806983, 124132.37933810454, 125040.0, 126900.0, 6570.277269500256, 7173.780457322164, 8243.804648326079, 8858.114188581349, 8923.41997770143, 60574.0, 63726.044109339324, 63940.68029659822, 64435.71128577496, 65580.0, 82602.0, 102309.48845255726, 105179.0, 106170.46914765377, 107402.46298768456, 11680.130289905017, 11822.822657660314, 11823.881761182278, 12012.099092567918, 12441.751164976831, 13151.473941042252, 13227.735445290848, 13405.597832065054, 13407.396667149807, 13578.185308881499, 12004.459799308877, 12219.816702749644, 12334.938325308316, 12602.046682764187, 12769.0, 11857.762844743229, 11971.401429928643, 12341.197822141532, 12611.74776504483, 12698.619041428772, 11803.0, 12286.201396909173, 12467.5012999479, 12493.875061249271, 12569.811452828399, 9413.82327209099, 9775.315727898978, 9914.950425247827, 9979.750506237111, 9997.850032249376, 8089.555074470725, 8317.916820831715, 9904.25718071133, 9939.850902236616, 9965.053319934595], "value": 7754.0390719862135, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1629.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 114.0, 115.0, 116.0, 116.0, 116.0, 116.0, 132.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 138.0, 189.0, 99.0, 162.0, 160.0, 120.0, 198.0, 138.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 210.0, 260.0, 272.0, 274.0, 249.0, 201.0, 200.0, 192.0, 193.0], "value": 225.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 83.0, 164.0, 93.0, 86.0, 86.0, 79.0, 134.0, 60.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 126.0, 70.0, 70.0, 75.0, 107.0, 94.0, 105.0, 148.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 116.0, 89.0, 85.0, 89.0, 92.0, 135.0, 86.0, 88.0, 85.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 128.0, 133.0, 105.0, 154.0, 108.0, 153.0, 153.0, 94.0], "value": 121.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 75.0, 145.0, 151.0, 92.0, 91.0, 90.0, 127.0, 147.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 57.0, 59.0, 58.0, 60.0, 58.0, 57.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 76.0, 71.0, 75.0, 82.0, 75.0, 70.0, 71.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 86.0, 89.0, 88.0, 86.0, 93.0, 84.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 165.0, 157.0, 141.0, 140.0, 165.0, 158.0, 170.0, 194.0, 173.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 170.0, 158.0, 218.0, 169.0, 170.0, 170.0, 173.0, 171.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 69.0, 67.0, 68.0, 78.0, 79.0, 69.0], "value": 70.2, "unit": "score"}]}]} 16:04:08 INFO - Return code: 0 16:04:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:08 ERROR - # TBPL SUCCESS # 16:04:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:04:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:04:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:04:08 INFO - 2016-08-30 16:04:08.139 screenresolution[1967:14701] starting screenresolution argv=screenresolution get 16:04:08 INFO - 2016-08-30 16:04:08.142 screenresolution[1967:14701] Display 0: 1600x1200x32@60 16:04:08 INFO - 2016-08-30 16:04:08.148 screenresolution[1968:14704] starting screenresolution argv=screenresolution list 16:04:08 INFO - Available Modes on Display 0 16:04:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:04:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:04:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:04:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:04:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:04:08 INFO - Intel Iris: 16:04:08 INFO - Chipset Model: Intel Iris 16:04:08 INFO - Type: GPU 16:04:08 INFO - Bus: Built-In 16:04:08 INFO - VRAM (Dynamic, Max): 1536 MB 16:04:08 INFO - Vendor: Intel (0x8086) 16:04:08 INFO - Device ID: 0x0a2e 16:04:08 INFO - Revision ID: 0x0009 16:04:08 INFO - Displays: 16:04:08 INFO - Display: 16:04:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:04:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:04:08 INFO - Display Serial Number: 1600x1200 60 16:04:08 INFO - Main Display: Yes 16:04:08 INFO - Mirror: Off 16:04:08 INFO - Online: Yes 16:04:08 INFO - Rotation: Supported 16:04:08 INFO - Return code: 0 16:04:08 INFO - Running post-action listener: _resource_record_post_action 16:04:08 INFO - [mozharness: 2016-08-30 23:04:08.383426Z] Finished run-tests step (success) 16:04:08 INFO - Running post-run listener: _resource_record_post_run 16:04:08 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 745472; Write bytes: 709766144; Read time: 10; Write time: 2275 16:04:08 INFO - TinderboxPrint: CPU usage
54.6% 16:04:08 INFO - TinderboxPrint: I/O read bytes / time
745,472 / 10 16:04:08 INFO - TinderboxPrint: I/O write bytes / time
709,766,144 / 2,275 16:04:08 INFO - TinderboxPrint: CPU idle
2,199.0 (45.4%) 16:04:08 INFO - TinderboxPrint: CPU system
980.9 (20.3%) 16:04:08 INFO - TinderboxPrint: CPU user
1,661.8 (34.3%) 16:04:08 INFO - TinderboxPrint: Swap in / out
406,642,688 / 0 16:04:08 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394306048; Write bytes: 389620224; Read time: 29262; Write time: 755 16:04:08 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 737280; Write bytes: 299371008; Read time: 9; Write time: 1479 16:04:08 INFO - Running post-run listener: _upload_blobber_files 16:04:08 INFO - Blob upload gear active. 16:04:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:08 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 16:04:08 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'] 16:04:08 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 16:04:09 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:10 INFO - (blobuploader) - INFO - Done attempting. 16:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:11 INFO - (blobuploader) - INFO - Done attempting. 16:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:04:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:13 INFO - (blobuploader) - INFO - Done attempting. 16:04:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:04:13 INFO - Return code: 0 16:04:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:04:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:04:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0f08ed1c141b74c1199d5ca1726ae76699f49415c567d818ddd03319f19692b43e43a6cd2133fc735d46de4da59d7215388932bcfb05f70f3d8792958e1b46e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f87c86d3bccf894db3add24893156e8addc63a50a46a814547027decc67e44178ef6ae8432326bc12c734c4740e37e471611ba3efcaa6d1991e022317d4c304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddab773ba7ff4e41bc506ce4cbb3c47f06f370044fd6dd2524d3d5c7f2e442b157b45cb4341491c632092f8e67eaa3e001dfa54ed8140741d1086c98f5b0c130"} 16:04:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:04:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:04:13 INFO - Contents: 16:04:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a0f08ed1c141b74c1199d5ca1726ae76699f49415c567d818ddd03319f19692b43e43a6cd2133fc735d46de4da59d7215388932bcfb05f70f3d8792958e1b46e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f87c86d3bccf894db3add24893156e8addc63a50a46a814547027decc67e44178ef6ae8432326bc12c734c4740e37e471611ba3efcaa6d1991e022317d4c304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddab773ba7ff4e41bc506ce4cbb3c47f06f370044fd6dd2524d3d5c7f2e442b157b45cb4341491c632092f8e67eaa3e001dfa54ed8140741d1086c98f5b0c130"} 16:04:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:04:13 INFO - Copying logs to upload dir... 16:04:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:04:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.037003 ========= master_lag: 17.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-08-30 16:04:31.295682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 16:04:31.296669) ========= 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.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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/a0f08ed1c141b74c1199d5ca1726ae76699f49415c567d818ddd03319f19692b43e43a6cd2133fc735d46de4da59d7215388932bcfb05f70f3d8792958e1b46e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f87c86d3bccf894db3add24893156e8addc63a50a46a814547027decc67e44178ef6ae8432326bc12c734c4740e37e471611ba3efcaa6d1991e022317d4c304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddab773ba7ff4e41bc506ce4cbb3c47f06f370044fd6dd2524d3d5c7f2e442b157b45cb4341491c632092f8e67eaa3e001dfa54ed8140741d1086c98f5b0c130"} build_url:https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011660 build_url: 'https://queue.taskcluster.net/v1/task/BC-4hSxMS3qi2pdHrQBeKQ/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/a0f08ed1c141b74c1199d5ca1726ae76699f49415c567d818ddd03319f19692b43e43a6cd2133fc735d46de4da59d7215388932bcfb05f70f3d8792958e1b46e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f87c86d3bccf894db3add24893156e8addc63a50a46a814547027decc67e44178ef6ae8432326bc12c734c4740e37e471611ba3efcaa6d1991e022317d4c304", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddab773ba7ff4e41bc506ce4cbb3c47f06f370044fd6dd2524d3d5c7f2e442b157b45cb4341491c632092f8e67eaa3e001dfa54ed8140741d1086c98f5b0c130"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 16:04:31.373010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-30 16:04:31.373299) ========= 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.ECYWyin7wX/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.U38YMVj9Ce/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005191 ========= master_lag: 3.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-08-30 16:04:34.651843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 16:04:34.652185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 16:04:34.756244) ========= ========= Total master_lag: 20.86 =========