builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1472703695.9 results: success (0) buildid: 20160831193421 builduid: ba9d864efe6c4596af9292fd32bd0943 revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:35.900174) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:35.900647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:35.900953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:35.924796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:35.925336) ========= 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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-31 21:21:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.79M=0.001s 2016-08-31 21:21:36 (7.79 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:36.162172) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:36.162508) ========= 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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.020061 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:36.242789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 21:21:36.243249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7f7ae14590aced450bb0b0469dfb38edd2c0ace --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 b7f7ae14590aced450bb0b0469dfb38edd2c0ace --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-31 21:21:36,325 truncating revision to first 12 chars 2016-08-31 21:21:36,325 Setting DEBUG logging. 2016-08-31 21:21:36,325 attempt 1/10 2016-08-31 21:21:36,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7f7ae14590a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 21:21:37,947 unpacking tar archive at: mozilla-central-b7f7ae14590a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.884581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 21:21:38.151582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:38.151920) ========= script_repo_revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:38.152880) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:38.153201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 21:21:38.171811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-31 21:21:38.172257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:21:38 INFO - MultiFileLogger online at 20160831 21:21:38 in /builds/slave/test 21:21:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:21:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:21:38 INFO - {'append_to_log': False, 21:21:38 INFO - 'base_work_dir': '/builds/slave/test', 21:21:38 INFO - 'blob_upload_branch': 'Firefox', 21:21:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:21:38 INFO - 'branch': 'Firefox', 21:21:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:21:38 INFO - 'config_files': ('talos/mac_config.py',), 21:21:38 INFO - 'default_actions': ('clobber', 21:21:38 INFO - 'read-buildbot-config', 21:21:38 INFO - 'download-and-extract', 21:21:38 INFO - 'populate-webroot', 21:21:38 INFO - 'create-virtualenv', 21:21:38 INFO - 'install', 21:21:38 INFO - 'run-tests'), 21:21:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:21:38 INFO - 'download_minidump_stackwalk': True, 21:21:38 INFO - 'download_symbols': 'ondemand', 21:21:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:21:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:21:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:21:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:21:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:21:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:21:38 INFO - 'installer_path': 'installer.exe', 21:21:38 INFO - 'log_level': 'info', 21:21:38 INFO - 'log_name': 'talos', 21:21:38 INFO - 'log_to_console': True, 21:21:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:21:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:21:38 INFO - 'opt_config_files': (), 21:21:38 INFO - 'pip_index': False, 21:21:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:38 INFO - 'cmd': ('bash', 21:21:38 INFO - '-c', 21:21:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:38 INFO - 'enabled': True, 21:21:38 INFO - 'halt_on_failure': False, 21:21:38 INFO - 'name': 'check_screen_resolution'},), 21:21:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:21:38 INFO - 'cmd': ('bash', 21:21:38 INFO - '-c', 21:21:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:21:38 INFO - 'enabled': True, 21:21:38 INFO - 'halt_on_failure': False, 21:21:38 INFO - 'name': 'check_screen_resolution'},), 21:21:38 INFO - 'run_cmd_checks_enabled': True, 21:21:38 INFO - 'sps_profile': False, 21:21:38 INFO - 'sps_profile_interval': 0, 21:21:38 INFO - 'suite': 'dromaeojs', 21:21:38 INFO - 'system_bits': '32', 21:21:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:21:38 INFO - 'title': 't-yosemite-r7-0345', 21:21:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:21:38 INFO - 'use_talos_json': True, 21:21:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:21:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:21:38 INFO - 'work_dir': 'build'} 21:21:38 INFO - [mozharness: 2016-09-01 04:21:38.364084Z] Running clobber step. 21:21:38 INFO - Running pre-action listener: _resource_record_pre_action 21:21:38 INFO - Running main action method: clobber 21:21:38 INFO - rmtree: /builds/slave/test/build 21:21:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:21:38 INFO - Running post-action listener: _resource_record_post_action 21:21:38 INFO - [mozharness: 2016-09-01 04:21:38.545020Z] Finished clobber step (success) 21:21:38 INFO - [mozharness: 2016-09-01 04:21:38.545187Z] Running read-buildbot-config step. 21:21:38 INFO - Running pre-action listener: _resource_record_pre_action 21:21:38 INFO - Running main action method: read_buildbot_config 21:21:38 INFO - Using buildbot properties: 21:21:38 INFO - { 21:21:38 INFO - "project": "", 21:21:38 INFO - "product": "firefox", 21:21:38 INFO - "script_repo_revision": "production", 21:21:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:21:38 INFO - "repository": "", 21:21:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:21:38 INFO - "buildid": "20160831193421", 21:21:38 INFO - "pgo_build": "False", 21:21:38 INFO - "basedir": "/builds/slave/test", 21:21:38 INFO - "buildnumber": 87, 21:21:38 INFO - "slavename": "t-yosemite-r7-0345", 21:21:38 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:21:38 INFO - "platform": "yosemite_r7", 21:21:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:21:38 INFO - "branch": "mozilla-central", 21:21:38 INFO - "repo_path": "mozilla-central", 21:21:38 INFO - "revision": "b7f7ae14590aced450bb0b0469dfb38edd2c0ace", 21:21:38 INFO - "stage_platform": "macosx64", 21:21:38 INFO - "builduid": "ba9d864efe6c4596af9292fd32bd0943", 21:21:38 INFO - "slavebuilddir": "test" 21:21:38 INFO - } 21:21:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:21:38 INFO - Running post-action listener: _resource_record_post_action 21:21:38 INFO - [mozharness: 2016-09-01 04:21:38.548454Z] Finished read-buildbot-config step (success) 21:21:38 INFO - [mozharness: 2016-09-01 04:21:38.548587Z] Running download-and-extract step. 21:21:38 INFO - Running pre-action listener: _resource_record_pre_action 21:21:38 INFO - Running main action method: download_and_extract 21:21:38 INFO - mkdir: /builds/slave/test/build/tests 21:21: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')]} 21:21:38 INFO - trying https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:21:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:40 INFO - Downloaded 1199 bytes. 21:21:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:21:40 INFO - Using the following test package requirements: 21:21:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:21:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:21:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:21:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'jsshell-mac.zip'], 21:21:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:21:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:21:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:21:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:21:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:21:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:21:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:21:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:21:40 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')]} 21:21:40 INFO - trying https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:41 INFO - Downloaded 16399848 bytes. 21:21:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:21:48 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 21:21:48 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')]} 21:21:48 INFO - trying https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:21:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:49 INFO - Downloaded 16399848 bytes. 21:21:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:55 INFO - trying https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:21:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:21:57 INFO - Downloaded 14413998 bytes. 21:21:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:21:58 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')]} 21:21:58 INFO - trying https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:21:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:21:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/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 21:22:03 INFO - Downloaded 111601172 bytes. 21:22:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:22:03 INFO - mkdir: /builds/slave/test/properties 21:22:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:22:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:22:03 INFO - Contents: 21:22:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:22:04 INFO - Running post-action listener: _resource_record_post_action 21:22:04 INFO - Running post-action listener: set_extra_try_arguments 21:22:04 INFO - [mozharness: 2016-09-01 04:22:04.502538Z] Finished download-and-extract step (success) 21:22:04 INFO - [mozharness: 2016-09-01 04:22:04.502683Z] Running populate-webroot step. 21:22:04 INFO - Running pre-action listener: _resource_record_pre_action 21:22:04 INFO - Running main action method: populate_webroot 21:22:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:22:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:22:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:22:04 INFO - '--tppagecycles', 21:22:04 INFO - '7'], 21:22:04 INFO - 'tests': ['tsvgm']}}, 21:22:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:22:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:22:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:22:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:22:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:22:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['damp', 'tps']}, 21:22:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'tests': ['damp', 'tps']}, 21:22:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['dromaeo_dom']}, 21:22:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:22:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['basic_compositor_video']}, 21:22:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:22:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'other-e10s': {'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['a11yr', 21:22:04 INFO - 'ts_paint', 21:22:04 INFO - 'tpaint', 21:22:04 INFO - 'sessionrestore', 21:22:04 INFO - 'sessionrestore_no_auto_restore', 21:22:04 INFO - 'tabpaint']}, 21:22:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['tsvgx', 21:22:04 INFO - 'tsvgr_opacity', 21:22:04 INFO - 'tart', 21:22:04 INFO - 'tscrollx', 21:22:04 INFO - 'cart']}, 21:22:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:22:04 INFO - 'tsvgr_opacity', 21:22:04 INFO - 'tart', 21:22:04 INFO - 'tscrollx', 21:22:04 INFO - 'cart']}, 21:22:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'talos_options': ['--disable-e10s'], 21:22:04 INFO - 'tests': ['tp5o']}, 21:22:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'tests': ['tp5o']}, 21:22:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'talos_options': ['--disable-e10s', 21:22:04 INFO - '--xperf_path', 21:22:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:04 INFO - 'tests': ['tp5n']}, 21:22:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:22:04 INFO - 'talos_options': ['--xperf_path', 21:22:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:22:04 INFO - 'tests': ['tp5n']}}, 21:22:04 INFO - 'talos.zip': {'path': '', 21:22:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:22:04 INFO - Running post-action listener: _resource_record_post_action 21:22:04 INFO - [mozharness: 2016-09-01 04:22:04.521484Z] Finished populate-webroot step (success) 21:22:04 INFO - [mozharness: 2016-09-01 04:22:04.521617Z] Running create-virtualenv step. 21:22:04 INFO - Running pre-action listener: _resource_record_pre_action 21:22:04 INFO - Running main action method: create_virtualenv 21:22:04 INFO - Creating virtualenv /builds/slave/test/build/venv 21:22:04 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 21:22:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:22:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:22:04 INFO - Using real prefix '/tools/python27' 21:22:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:22:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:22:08 INFO - Installing pip.................done. 21:22:08 INFO - Return code: 0 21:22:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:08 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:08 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 21:22:08 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 21:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:08 INFO - 'HOME': '/Users/cltbld', 21:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:08 INFO - 'LOGNAME': 'cltbld', 21:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:08 INFO - 'MOZ_NO_REMOTE': '1', 21:22:08 INFO - 'NO_EM_RESTART': '1', 21:22:08 INFO - 'PAGER': '/bin/cat', 21:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:08 INFO - 'PWD': '/builds/slave/test', 21:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:08 INFO - 'SHELL': '/bin/bash', 21:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:08 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:08 INFO - 'USER': 'cltbld', 21:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:08 INFO - 'XPC_FLAGS': '0x0', 21:22:08 INFO - 'XPC_SERVICE_NAME': '0', 21:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:08 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 21:22:08 INFO - Cleaning up... 21:22:08 INFO - Return code: 0 21:22:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:08 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:08 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 21:22:08 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 21:22:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:08 INFO - 'HOME': '/Users/cltbld', 21:22:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:08 INFO - 'LOGNAME': 'cltbld', 21:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:08 INFO - 'MOZ_NO_REMOTE': '1', 21:22:08 INFO - 'NO_EM_RESTART': '1', 21:22:08 INFO - 'PAGER': '/bin/cat', 21:22:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:08 INFO - 'PWD': '/builds/slave/test', 21:22:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:08 INFO - 'SHELL': '/bin/bash', 21:22:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:08 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:08 INFO - 'USER': 'cltbld', 21:22:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:08 INFO - 'XPC_FLAGS': '0x0', 21:22:08 INFO - 'XPC_SERVICE_NAME': '0', 21:22:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:08 INFO - Downloading/unpacking psutil>=3.1.1 21:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:12 INFO - Installing collected packages: psutil 21:22:12 INFO - Running setup.py install for psutil 21:22:12 INFO - building 'psutil._psutil_osx' extension 21:22:12 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 21:22:12 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 21:22:12 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 21:22:12 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 21:22:12 INFO - building 'psutil._psutil_posix' extension 21:22:12 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 21:22:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:22:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:22:12 INFO - ^ 21:22:12 INFO - 1 warning generated. 21:22:12 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 21:22:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:22:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:22:12 INFO - Successfully installed psutil 21:22:12 INFO - Cleaning up... 21:22:13 INFO - Return code: 0 21:22:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:13 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:13 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 21:22:13 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 21:22:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:13 INFO - 'HOME': '/Users/cltbld', 21:22:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:13 INFO - 'LOGNAME': 'cltbld', 21:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:13 INFO - 'MOZ_NO_REMOTE': '1', 21:22:13 INFO - 'NO_EM_RESTART': '1', 21:22:13 INFO - 'PAGER': '/bin/cat', 21:22:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:13 INFO - 'PWD': '/builds/slave/test', 21:22:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:13 INFO - 'SHELL': '/bin/bash', 21:22:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:13 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:13 INFO - 'USER': 'cltbld', 21:22:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:13 INFO - 'XPC_FLAGS': '0x0', 21:22:13 INFO - 'XPC_SERVICE_NAME': '0', 21:22:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:22:13 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 21:22:13 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 21:22:13 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 21:22:13 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 21:22:13 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 21:22:13 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 21:22:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:22:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:22:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:22:15 INFO - Installing collected packages: mozsystemmonitor 21:22:15 INFO - Running setup.py install for mozsystemmonitor 21:22:15 INFO - Successfully installed mozsystemmonitor 21:22:15 INFO - Cleaning up... 21:22:15 INFO - Return code: 0 21:22:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:16 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:16 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 21:22:16 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 21:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:16 INFO - 'HOME': '/Users/cltbld', 21:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:16 INFO - 'LOGNAME': 'cltbld', 21:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:16 INFO - 'MOZ_NO_REMOTE': '1', 21:22:16 INFO - 'NO_EM_RESTART': '1', 21:22:16 INFO - 'PAGER': '/bin/cat', 21:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:16 INFO - 'PWD': '/builds/slave/test', 21:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:16 INFO - 'SHELL': '/bin/bash', 21:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:16 INFO - 'USER': 'cltbld', 21:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:16 INFO - 'XPC_FLAGS': '0x0', 21:22:16 INFO - 'XPC_SERVICE_NAME': '0', 21:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:16 INFO - Downloading/unpacking jsonschema==2.5.1 21:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:22:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:22:18 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 21:22:18 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 21:22:18 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 21:22:18 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 21:22:18 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 21:22:18 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 21:22:19 INFO - Downloading functools32-3.2.3-2.tar.gz 21:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:22:19 INFO - warning: no files found matching '*.txt' 21:22:19 INFO - no previously-included directories found matching 'build' 21:22:19 INFO - no previously-included directories found matching 'dist' 21:22:19 INFO - no previously-included directories found matching '.git*' 21:22:19 INFO - Installing collected packages: jsonschema, functools32 21:22:19 INFO - Running setup.py install for functools32 21:22:19 INFO - warning: no files found matching '*.txt' 21:22:19 INFO - no previously-included directories found matching 'build' 21:22:19 INFO - no previously-included directories found matching 'dist' 21:22:19 INFO - no previously-included directories found matching '.git*' 21:22:19 INFO - Successfully installed jsonschema functools32 21:22:19 INFO - Cleaning up... 21:22:19 INFO - Return code: 0 21:22:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:19 INFO - 'HOME': '/Users/cltbld', 21:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:19 INFO - 'LOGNAME': 'cltbld', 21:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:19 INFO - 'MOZ_NO_REMOTE': '1', 21:22:19 INFO - 'NO_EM_RESTART': '1', 21:22:19 INFO - 'PAGER': '/bin/cat', 21:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:19 INFO - 'PWD': '/builds/slave/test', 21:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:19 INFO - 'SHELL': '/bin/bash', 21:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:19 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:19 INFO - 'USER': 'cltbld', 21:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:19 INFO - 'XPC_FLAGS': '0x0', 21:22:19 INFO - 'XPC_SERVICE_NAME': '0', 21:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:22:19 INFO - Cleaning up... 21:22:19 INFO - Return code: 0 21:22:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:22:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:19 INFO - 'HOME': '/Users/cltbld', 21:22:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:19 INFO - 'LOGNAME': 'cltbld', 21:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:19 INFO - 'MOZ_NO_REMOTE': '1', 21:22:19 INFO - 'NO_EM_RESTART': '1', 21:22:19 INFO - 'PAGER': '/bin/cat', 21:22:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:19 INFO - 'PWD': '/builds/slave/test', 21:22:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:19 INFO - 'SHELL': '/bin/bash', 21:22:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:19 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:19 INFO - 'USER': 'cltbld', 21:22:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:19 INFO - 'XPC_FLAGS': '0x0', 21:22:19 INFO - 'XPC_SERVICE_NAME': '0', 21:22:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:22:19 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 21:22:19 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 21:22:19 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 21:22:19 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 21:22:19 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 21:22:19 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 21:22:22 INFO - Downloading blobuploader-1.2.4.tar.gz 21:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:22:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:22:22 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 21:22:22 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 21:22:22 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 21:22:22 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 21:22:22 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 21:22:22 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 21:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:22:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:22:23 INFO - Downloading docopt-0.6.1.tar.gz 21:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:22:23 INFO - Installing collected packages: blobuploader, requests, docopt 21:22:23 INFO - Running setup.py install for blobuploader 21:22:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:22:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:22:23 INFO - Running setup.py install for requests 21:22:24 INFO - Running setup.py install for docopt 21:22:24 INFO - Successfully installed blobuploader requests docopt 21:22:24 INFO - Cleaning up... 21:22:24 INFO - Return code: 0 21:22:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:24 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')]} 21:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:24 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')]} 21:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:24 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:24 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 21:22:24 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 21:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:24 INFO - 'HOME': '/Users/cltbld', 21:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:24 INFO - 'LOGNAME': 'cltbld', 21:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:24 INFO - 'MOZ_NO_REMOTE': '1', 21:22:24 INFO - 'NO_EM_RESTART': '1', 21:22:24 INFO - 'PAGER': '/bin/cat', 21:22:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:24 INFO - 'PWD': '/builds/slave/test', 21:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:24 INFO - 'SHELL': '/bin/bash', 21:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:24 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:24 INFO - 'USER': 'cltbld', 21:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:24 INFO - 'XPC_FLAGS': '0x0', 21:22:24 INFO - 'XPC_SERVICE_NAME': '0', 21:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:22:24 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Rcs79U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:22:24 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-f2dOqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:22:24 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Yk3mc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5lCdA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-yCg6JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-rcG6od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-oP4V_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FpACNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-K3RVt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-omw5b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GdqajG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:22:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:22:25 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-UdP9pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:22:26 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0GluAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:22:26 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Zr_jVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:26 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FGmqE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:22:26 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-hUdH0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:22:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:22:26 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-KHRazE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:22:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:22:26 INFO - Running setup.py install for manifestparser 21:22:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:22:26 INFO - Running setup.py install for mozcrash 21:22:26 INFO - Running setup.py install for mozdebug 21:22:26 INFO - Running setup.py install for mozdevice 21:22:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Running setup.py install for mozfile 21:22:27 INFO - Running setup.py install for mozhttpd 21:22:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Running setup.py install for mozinfo 21:22:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Running setup.py install for mozInstall 21:22:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:22:27 INFO - Running setup.py install for mozleak 21:22:27 INFO - Running setup.py install for mozlog 21:22:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Running setup.py install for moznetwork 21:22:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Running setup.py install for mozprocess 21:22:28 INFO - Running setup.py install for mozprofile 21:22:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Running setup.py install for mozrunner 21:22:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:22:28 INFO - Running setup.py install for mozscreenshot 21:22:28 INFO - Running setup.py install for moztest 21:22:28 INFO - Running setup.py install for mozversion 21:22:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:22:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:22:29 INFO - Cleaning up... 21:22:29 INFO - Return code: 0 21:22:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:29 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:29 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 21:22:29 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 21:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:29 INFO - 'HOME': '/Users/cltbld', 21:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:29 INFO - 'LOGNAME': 'cltbld', 21:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:29 INFO - 'MOZ_NO_REMOTE': '1', 21:22:29 INFO - 'NO_EM_RESTART': '1', 21:22:29 INFO - 'PAGER': '/bin/cat', 21:22:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:29 INFO - 'PWD': '/builds/slave/test', 21:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:29 INFO - 'SHELL': '/bin/bash', 21:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:29 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:29 INFO - 'USER': 'cltbld', 21:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:29 INFO - 'XPC_FLAGS': '0x0', 21:22:29 INFO - 'XPC_SERVICE_NAME': '0', 21:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0HQ7TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:22:29 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)) 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5__9mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:22:29 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)) 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-KYvUwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:22:29 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)) 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fGuVZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:22:29 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)) 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fxh1wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:22:29 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)) 21:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:22:29 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xsaYWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ejnLIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Ghw5EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-AmBIGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-RwQSrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GpuZgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HHBAF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-AqqPDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9TcK7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FUcIdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:22:30 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)) 21:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:22:30 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-XDxEtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:22:31 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)) 21:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:22:31 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fDdEc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:22:31 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)) 21:22:31 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)) 21:22:31 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)) 21:22:31 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)) 21:22:31 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)) 21:22:31 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)) 21:22:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22: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 21:22:33 INFO - Downloading blessings-1.6.tar.gz 21:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:22:33 INFO - Installing collected packages: blessings 21:22:33 INFO - Running setup.py install for blessings 21:22:33 INFO - Successfully installed blessings 21:22:33 INFO - Cleaning up... 21:22:33 INFO - Return code: 0 21:22:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:22:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:22:34 INFO - Reading from file tmpfile_stdout 21:22:34 INFO - Current package versions: 21:22:34 INFO - blessings == 1.6 21:22:34 INFO - blobuploader == 1.2.4 21:22:34 INFO - docopt == 0.6.1 21:22:34 INFO - functools32 == 3.2.3-2 21:22:34 INFO - jsonschema == 2.5.1 21:22:34 INFO - manifestparser == 1.1 21:22:34 INFO - mozInstall == 1.12 21:22:34 INFO - mozcrash == 0.17 21:22:34 INFO - mozdebug == 0.1 21:22:34 INFO - mozdevice == 0.48 21:22:34 INFO - mozfile == 1.2 21:22:34 INFO - mozhttpd == 0.7 21:22:34 INFO - mozinfo == 0.9 21:22:34 INFO - mozleak == 0.1 21:22:34 INFO - mozlog == 3.3 21:22:34 INFO - moznetwork == 0.27 21:22:34 INFO - mozprocess == 0.23 21:22:34 INFO - mozprofile == 0.28 21:22:34 INFO - mozrunner == 6.12 21:22:34 INFO - mozscreenshot == 0.1 21:22:34 INFO - mozsystemmonitor == 0.3 21:22:34 INFO - moztest == 0.7 21:22:34 INFO - mozversion == 1.4 21:22:34 INFO - psutil == 3.1.1 21:22:34 INFO - requests == 1.2.3 21:22:34 INFO - wsgiref == 0.1.2 21:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:22:34 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')]} 21:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:34 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')]} 21:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:34 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:34 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 21:22:34 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 21:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:34 INFO - 'HOME': '/Users/cltbld', 21:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:34 INFO - 'LOGNAME': 'cltbld', 21:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:34 INFO - 'MOZ_NO_REMOTE': '1', 21:22:34 INFO - 'NO_EM_RESTART': '1', 21:22:34 INFO - 'PAGER': '/bin/cat', 21:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:34 INFO - 'PWD': '/builds/slave/test', 21:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:34 INFO - 'SHELL': '/bin/bash', 21:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:34 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:34 INFO - 'USER': 'cltbld', 21:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:34 INFO - 'XPC_FLAGS': '0x0', 21:22:34 INFO - 'XPC_SERVICE_NAME': '0', 21:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 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)) 21:22:34 INFO - Cleaning up... 21:22:34 INFO - Return code: 0 21:22:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:22:34 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')]} 21:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:34 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')]} 21:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:22:34 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 0x106f71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107006618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91035cbde0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, '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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 21:22:34 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 21:22:34 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 21:22:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:22:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:22:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:22:34 INFO - 'HOME': '/Users/cltbld', 21:22:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:22:34 INFO - 'LOGNAME': 'cltbld', 21:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:22:34 INFO - 'MOZ_NO_REMOTE': '1', 21:22:34 INFO - 'NO_EM_RESTART': '1', 21:22:34 INFO - 'PAGER': '/bin/cat', 21:22:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:22:34 INFO - 'PWD': '/builds/slave/test', 21:22:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:22:34 INFO - 'SHELL': '/bin/bash', 21:22:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:22:34 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:22:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:22:34 INFO - 'USER': 'cltbld', 21:22:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:22:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:22:34 INFO - 'XPC_FLAGS': '0x0', 21:22:34 INFO - 'XPC_SERVICE_NAME': '0', 21:22:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:22:34 INFO - Cleaning up... 21:22:34 INFO - Return code: 0 21:22:34 INFO - Running post-action listener: _resource_record_post_action 21:22:34 INFO - Running post-action listener: _start_resource_monitoring 21:22:34 INFO - Starting resource monitoring. 21:22:34 INFO - [mozharness: 2016-09-01 04:22:34.820513Z] Finished create-virtualenv step (success) 21:22:34 INFO - [mozharness: 2016-09-01 04:22:34.821353Z] Running install step. 21:22:34 INFO - Running pre-action listener: _resource_record_pre_action 21:22:34 INFO - Running main action method: install 21:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:22:35 INFO - Reading from file tmpfile_stdout 21:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:22:35 INFO - Reading from file tmpfile_stdout 21:22:35 INFO - Output received: 21:22:35 INFO - Usage: mozinstall [options] installer 21:22:35 INFO - Options: 21:22:35 INFO - -h, --help show this help message and exit 21:22:35 INFO - -d DEST, --destination=DEST 21:22:35 INFO - Directory to install application into. [default: 21:22:35 INFO - "/builds/slave/test"] 21:22:35 INFO - --app=APP Application being installed. [default: firefox] 21:22:35 INFO - mkdir: /builds/slave/test/build/application 21:22:35 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'] 21:22:35 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 21:23:10 INFO - Reading from file tmpfile_stdout 21:23:10 INFO - Output received: 21:23:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - [mozharness: 2016-09-01 04:23:10.805857Z] Finished install step (success) 21:23:10 INFO - [mozharness: 2016-09-01 04:23:10.805959Z] Running run-tests step. 21:23:10 INFO - Running pre-action listener: _resource_record_pre_action 21:23:10 INFO - Running main action method: run_tests 21:23:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:23:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:23:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:23:10 INFO - 2016-08-31 21:23:10.818 screenresolution[1910:9414] starting screenresolution argv=screenresolution get 21:23:10 INFO - 2016-08-31 21:23:10.821 screenresolution[1910:9414] Display 0: 1600x1200x32@60 21:23:10 INFO - 2016-08-31 21:23:10.826 screenresolution[1911:9417] starting screenresolution argv=screenresolution list 21:23:10 INFO - Available Modes on Display 0 21:23:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:23:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:23:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:23:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:23:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:23:11 INFO - Intel Iris: 21:23:11 INFO - Chipset Model: Intel Iris 21:23:11 INFO - Type: GPU 21:23:11 INFO - Bus: Built-In 21:23:11 INFO - VRAM (Dynamic, Max): 1536 MB 21:23:11 INFO - Vendor: Intel (0x8086) 21:23:11 INFO - Device ID: 0x0a2e 21:23:11 INFO - Revision ID: 0x0009 21:23:11 INFO - Displays: 21:23:11 INFO - Display: 21:23:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:23:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:23:11 INFO - Display Serial Number: 1600x1200 60 21:23:11 INFO - Main Display: Yes 21:23:11 INFO - Mirror: Off 21:23:11 INFO - Online: Yes 21:23:11 INFO - Rotation: Supported 21:23:11 INFO - Return code: 0 21:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:23:11 INFO - Python 2.7.3 21:23:11 INFO - Return code: 0 21:23:11 INFO - grabbing minidump binary from tooltool 21:23:11 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')]} 21:23:11 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 0x106ed5d30>, '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 0x106c3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ecdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:23:11 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 21:23:11 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 21:23:11 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 21:23:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:23:11 INFO - Return code: 0 21:23:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:23:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:23:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:23:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:23:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t2ln2r9FaL/Render', 21:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:23:11 INFO - 'HOME': '/Users/cltbld', 21:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:23:11 INFO - 'LOGNAME': 'cltbld', 21:23:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:23:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:23:11 INFO - 'MOZ_NO_REMOTE': '1', 21:23:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:23:11 INFO - 'NO_EM_RESTART': '1', 21:23:11 INFO - 'PAGER': '/bin/cat', 21:23:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:23:11 INFO - 'PWD': '/builds/slave/test', 21:23:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:23:11 INFO - 'SHELL': '/bin/bash', 21:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yOuNe6Cwxm/Listeners', 21:23:11 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 21:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:23:11 INFO - 'USER': 'cltbld', 21:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:23:11 INFO - 'XPC_FLAGS': '0x0', 21:23:11 INFO - 'XPC_SERVICE_NAME': '0', 21:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:23:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:23:11 INFO - mozversion application_buildid: 20160831193421 21:23:11 INFO - mozversion application_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 21:23:11 INFO - mozversion application_display_name: Nightly 21:23:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:23:11 INFO - mozversion application_name: Firefox 21:23:11 INFO - mozversion application_remotingname: firefox 21:23:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:23:11 INFO - mozversion application_vendor: Mozilla 21:23:11 INFO - mozversion application_version: 51.0a1 21:23:11 INFO - mozversion platform_buildid: 20160831193421 21:23:11 INFO - mozversion platform_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 21:23:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:23:11 INFO - mozversion platform_version: 51.0a1 21:23:11 INFO - using testdate: 1472703791 21:23:11 INFO - actual date: 1472703791 21:23:11 INFO - starting webserver on 'localhost:49459' 21:23:11 INFO - SUITE-START | Running 2 tests 21:23:11 INFO - TEST-START | dromaeo_css 21:23:11 INFO - operating with platform_type : mac_ 21:23:11 INFO - Initialising browser for dromaeo_css test... 21:23:11 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpmDp8HC/profile http://localhost:49459/getInfo.html) 21:23:13 INFO - PROCESS | 1921 | __metrics Screen width/height:1600/1200 21:23:13 INFO - PROCESS | 1921 | colorDepth:24 21:23:13 INFO - PROCESS | 1921 | Browser inner width/height: 1024/689 21:23:13 INFO - PROCESS | 1921 | __metrics 21:23:13 INFO - PROCESS | 1921 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:23:13 INFO - PROCESS | 1921 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:14 INFO - TEST-INFO | 1921: exit 0 21:23:14 INFO - Browser initialized. 21:23:14 INFO - Running cycle 1/1 for dromaeo_css test... 21:23:14 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpmDp8HC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:26 INFO - PROCESS | 1923 | RSS: Main: 233869312 21:23:26 INFO - PROCESS | 1923 | 21:24:17 INFO - PROCESS | 1923 | 1472703857729 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] 21:26:29 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49459/tests/dromaeo/cssquery-ext.html) 21:26:31 INFO - PROCESS | 1923 | RSS: Main: 333189120 21:26:31 INFO - PROCESS | 1923 | 21:29:34 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-ext.html (next: http://localhost:49459/tests/dromaeo/cssquery-jquery.html) 21:29:35 INFO - PROCESS | 1923 | RSS: Main: 368902144 21:29:35 INFO - PROCESS | 1923 | 21:32:37 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49459/tests/dromaeo/cssquery-mootools.html) 21:32:38 INFO - PROCESS | 1923 | RSS: Main: 329777152 21:32:38 INFO - PROCESS | 1923 | 21:35:40 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49459/tests/dromaeo/cssquery-prototype.html) 21:35:41 INFO - PROCESS | 1923 | RSS: Main: 364875776 21:35:41 INFO - PROCESS | 1923 | 21:38:44 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49459/tests/dromaeo/cssquery-yui.html) 21:38:45 INFO - PROCESS | 1923 | RSS: Main: 326430720 21:38:45 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:49459/tests/dromaeo/cssquery-yui.html (next: http://localhost:49459/tests/dromaeo/cssquery-dojo.html) 21:41:48 INFO - PROCESS | 1923 | RSS: Main: 425390080 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | __start_tp_report 21:41:48 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 21:41:48 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 21:41:48 INFO - PROCESS | 1923 | |i|pagename|runs| 21:41:48 INFO - PROCESS | 1923 | |0;dojo.html;3267.264865405283;3291.2594666200102;3314.0057982605213;3329.900102996911;3372.814495202764;4544.3183522471645;5502.147167189092;5558.194061861028;5630.211770352149;5660.2075709400715;5614.9157762633595;5616.466435688613;5708.08670612701;5735.397783232763;5760.337561180466;5049.368828896388;5106.183010718286;5107.616928730342;5120.539151476366;5242.748257947577;5211;5229.7385130743505;5230.163173892159;5245.921311180336;5245.973770131163;5057.49425057495;5107.948920510785;5116.513931176532;5117.795288188468;5161.329027226437;5061.291419201315;5142.74286285688;5153.768080436389;5211.478852114796;5212.374515058179;5040.092783299005;5090.77091530882;5101.183810590325;5135.460776618439;5139.331886854685;5651.434856514356;5652.463016013472;5684.261046063985;5686.578355411148;5734.283214598176;6055.122007308915;6064.710158638488;6133.1413602095745;6142.989934931851;6175.382461753834;6161.7535298588;6253.624782513064;6263.404976527223;6289.748410063592;6290.308066112724;5757.68332741699;5765.596408251466;5773.1051686988585;5773.422657734277;5774.913376299359;6200.472959798378;6225.564210505312;6273.99616061428;6292.685365731695;6340.714667839959;6056.065804653647;6060.515158787286;6072.666003369769;6100.49335636658;6113.113598528189;6111;6161.4454699076405;6168.321484636686;6170.321264660884;6189.071639254058;6019.638821670714;6042.909356359658;6085.695715214221;6089.208402907594;6123.326434092246;6122.61138576932;6164.938350616437;6173.444390004831;6174.38256174379;6177.4749146323065;4908.410990681141;4909.189983652729;4917.483664215206;4920.237363208708;4940.283658869444;3766.851110411296;4398.934015989763;4400.823967041282;4453.621442177451;4468.620167285752;5708.029634962067;5715.199872017921;5735.598508104476;5754.539636829044;5772.422757724278;6215.875682486325;6244.718987645567;6248.4376406123665;6261.592996455307;6278.623282603058;5567.415421380697;5618.185363122406;5631.352394474606;5704.286964129484;5725.1698503716725;5348.545373643206;5358.946410535845;5379.784808607612;5384.246205531229;5424.83725488236;6296.338884417162;6319.6208227506495;6327.303996560283;6342.334054924258;6363.90454143179;5246.816361427332;6120.8775824484155;6197.163382943245;6202.658853763086;6232.626042437469;6221.035739460391;6245.750169993149;6278.340774218824;6282.874342513215;6284.74861005573;5078.5175408336145;6018.91659501294;6118.388161183846;6134.613751167758;6141.7543298267565;6125.081237814185;6183.907241391293;6194.163787888578;6202.627842329474;6206.503479721521;5821.243238379153;5866.50134738552;5943.108533719977;5957.6127551709;5977.491913187428;5963.224780778471;5982.641041537521;5995.16067750524;6005.699715014319;6011.21854158974;5779.190913272061;5802.274715660543;5807.593468457168;5816.76732930678;5843.532517398513;4920.82777102814;5856.648601083949;5865.3254875688135;5892.469677729025;6047.183630210041;5767.538596912321;5799.333076696234;5812.593118481665;5816.76732930678;5817.476427121579 21:41:48 INFO - PROCESS | 1923 | |1;ext.html;429.0389527458493;469.01740852913133;500.74211780932825;515.7472838309229;520.0924386944782;29990.400191996174;30015.699843001592;31683.99999999997;31690.890818821346;38816.22367552654;39166.629167979125;41542.37686434706;41746.37380439288;41790.791046044804;41845.7907710461;9547.045295470467;9725.465099419529;9742.756431089245;9746.707598772047;9760.41437513748;8758.781030474225;8868.733937981871;9552.71341859742;9681.564329605184;11619.244749091324;11697.485040716245;11921.523139074427;12104.697382565419;12115.93942030293;12119.454624541873;12033.338166400845;12098.334591597459;12101.697457563587;12126.939365303206;12151.331676757774;11701.70745731355;11769.470373833197;11781.175317727762;11800.232984855957;11802.881971180264;38799;38998;39022.804885975675;39099.60900390988;39136.41295380572;2757.655293088344;3440.3291358185165;3528.2414280929465;3695.61196074411;4053.209624123297;29306.41387172266;29921.102366929026;30317;30381.392372152433;30636.234094147825;3139.3015253300227;3184.8726050958167;3209.5667084943702;3246;3350.509023484526;483448;486048;487839;488882;496116.9999999964;32422.189445263586;52934;53195;53281;53325.933481330154;32964.50553241703;34304.313913722086;34379.312413751584;34404.65595344065;34408.65591344105;14305.281996420646;14391.568252952427;14422.42310307576;14451.49419770303;14467.49363772284;12135.393230338448;12229.3273869938;12239.632811015685;12257.958073563668;12282.201656892274;7209.567425954459;7335.816604584928;7476;7650.693972241159;7654.885176722353;3182.7931184472936;3227.790193637406;3234.2884565395575;3240.2709390386976;3257.609086909586;846.191886748154;887.3877024852831;895.7760559860035;988.1650005745134;1021.6322124035341;27987.44025119486;28547.857260713565;29651.55522667162;29760.702392975792;30005.849970750005;1023.9385636861812;1041.0162396535202;1067.8771941226703;1079.6653037558383;1155.734181138326;14602.561923142322;15135;15150.469733559494;15535.76696349533;15603;630841;638786;639073.8046309832;639169;639771;54838.177427338625;55192;55286.447135528935;55291.72354138204;55317.89364212693;1202.7053371923935;1308.228145394241;1317.4532568983957;1334.3461703765086;1337.2778699502549;25760.227193184233;29322.413551729274;29607.85196074006;30065.3986920256;30265.37268554322;46098.76950615225;46553.3017004752;46604.7669761649;46687;46807.76596116998;534496.3275183755;536175;536368;537551;538485;25734.356641084123;25842.741572584033;26255.949762009306;26400.471990559698;27250;42255.577444226394;42365.78817106018;42943.141137176455;43282.56717432912;43520.56479435165;35896;36124.819375904;36204.81897590495;37113.814430927676;37118.44322335221;35455;36092.819535902156;36875.26249475049;36899.44650830186;36942.445863311536;35046.82476587601;35205;35692.28615427625;35699.82150089337;36015.63984360123;29536.852315738284;29827.481915845638;33021.83489082539;33581;34054.65945340614;24670.850739472346;24739.25782226536;24904.875475622506;24972;25469.872650637368 21:41:48 INFO - PROCESS | 1923 | |2;jquery.html;353.0802260112409;369.2209438085639;373.268393947862;387.3685891996047;404.1774987899623;15382.461613843518;16150.273237704303;20560.971951402444;20723.963801809925;20750.48123796906;20891.791082089174;21123.47191320218;21312;21334;21671.45821354467;5752.137179423089;5793.797217097382;5928.525717942554;5955.719520303134;6045.244344456943;5865.178874957509;5959.165716799652;5967.671778052206;5974.223350964368;5979.2824861016525;4082.9183416331657;5007.599392048645;6584.9012264816065;6586.077949087132;6652.467802575782;6412.807615771534;6451.3548645135115;6597.47220222381;6606.339366063403;6621.834454138637;5666.178404131378;5717.313922329347;5717.685527295997;5721.628094173865;5733.9678857805575;25892;25999;26026.958921643112;26160.8691956539;26253.606195907076;2167.642339014061;2235.474663454087;2298.689676893615;2350.847194932341;2487.2662564543502;14683.926580367137;15713.13577753223;15930.442434514736;15944.760828587581;16207.83792162075;1825.1148193126323;1840.7054871220673;1882.9435116946513;1896.781870084944;1955.8337541309006;74125;94252.99999999932;97787;98014;113234;9011.369204155646;10874.18443616732;10884.455777211107;11193.160512961398;11672.88327116735;13920.930395347958;13950.232737199349;13961.441542338396;13972.161670299814;13972.860271397156;8299.709510167115;8651.6971905983;8664.696735614349;8794.252488538417;8795.164459376349;8547.529885856213;8653.17794809492;8673.52295623734;8676.481615717224;8860.822783544292;6645.867082658319;6742.9662851685425;6748.11983109704;6752.459803215731;6783.389494945479;1817.2190412090924;1841.042657817954;1843.7234414837612;1850.7964123946356;1851.7685289338833;828.1925123005142;856.2550580994574;882.75282920781;912.8904531456135;975.8731364922514;20769.27307544229;21017.264395746075;21965;22772.975216115316;22855.885720571292;924.1082355526949;948.3882895532481;948.5873644964463;1011.9291649584605;1039.4698703661188;11509.02173315261;11831;11986.700332491757;12022.158448908667;12047.33739644328;562154;563601;571766;580142;584366;113117.43441282741;117982;121000.39499802445;122566;141873;996.7707427291764;998.4259051045677;1065.8454524093963;1067.1302888146136;1067.1356201476829;19332.03339833031;19616.921069341322;19688.80311196927;19754.60490790205;19875;45851.541484584726;50952.72618184575;53650.73174634258;56062.59843503782;56395.71802140963;82542.17457825344;83652.58173709092;85569.28861422862;85710;87820.33976262734;6473.676316184078;7862.449628526177;8159.551224682699;8277.751667449986;8498.787530311793;9409.905900940903;10393.480325983519;12335.568255111388;13513.391897364445;13546.119502232323;9300.302477314093;11111.444427778417;11489.597864074718;11560.30638161713;11673.883261167619;10706.518206680874;11113.722156946142;11298.209125361474;11469.197156198987;11535.711607209887;11027.17296202772;11369.772604548029;11452.141089418494;11606.76786464249;11752.412379380825;7095.432365410858;7344.96327518359;7484.550926944401;7778.649960751893;8542.821580496933;9907.554160062671;11235.55057797679;11754.412279386168;11815;11838.644840654793 21:41:48 INFO - PROCESS | 1923 | |3;mootools.html;1312.1930013041979;1335.5993202039385;1485.0792508644643;1648.3818568036986;1896.6396384686916;7424.368928641072;7678.385729141669;8612.91387086129;8843.513606751627;8879.955600222005;8653.826923461527;8722.040575536701;8817.647294108228;8831.823363532741;8837.779055523599;2373;2393.5930891748444;2402.1112188490283;2402.5074859653814;2417.9395515112087;1981.187713037655;2352.8588284702887;2395.784379405853;2401.2076014915124;2412.867292298923;2359.138914296278;2380.155044959032;2386.486905315357;2392.449736560592;2392.7846493815555;2323.4772176260376;2345.2026311054237;2348.0607756897207;2350.0834674477055;2391.330427480291;1977.7527809023873;2360.138549429463;2369.561631098235;2373.1931143411152;2377.405648587853;8683.044865064838;8792.47245165292;8810.823783524358;8820.162084601952;8877.911220887838;5147.562457191143;5324.1215199492035;5338.706371149585;5364.061289274361;5374.731263436813;3349.342075672533;3532.8233588320736;3567.678908898212;3590.982045089784;3595.8202089895663;998.5007496251874;1029.541853875026;1031.448175226258;1051.2063392138962;1051.9263651544395;11478.024367928736;11529.884701152965;11608.825867611993;11611.361375124365;11661.300321980709;4075.0219947212454;4108.5275193352545;4384.978075109604;4560.270356742905;4567.520410356865;9092.408993415407;9105.408148470327;9106.31702622306;9108.772280692903;9112.589933453011;5207.895842083137;5208.479152084761;5209.6874187548865;5210.21846722987;5215.322008138994;4386.8025938832825;4415.558444155558;4518.254488009507;4691.296305554194;4848;3618.738288569644;3674.9816250919107;3772.6227377262053;3787.3750831112557;3791.696664266852;1118.6028959719345;1138.9237170873446;1147.8106112491512;1149.6148790155391;1149.8620165580016;867.7613656244583;871.1201686296886;877.1929824561291;904.6291020681489;943.3962264150949;5528.419515950848;5561.443855614406;5870.240986736228;5955.225820643289;5971.581989260797;367.6507318047865;422.1493690214221;442.0209236541077;443.7359770936288;450.16719069720756;3859.305325041463;3875.534935807721;3911.882643520699;3971.146203566247;3982.5818289079807;9000.729978100668;10378.377297362182;10733.946330268298;10742.08692261151;10809.459527023617;10742.08692261151;10746.785064298827;10768.623098191525;10771.89228107709;10791.514381852836;7855.4893931895385;8137.511749295061;8279.710210142615;8281.627326770189;8283.130271321545;4540.818367265272;5758.568107391879;5796.884062318814;5821.214136091573;5838.4453476919625;8290.29532489721;9749.56126974302;9882.802343952937;10097.242706796873;10185.439800811026;10048.54781534818;10055.69832905014;10213.489325533843;10251.487425628839;10373.792524149323;6515.804525864231;6642.501812363996;6956.721731130698;7040.119985001875;7052.0832291801735;8316.875246871423;8375.120612335617;8468.195521425454;8478.788030299293;8492.065872754116;7353.191148973716;7448.068991376078;7504.1370242420635;7521.4734968551675;7612.1246056701975;7363.668634911334;7378.889316660362;7387.335139837441;7400.666969986256;7452.441066919894;6892.414144797748;6941.167059952838;6965.686544105426;6971.755988540377;6980.616066116209;4908.361912951294;4963.53575695178;4983.601311895112;4984.1526940420945;5047.444781074006;4355.519123498026;4865.659403841697;4902.436219834622;4986.775595098156;5134.383873935151 21:41:48 INFO - PROCESS | 1923 | |4;prototype.html;284.10365297486436;297.32210559923374;304.32743636563197;308.70981277599043;309.73981855241607;4535.931961020588;4547.112948126528;4963.726995015273;5219.634625576211;5555.472230138141;4415.873952142199;4430.911381772371;5428.728563571815;5456.262460214755;5465.617406781527;4145.54399016108;4150.501939767232;4151.626353628173;4195;4213.47331583552;3505.2999295341738;3618.764780289286;4107.925497623696;4213.578642135777;4219.303814870543;3636.236390358028;3946.940795888064;4099.692523060782;4103.507579090498;4181;3455.4644030175364;4082.81627326771;4096.262672718909;4107.732997355162;4111.71218014739;3095;3433.6051354094348;3572.356975744365;3573.1053152064114;3573.767705099186;4987.905079866465;5310.654807437543;5331;5374.946250537484;5415.512603865671;4120.773357465338;4626.635142632931;4684.4378674559275;4707.411573553306;4740.762961851928;5803.680797556132;5817.418258174191;5823.737931793079;5867.973104706702;5882.088276317135;3643.8360273787744;3895.9610403896163;3897;3904.941425878614;3909.7654140751647;5194.844154675366;5889.882202355929;5917.6449413034925;5928.7924922627935;6015.1428071665605;3797.525309336333;3886.300465916162;3896.5518965318784;3903.1803321302277;3907.0037140528984;3350.011746534778;3841.558220804643;3968.146848427602;3987.9232607195895;4011.659008984269;3866.478025466582;4056.269871423172;4385.3641222022625;4478.39541661878;4674.74288914113;5774.913376299359;5794.710264486759;5810.099434587646;5815.73829177688;5839.182514447981;1334.3995202159067;1357.5384369314481;1361.2309045389322;1362.0397619678104;1383.1770096792393;762.6529928882345;769.7036640893184;776.6116941529235;796.9561674107864;813.2558708781517;3892.377219644843;4423.748544819555;4487.192305384997;4577.382053422812;4656.46108957195;4220.07158425146;4565.3836732040745;4624.445066591963;4713.74074425903;4801.991581767798;3851.6533511984057;4505.504394516601;4518.683692141519;4567.6802623816675;4590.816367345269;2796.678381986057;2818.25316291183;3151.9684803152136;3152.0543836848856;3159.7472202223767;6162.859870923893;6168.290646575701;6174.905702795212;6182.567220294626;6208.671748094464;5131.461196574381;5744;5786.842631473638;5816;6132.320607635473;6142.938570614237;6169.907451388232;6187.504999600022;6211.782587609412;6268.968655156695;5601.467860553241;6054.878902421839;6058.5153187745755;6082.422169893853;6087.969560152171;5670.574706896917;5877.382874798255;5930.377310382348;5946.762129514944;5970.373110823301;5334.733263336895;5602.85992850182;6000.729967151576;6076.635401875901;6180.969095154495;3911.7457365271166;3942.901427464222;3947.427622994592;3949.466821978996;3992.2414741199077;4958.380382320998;5596;5904.793332233351;5969.970150149222;6022.6386416813375;4879.463259041574;4997.325895824939;5044.848654540369;5464.1257398816;5847.649141051551;5544.3346798384455;5781.479666830005;5823.5923485355615;5861.531077513703;5887;5127.923081153711;5320.44135365781;5646.096624540054;5712.7714891403875;5721.7425215866215;5460.890782184413;5859.648421094748;5866.442687944638;5873.4126587340925;5875.294964604275;5496.422875598005;5736.340320863154;5765.682887441231;5766.740496677576;5774.133879918046 21:41:48 INFO - PROCESS | 1923 | |5;yui.html;703.6200451756052;713.9928600713993;754.2080815144097;757.1482082657011;854.8333075050366;15009.699806003873;15706.45027424039;15713.057216566986;15715.764263536055;15806.814488913335;13830.792538111911;13927.930360348184;13959.232242226673;13960;14373.640658983531;661.1042038038461;805.4040010392312;818.153211426174;843.6541018182546;844.8986121665408;832.4089896173693;834.7161964931922;834.8288600836814;835.1606635331483;835.4026870787386;885.7918389178537;886.2024178239603;886.6940905387631;887.414306557672;887.5828360670474;696.2376198063088;865.3726048614767;880.4717169698162;883.0286684646901;889.937704360695;657.628439931442;658.2824721054026;658.5159907468008;658.5488940076063;660.4188314283448;14404.63988400288;14444.711105777931;14456.56630301082;14470.49353272641;14480.710385792225;13471.932640336834;13694.315284235849;13753.931230343784;13794.448222071105;13984.440622375092;12663.620091397273;12710.555130570478;12836.743265134644;12856.55002074923;12873.613791586267;4438.733675979452;4563;4570.702904311209;4576.656750743708;4669.2062349400685;118632;120032;120630.19054714186;123971.38014309961;125937.74062259351;10699.465026748632;10909.290896091728;11188.629457860272;11304.321740695585;11310.434478276053;21755.67366489504;21969.67045494319;21991.340259792232;22012.889935550218;22103.778962210174;7812.140664526897;7828.256315650005;7861.882071768928;7914.406419518559;7918.6436610352675;4263.765492897858;4268.423762792046;4312.741235525878;4414.668899832525;4458.621017213508;3392.6437724039115;3496.2133519957806;3497.4928635347733;3500.9474857877153;3509.192885636318;524.4545672500633;635.9841003974846;643.157463722525;643.3566433566433;644.7034364192524;525.3459442993498;546.4999525434183;619.3373090792899;667.8764428580728;691.9031335613018;8858.335624828034;9128.49793261377;9250.537473126316;9298.488583127993;9476.478793666276;566.9348024977098;600.3096439095076;611.7950486587043;643.7714611312916;650.6844180572418;4161.375793630979;4634.652401069933;4742.33607294979;4745.240761478147;4764.894656062486;92005.07994919964;110838;142957;154330.22834885755;156512;58365.70817145887;122443;129456;131671;136395;110634.89365106246;110776.89223107827;111078.44460777644;112788;116409.41795291139;8826.205641492297;8866.512341821004;8873.73378798637;8908.10918908104;9209.907900921173;61806.0729089055;62237.68881155565;62896.74206515752;63649.727005458706;63967.502098573415;90535.54732226297;100403.49798250962;100895.99104008866;102453;102555.97444025465;11515.424228788359;11940.462679179283;12317.93841030825;12415.813762793385;12559.120861539604;12846.894609935422;13139.737205256033;13193.934030329787;13335.599932002055;13456.327183640975;12155.392230388623;12252.264864108181;12267.938660306641;12393.380330983235;12676.492940282285;11945.641630750744;12251.448684809384;12336;12343.506259749509;12449.564265250672;11593.130515211224;11891.881081189078;11936.940315298369;12410.069244806857;12481.500739970299;9235.50945396345;9682.419054856731;9684.128428441474;9866.753331166778;9886.703398898044;9716.659916902874;9819.852702209615;9829.262805289489;9882.061204185591;9895.703128906145 21:41:48 INFO - PROCESS | 1923 | __end_tp_report 21:41:48 INFO - PROCESS | 1923 | __start_cc_report 21:41:48 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,1330 21:41:48 INFO - PROCESS | 1923 | __end_cc_report 21:41:48 INFO - PROCESS | 1923 | __startTimestamp1472704908894__endTimestamp 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | ------- Summary: start ------- 21:41:48 INFO - PROCESS | 1923 | Number of tests: 6 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#0] dojo.html Cycles:165 Average:5660.83 Median:5807.59 stddev:648.07 (11.2%) stddev-sans-first:622.26 21:41:48 INFO - PROCESS | 1923 | Values: 3267.3 3291.3 3314.0 3329.9 3372.8 4544.3 5502.1 5558.2 5630.2 5660.2 5614.9 5616.5 5708.1 5735.4 5760.3 5049.4 5106.2 5107.6 5120.5 5242.7 5211.0 5229.7 5230.2 5245.9 5246.0 5057.5 5107.9 5116.5 5117.8 5161.3 5061.3 5142.7 5153.8 5211.5 5212.4 5040.1 5090.8 5101.2 5135.5 5139.3 5651.4 5652.5 5684.3 5686.6 5734.3 6055.1 6064.7 6133.1 6143.0 6175.4 6161.8 6253.6 6263.4 6289.7 6290.3 5757.7 5765.6 5773.1 5773.4 5774.9 6200.5 6225.6 6274.0 6292.7 6340.7 6056.1 6060.5 6072.7 6100.5 6113.1 6111.0 6161.4 6168.3 6170.3 6189.1 6019.6 6042.9 6085.7 6089.2 6123.3 6122.6 6164.9 6173.4 6174.4 6177.5 4908.4 4909.2 4917.5 4920.2 4940.3 3766.9 4398.9 4400.8 4453.6 4468.6 5708.0 5715.2 5735.6 5754.5 5772.4 6215.9 6244.7 6248.4 6261.6 6278.6 5567.4 5618.2 5631.4 5704.3 5725.2 5348.5 5358.9 5379.8 5384.2 5424.8 6296.3 6319.6 6327.3 6342.3 6363.9 5246.8 6120.9 6197.2 6202.7 6232.6 6221.0 6245.8 6278.3 6282.9 6284.7 5078.5 6018.9 6118.4 6134.6 6141.8 6125.1 6183.9 6194.2 6202.6 6206.5 5821.2 5866.5 5943.1 5957.6 5977.5 5963.2 5982.6 5995.2 6005.7 6011.2 5779.2 5802.3 5807.6 5816.8 5843.5 4920.8 5856.6 5865.3 5892.5 6047.2 5767.5 5799.3 5812.6 5816.8 5817.5 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#1] ext.html Cycles:180 Average:66704.43 Median:18909.82 stddev:149298.95 (789.5%) stddev-sans-first:149634.85 21:41:48 INFO - PROCESS | 1923 | Values: 429.0 469.0 500.7 515.7 520.1 29990.4 30015.7 31684.0 31690.9 38816.2 39166.6 41542.4 41746.4 41790.8 41845.8 9547.0 9725.5 9742.8 9746.7 9760.4 8758.8 8868.7 9552.7 9681.6 11619.2 11697.5 11921.5 12104.7 12115.9 12119.5 12033.3 12098.3 12101.7 12126.9 12151.3 11701.7 11769.5 11781.2 11800.2 11802.9 38799.0 38998.0 39022.8 39099.6 39136.4 2757.7 3440.3 3528.2 3695.6 4053.2 29306.4 29921.1 30317.0 30381.4 30636.2 3139.3 3184.9 3209.6 3246.0 3350.5 483448.0 486048.0 487839.0 488882.0 496117.0 32422.2 52934.0 53195.0 53281.0 53325.9 32964.5 34304.3 34379.3 34404.7 34408.7 14305.3 14391.6 14422.4 14451.5 14467.5 12135.4 12229.3 12239.6 12258.0 12282.2 7209.6 7335.8 7476.0 7650.7 7654.9 3182.8 3227.8 3234.3 3240.3 3257.6 846.2 887.4 895.8 988.2 1021.6 27987.4 28547.9 29651.6 29760.7 30005.8 1023.9 1041.0 1067.9 1079.7 1155.7 14602.6 15135.0 15150.5 15535.8 15603.0 630841.0 638786.0 639073.8 639169.0 639771.0 54838.2 55192.0 55286.4 55291.7 55317.9 1202.7 1308.2 1317.5 1334.3 1337.3 25760.2 29322.4 29607.9 30065.4 30265.4 46098.8 46553.3 46604.8 46687.0 46807.8 534496.3 536175.0 536368.0 537551.0 538485.0 25734.4 25842.7 26255.9 26400.5 27250.0 42255.6 42365.8 42943.1 43282.6 43520.6 35896.0 36124.8 36204.8 37113.8 37118.4 35455.0 36092.8 36875.3 36899.4 36942.4 35046.8 35205.0 35692.3 35699.8 36015.6 29536.9 29827.5 33021.8 33581.0 34054.7 24670.9 24739.3 24904.9 24972.0 25469.9 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#2] jquery.html Cycles:180 Average:34007.35 Median:26207.24 stddev:95264.95 (363.5%) stddev-sans-first:95498.68 21:41:48 INFO - PROCESS | 1923 | Values: 353.1 369.2 373.3 387.4 404.2 15382.5 16150.3 20561.0 20724.0 20750.5 20891.8 21123.5 21312.0 21334.0 21671.5 5752.1 5793.8 5928.5 5955.7 6045.2 5865.2 5959.2 5967.7 5974.2 5979.3 4082.9 5007.6 6584.9 6586.1 6652.5 6412.8 6451.4 6597.5 6606.3 6621.8 5666.2 5717.3 5717.7 5721.6 5734.0 25892.0 25999.0 26027.0 26160.9 26253.6 2167.6 2235.5 2298.7 2350.8 2487.3 14683.9 15713.1 15930.4 15944.8 16207.8 1825.1 1840.7 1882.9 1896.8 1955.8 74125.0 94253.0 97787.0 98014.0 113234.0 9011.4 10874.2 10884.5 11193.2 11672.9 13920.9 13950.2 13961.4 13972.2 13972.9 8299.7 8651.7 8664.7 8794.3 8795.2 8547.5 8653.2 8673.5 8676.5 8860.8 6645.9 6743.0 6748.1 6752.5 6783.4 1817.2 1841.0 1843.7 1850.8 1851.8 828.2 856.3 882.8 912.9 975.9 20769.3 21017.3 21965.0 22773.0 22855.9 924.1 948.4 948.6 1011.9 1039.5 11509.0 11831.0 11986.7 12022.2 12047.3 562154.0 563601.0 571766.0 580142.0 584366.0 113117.4 117982.0 121000.4 122566.0 141873.0 996.8 998.4 1065.8 1067.1 1067.1 19332.0 19616.9 19688.8 19754.6 19875.0 45851.5 50952.7 53650.7 56062.6 56395.7 82542.2 83652.6 85569.3 85710.0 87820.3 6473.7 7862.4 8159.6 8277.8 8498.8 9409.9 10393.5 12335.6 13513.4 13546.1 9300.3 11111.4 11489.6 11560.3 11673.9 10706.5 11113.7 11298.2 11469.2 11535.7 11027.2 11369.8 11452.1 11606.8 11752.4 7095.4 7345.0 7484.6 7778.6 8542.8 9907.6 11235.6 11754.4 11815.0 11838.6 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#3] mootools.html Cycles:180 Average:5590.52 Median:4769.65 stddev:3181.43 (66.7%) stddev-sans-first:3174.11 21:41:48 INFO - PROCESS | 1923 | Values: 1312.2 1335.6 1485.1 1648.4 1896.6 7424.4 7678.4 8612.9 8843.5 8880.0 8653.8 8722.0 8817.6 8831.8 8837.8 2373.0 2393.6 2402.1 2402.5 2417.9 1981.2 2352.9 2395.8 2401.2 2412.9 2359.1 2380.2 2386.5 2392.4 2392.8 2323.5 2345.2 2348.1 2350.1 2391.3 1977.8 2360.1 2369.6 2373.2 2377.4 8683.0 8792.5 8810.8 8820.2 8877.9 5147.6 5324.1 5338.7 5364.1 5374.7 3349.3 3532.8 3567.7 3591.0 3595.8 998.5 1029.5 1031.4 1051.2 1051.9 11478.0 11529.9 11608.8 11611.4 11661.3 4075.0 4108.5 4385.0 4560.3 4567.5 9092.4 9105.4 9106.3 9108.8 9112.6 5207.9 5208.5 5209.7 5210.2 5215.3 4386.8 4415.6 4518.3 4691.3 4848.0 3618.7 3675.0 3772.6 3787.4 3791.7 1118.6 1138.9 1147.8 1149.6 1149.9 867.8 871.1 877.2 904.6 943.4 5528.4 5561.4 5870.2 5955.2 5971.6 367.7 422.1 442.0 443.7 450.2 3859.3 3875.5 3911.9 3971.1 3982.6 9000.7 10378.4 10733.9 10742.1 10809.5 10742.1 10746.8 10768.6 10771.9 10791.5 7855.5 8137.5 8279.7 8281.6 8283.1 4540.8 5758.6 5796.9 5821.2 5838.4 8290.3 9749.6 9882.8 10097.2 10185.4 10048.5 10055.7 10213.5 10251.5 10373.8 6515.8 6642.5 6956.7 7040.1 7052.1 8316.9 8375.1 8468.2 8478.8 8492.1 7353.2 7448.1 7504.1 7521.5 7612.1 7363.7 7378.9 7387.3 7400.7 7452.4 6892.4 6941.2 6965.7 6971.8 6980.6 4908.4 4963.5 4983.6 4984.2 5047.4 4355.5 4865.7 4902.4 4986.8 5134.4 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#4] prototype.html Cycles:180 Average:4583.01 Median:4961.05 stddev:1456.02 (29.3%) stddev-sans-first:1423.90 21:41:48 INFO - PROCESS | 1923 | Values: 284.1 297.3 304.3 308.7 309.7 4535.9 4547.1 4963.7 5219.6 5555.5 4415.9 4430.9 5428.7 5456.3 5465.6 4145.5 4150.5 4151.6 4195.0 4213.5 3505.3 3618.8 4107.9 4213.6 4219.3 3636.2 3946.9 4099.7 4103.5 4181.0 3455.5 4082.8 4096.3 4107.7 4111.7 3095.0 3433.6 3572.4 3573.1 3573.8 4987.9 5310.7 5331.0 5374.9 5415.5 4120.8 4626.6 4684.4 4707.4 4740.8 5803.7 5817.4 5823.7 5868.0 5882.1 3643.8 3896.0 3897.0 3904.9 3909.8 5194.8 5889.9 5917.6 5928.8 6015.1 3797.5 3886.3 3896.6 3903.2 3907.0 3350.0 3841.6 3968.1 3987.9 4011.7 3866.5 4056.3 4385.4 4478.4 4674.7 5774.9 5794.7 5810.1 5815.7 5839.2 1334.4 1357.5 1361.2 1362.0 1383.2 762.7 769.7 776.6 797.0 813.3 3892.4 4423.7 4487.2 4577.4 4656.5 4220.1 4565.4 4624.4 4713.7 4802.0 3851.7 4505.5 4518.7 4567.7 4590.8 2796.7 2818.3 3152.0 3152.1 3159.7 6162.9 6168.3 6174.9 6182.6 6208.7 5131.5 5744.0 5786.8 5816.0 6132.3 6142.9 6169.9 6187.5 6211.8 6269.0 5601.5 6054.9 6058.5 6082.4 6088.0 5670.6 5877.4 5930.4 5946.8 5970.4 5334.7 5602.9 6000.7 6076.6 6181.0 3911.7 3942.9 3947.4 3949.5 3992.2 4958.4 5596.0 5904.8 5970.0 6022.6 4879.5 4997.3 5044.8 5464.1 5847.6 5544.3 5781.5 5823.6 5861.5 5887.0 5127.9 5320.4 5646.1 5712.8 5721.7 5460.9 5859.6 5866.4 5873.4 5875.3 5496.4 5736.3 5765.7 5766.7 5774.1 21:41:48 INFO - PROCESS | 1923 | 21:41:48 INFO - PROCESS | 1923 | [#5] yui.html Cycles:180 Average:24395.10 Median:4363.71 stddev:39158.98 (897.4%) stddev-sans-first:39228.43 21:41:48 INFO - PROCESS | 1923 | Values: 703.6 714.0 754.2 757.1 854.8 15009.7 15706.5 15713.1 15715.8 15806.8 13830.8 13927.9 13959.2 13960.0 14373.6 661.1 805.4 818.2 843.7 844.9 832.4 834.7 834.8 835.2 835.4 885.8 886.2 886.7 887.4 887.6 696.2 865.4 880.5 883.0 889.9 657.6 658.3 658.5 658.5 660.4 14404.6 14444.7 14456.6 14470.5 14480.7 13471.9 13694.3 13753.9 13794.4 13984.4 12663.6 12710.6 12836.7 12856.6 12873.6 4438.7 4563.0 4570.7 4576.7 4669.2 118632.0 120032.0 120630.2 123971.4 125937.7 10699.5 10909.3 11188.6 11304.3 11310.4 21755.7 21969.7 21991.3 22012.9 22103.8 7812.1 7828.3 7861.9 7914.4 7918.6 4263.8 4268.4 4312.7 4414.7 4458.6 3392.6 3496.2 3497.5 3500.9 3509.2 524.5 636.0 643.2 643.4 644.7 525.3 546.5 619.3 667.9 691.9 8858.3 9128.5 9250.5 9298.5 9476.5 566.9 600.3 611.8 643.8 650.7 4161.4 4634.7 4742.3 4745.2 4764.9 92005.1 110838.0 142957.0 154330.2 156512.0 58365.7 122443.0 129456.0 131671.0 136395.0 110634.9 110776.9 111078.4 112788.0 116409.4 8826.2 8866.5 8873.7 8908.1 9209.9 61806.1 62237.7 62896.7 63649.7 63967.5 90535.5 100403.5 100896.0 102453.0 102556.0 11515.4 11940.5 12317.9 12415.8 12559.1 12846.9 13139.7 13193.9 13335.6 13456.3 12155.4 12252.3 12267.9 12393.4 12676.5 11945.6 12251.4 12336.0 12343.5 12449.6 11593.1 11891.9 11936.9 12410.1 12481.5 9235.5 9682.4 9684.1 9866.8 9886.7 9716.7 9819.9 9829.3 9882.1 9895.7 21:41:48 INFO - PROCESS | 1923 | -------- Summary: end -------- 21:41:48 INFO - PROCESS | 1923 | 21:41:49 INFO - TEST-INFO | 1923: exit 0 21:41:49 INFO - TEST-OK | dromaeo_css | took 1118111ms 21:41:49 INFO - TEST-START | kraken 21:41:49 INFO - operating with platform_type : mac_ 21:41:49 INFO - Initialising browser for kraken test... 21:41:49 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpa3qvlg/profile http://localhost:49459/getInfo.html) 21:41:51 INFO - PROCESS | 1930 | __metrics Screen width/height:1600/1200 21:41:51 INFO - PROCESS | 1930 | colorDepth:24 21:41:51 INFO - PROCESS | 1930 | Browser inner width/height: 1024/689 21:41:51 INFO - PROCESS | 1930 | __metrics 21:41:51 INFO - PROCESS | 1930 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:51 INFO - PROCESS | 1930 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:52 INFO - TEST-INFO | 1930: exit 0 21:41:52 INFO - Browser initialized. 21:41:52 INFO - Running cycle 1/1 for kraken test... 21:41:52 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpa3qvlg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:04 INFO - PROCESS | 1931 | RSS: Main: 233963520 21:42:04 INFO - PROCESS | 1931 | 21:42:07 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-beat-detection) 21:42:08 INFO - PROCESS | 1931 | RSS: Main: 292884480 21:42:08 INFO - PROCESS | 1931 | 21:42:10 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-dft) 21:42:11 INFO - PROCESS | 1931 | RSS: Main: 289017856 21:42:11 INFO - PROCESS | 1931 | 21:42:15 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-fft) 21:42:15 INFO - PROCESS | 1931 | RSS: Main: 376418304 21:42:15 INFO - PROCESS | 1931 | 21:42:17 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49459/tests/kraken/driver.html?testName=audio-oscillator) 21:42:18 INFO - PROCESS | 1931 | RSS: Main: 280465408 21:42:18 INFO - PROCESS | 1931 | 21:42:20 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:42:21 INFO - PROCESS | 1931 | RSS: Main: 283197440 21:42:21 INFO - PROCESS | 1931 | 21:42:24 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-darkroom) 21:42:24 INFO - PROCESS | 1931 | RSS: Main: 323121152 21:42:24 INFO - PROCESS | 1931 | 21:42:27 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49459/tests/kraken/driver.html?testName=imaging-desaturate) 21:42:28 INFO - PROCESS | 1931 | RSS: Main: 323538944 21:42:28 INFO - PROCESS | 1931 | 21:42:31 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49459/tests/kraken/driver.html?testName=json-parse-financial) 21:42:31 INFO - PROCESS | 1931 | RSS: Main: 323477504 21:42:31 INFO - PROCESS | 1931 | 21:42:33 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:42:34 INFO - PROCESS | 1931 | RSS: Main: 298184704 21:42:34 INFO - PROCESS | 1931 | 21:42:35 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:42:36 INFO - PROCESS | 1931 | RSS: Main: 304496640 21:42:36 INFO - PROCESS | 1931 | 21:42:38 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:42:39 INFO - PROCESS | 1931 | RSS: Main: 304009216 21:42:39 INFO - PROCESS | 1931 | 21:42:42 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:42:43 INFO - PROCESS | 1931 | RSS: Main: 320507904 21:42:43 INFO - PROCESS | 1931 | 21:42:46 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:42:46 INFO - PROCESS | 1931 | RSS: Main: 316567552 21:42:46 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49459/tests/kraken/driver.html?testName=ai-astar) 21:42:48 INFO - PROCESS | 1931 | RSS: Main: 360022016 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | __start_tp_report 21:42:48 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 21:42:48 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 21:42:48 INFO - PROCESS | 1931 | |i|pagename|runs| 21:42:48 INFO - PROCESS | 1931 | |0;ai-astar;115;115;118;114;114;114;114;113;113;124 21:42:48 INFO - PROCESS | 1931 | |1;audio-beat-detection;150;110;134;166;108;131;130;109;159;105 21:42:48 INFO - PROCESS | 1931 | |2;audio-dft;181;188;184;184;211;264;184;185;260;213 21:42:48 INFO - PROCESS | 1931 | |3;audio-fft;72;80;74;158;57;57;56;66;145;47 21:42:48 INFO - PROCESS | 1931 | |4;audio-oscillator;84;84;135;71;74;87;123;68;69;118 21:42:48 INFO - PROCESS | 1931 | |5;imaging-gaussian-blur;93;89;92;89;90;130;92;89;92;91 21:42:48 INFO - PROCESS | 1931 | |6;imaging-darkroom;100;98;99;101;108;98;100;101;99;110 21:42:48 INFO - PROCESS | 1931 | |7;imaging-desaturate;86;85;84;87;87;83;83;87;83;83 21:42:48 INFO - PROCESS | 1931 | |8;json-parse-financial;54;54;58;52;54;73;85;84;84;54 21:42:48 INFO - PROCESS | 1931 | |9;json-stringify-tinderbox;67;74;72;76;78;70;72;72;71;74 21:42:48 INFO - PROCESS | 1931 | |10;stanford-crypto-aes;88;85;85;86;86;88;83;89;87;77 21:42:48 INFO - PROCESS | 1931 | |11;stanford-crypto-ccm;155;139;136;139;138;138;137;142;194;139 21:42:48 INFO - PROCESS | 1931 | |12;stanford-crypto-pbkdf2;172;178;174;173;173;186;246;189;173;172 21:42:48 INFO - PROCESS | 1931 | |13;stanford-crypto-sha256-iterative;68;68;69;69;68;68;68;69;67;69 21:42:48 INFO - PROCESS | 1931 | __end_tp_report 21:42:48 INFO - PROCESS | 1931 | __start_cc_report 21:42:48 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,2233 21:42:48 INFO - PROCESS | 1931 | __end_cc_report 21:42:48 INFO - PROCESS | 1931 | __startTimestamp1472704968791__endTimestamp 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | ------- Summary: start ------- 21:42:48 INFO - PROCESS | 1931 | Number of tests: 14 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#0] ai-astar Cycles:10 Average:115.40 Median:114.50 stddev:3.34 (2.9%) stddev-sans-first:3.54 21:42:48 INFO - PROCESS | 1931 | Values: 115.0 115.0 118.0 114.0 114.0 114.0 114.0 113.0 113.0 124.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:132.50 stddev:22.37 (16.9%) stddev-sans-first:22.55 21:42:48 INFO - PROCESS | 1931 | Values: 150.0 110.0 134.0 166.0 108.0 131.0 130.0 109.0 159.0 105.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#2] audio-dft Cycles:10 Average:205.40 Median:199.50 stddev:31.96 (16.0%) stddev-sans-first:32.66 21:42:48 INFO - PROCESS | 1931 | Values: 181.0 188.0 184.0 184.0 211.0 264.0 184.0 185.0 260.0 213.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#3] audio-fft Cycles:10 Average:81.20 Median:61.50 stddev:38.46 (62.5%) stddev-sans-first:40.65 21:42:48 INFO - PROCESS | 1931 | Values: 72.0 80.0 74.0 158.0 57.0 57.0 56.0 66.0 145.0 47.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:72.50 stddev:24.73 (34.1%) stddev-sans-first:26.09 21:42:48 INFO - PROCESS | 1931 | Values: 84.0 84.0 135.0 71.0 74.0 87.0 123.0 68.0 69.0 118.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:91.50 stddev:12.49 (13.7%) stddev-sans-first:13.23 21:42:48 INFO - PROCESS | 1931 | Values: 93.0 89.0 92.0 89.0 90.0 130.0 92.0 89.0 92.0 91.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#6] imaging-darkroom Cycles:10 Average:101.40 Median:104.00 stddev:4.17 (4.0%) stddev-sans-first:4.39 21:42:48 INFO - PROCESS | 1931 | Values: 100.0 98.0 99.0 101.0 108.0 98.0 100.0 101.0 99.0 110.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.81 (2.1%) stddev-sans-first:1.87 21:42:48 INFO - PROCESS | 1931 | Values: 86.0 85.0 84.0 87.0 87.0 83.0 83.0 87.0 83.0 83.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:14.48 (22.1%) stddev-sans-first:14.78 21:42:48 INFO - PROCESS | 1931 | Values: 54.0 54.0 58.0 52.0 54.0 73.0 85.0 84.0 84.0 54.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:3.10 (4.2%) stddev-sans-first:2.54 21:42:48 INFO - PROCESS | 1931 | Values: 67.0 74.0 72.0 76.0 78.0 70.0 72.0 72.0 71.0 74.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.50 stddev:3.44 (4.0%) stddev-sans-first:3.52 21:42:48 INFO - PROCESS | 1931 | Values: 88.0 85.0 85.0 86.0 86.0 88.0 83.0 89.0 87.0 77.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:139.00 stddev:17.81 (12.8%) stddev-sans-first:18.57 21:42:48 INFO - PROCESS | 1931 | Values: 155.0 139.0 136.0 139.0 138.0 138.0 137.0 142.0 194.0 139.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:176.00 stddev:22.75 (12.9%) stddev-sans-first:23.74 21:42:48 INFO - PROCESS | 1931 | Values: 172.0 178.0 174.0 173.0 173.0 186.0 246.0 189.0 173.0 172.0 21:42:48 INFO - PROCESS | 1931 | 21:42:48 INFO - PROCESS | 1931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 21:42:48 INFO - PROCESS | 1931 | Values: 68.0 68.0 69.0 69.0 68.0 68.0 68.0 69.0 67.0 69.0 21:42:48 INFO - PROCESS | 1931 | -------- Summary: end -------- 21:42:48 INFO - PROCESS | 1931 | 21:42:49 INFO - TEST-INFO | 1931: exit 0 21:42:49 INFO - TEST-OK | kraken | took 60141ms 21:42:49 INFO - SUITE-END | took 1178s 21:42:49 INFO - Completed test suite (00:19:38) 21:42:49 INFO - javascript benchmark 21:42:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.264865405283, 3291.2594666200102, 3314.0057982605213, 3329.900102996911, 3372.814495202764, 4544.3183522471645, 5502.147167189092, 5558.194061861028, 5630.211770352149, 5660.2075709400715, 5614.9157762633595, 5616.466435688613, 5708.08670612701, 5735.397783232763, 5760.337561180466, 5049.368828896388, 5106.183010718286, 5107.616928730342, 5120.539151476366, 5242.748257947577, 5211.0, 5229.7385130743505, 5230.163173892159, 5245.921311180336, 5245.973770131163, 5057.49425057495, 5107.948920510785, 5116.513931176532, 5117.795288188468, 5161.329027226437, 5061.291419201315, 5142.74286285688, 5153.768080436389, 5211.478852114796, 5212.374515058179, 5040.092783299005, 5090.77091530882, 5101.183810590325, 5135.460776618439, 5139.331886854685, 5651.434856514356, 5652.463016013472, 5684.261046063985, 5686.578355411148, 5734.283214598176, 6055.122007308915, 6064.710158638488, 6133.1413602095745, 6142.989934931851, 6175.382461753834, 6161.7535298588, 6253.624782513064, 6263.404976527223, 6289.748410063592, 6290.308066112724, 5757.68332741699, 5765.596408251466, 5773.1051686988585, 5773.422657734277, 5774.913376299359, 6200.472959798378, 6225.564210505312, 6273.99616061428, 6292.685365731695, 6340.714667839959, 6056.065804653647, 6060.515158787286, 6072.666003369769, 6100.49335636658, 6113.113598528189, 6111.0, 6161.4454699076405, 6168.321484636686, 6170.321264660884, 6189.071639254058, 6019.638821670714, 6042.909356359658, 6085.695715214221, 6089.208402907594, 6123.326434092246, 6122.61138576932, 6164.938350616437, 6173.444390004831, 6174.38256174379, 6177.4749146323065, 4908.410990681141, 4909.189983652729, 4917.483664215206, 4920.237363208708, 4940.283658869444, 3766.851110411296, 4398.934015989763, 4400.823967041282, 4453.621442177451, 4468.620167285752, 5708.029634962067, 5715.199872017921, 5735.598508104476, 5754.539636829044, 5772.422757724278, 6215.875682486325, 6244.718987645567, 6248.4376406123665, 6261.592996455307, 6278.623282603058, 5567.415421380697, 5618.185363122406, 5631.352394474606, 5704.286964129484, 5725.1698503716725, 5348.545373643206, 5358.946410535845, 5379.784808607612, 5384.246205531229, 5424.83725488236, 6296.338884417162, 6319.6208227506495, 6327.303996560283, 6342.334054924258, 6363.90454143179, 5246.816361427332, 6120.8775824484155, 6197.163382943245, 6202.658853763086, 6232.626042437469, 6221.035739460391, 6245.750169993149, 6278.340774218824, 6282.874342513215, 6284.74861005573, 5078.5175408336145, 6018.91659501294, 6118.388161183846, 6134.613751167758, 6141.7543298267565, 6125.081237814185, 6183.907241391293, 6194.163787888578, 6202.627842329474, 6206.503479721521, 5821.243238379153, 5866.50134738552, 5943.108533719977, 5957.6127551709, 5977.491913187428, 5963.224780778471, 5982.641041537521, 5995.16067750524, 6005.699715014319, 6011.21854158974, 5779.190913272061, 5802.274715660543, 5807.593468457168, 5816.76732930678, 5843.532517398513, 4920.82777102814, 5856.648601083949, 5865.3254875688135, 5892.469677729025, 6047.183630210041, 5767.538596912321, 5799.333076696234, 5812.593118481665, 5816.76732930678, 5817.476427121579], "value": 5619.36469959815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.0389527458493, 469.01740852913133, 500.74211780932825, 515.7472838309229, 520.0924386944782, 29990.400191996174, 30015.699843001592, 31683.99999999997, 31690.890818821346, 38816.22367552654, 39166.629167979125, 41542.37686434706, 41746.37380439288, 41790.791046044804, 41845.7907710461, 9547.045295470467, 9725.465099419529, 9742.756431089245, 9746.707598772047, 9760.41437513748, 8758.781030474225, 8868.733937981871, 9552.71341859742, 9681.564329605184, 11619.244749091324, 11697.485040716245, 11921.523139074427, 12104.697382565419, 12115.93942030293, 12119.454624541873, 12033.338166400845, 12098.334591597459, 12101.697457563587, 12126.939365303206, 12151.331676757774, 11701.70745731355, 11769.470373833197, 11781.175317727762, 11800.232984855957, 11802.881971180264, 38799.0, 38998.0, 39022.804885975675, 39099.60900390988, 39136.41295380572, 2757.655293088344, 3440.3291358185165, 3528.2414280929465, 3695.61196074411, 4053.209624123297, 29306.41387172266, 29921.102366929026, 30317.0, 30381.392372152433, 30636.234094147825, 3139.3015253300227, 3184.8726050958167, 3209.5667084943702, 3246.0, 3350.509023484526, 483448.0, 486048.0, 487839.0, 488882.0, 496116.9999999964, 32422.189445263586, 52934.0, 53195.0, 53281.0, 53325.933481330154, 32964.50553241703, 34304.313913722086, 34379.312413751584, 34404.65595344065, 34408.65591344105, 14305.281996420646, 14391.568252952427, 14422.42310307576, 14451.49419770303, 14467.49363772284, 12135.393230338448, 12229.3273869938, 12239.632811015685, 12257.958073563668, 12282.201656892274, 7209.567425954459, 7335.816604584928, 7476.0, 7650.693972241159, 7654.885176722353, 3182.7931184472936, 3227.790193637406, 3234.2884565395575, 3240.2709390386976, 3257.609086909586, 846.191886748154, 887.3877024852831, 895.7760559860035, 988.1650005745134, 1021.6322124035341, 27987.44025119486, 28547.857260713565, 29651.55522667162, 29760.702392975792, 30005.849970750005, 1023.9385636861812, 1041.0162396535202, 1067.8771941226703, 1079.6653037558383, 1155.734181138326, 14602.561923142322, 15135.0, 15150.469733559494, 15535.76696349533, 15603.0, 630841.0, 638786.0, 639073.8046309832, 639169.0, 639771.0, 54838.177427338625, 55192.0, 55286.447135528935, 55291.72354138204, 55317.89364212693, 1202.7053371923935, 1308.228145394241, 1317.4532568983957, 1334.3461703765086, 1337.2778699502549, 25760.227193184233, 29322.413551729274, 29607.85196074006, 30065.3986920256, 30265.37268554322, 46098.76950615225, 46553.3017004752, 46604.7669761649, 46687.0, 46807.76596116998, 534496.3275183755, 536175.0, 536368.0, 537551.0, 538485.0, 25734.356641084123, 25842.741572584033, 26255.949762009306, 26400.471990559698, 27250.0, 42255.577444226394, 42365.78817106018, 42943.141137176455, 43282.56717432912, 43520.56479435165, 35896.0, 36124.819375904, 36204.81897590495, 37113.814430927676, 37118.44322335221, 35455.0, 36092.819535902156, 36875.26249475049, 36899.44650830186, 36942.445863311536, 35046.82476587601, 35205.0, 35692.28615427625, 35699.82150089337, 36015.63984360123, 29536.852315738284, 29827.481915845638, 33021.83489082539, 33581.0, 34054.65945340614, 24670.850739472346, 24739.25782226536, 24904.875475622506, 24972.0, 25469.872650637368], "value": 18335.878896048376, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.0802260112409, 369.2209438085639, 373.268393947862, 387.3685891996047, 404.1774987899623, 15382.461613843518, 16150.273237704303, 20560.971951402444, 20723.963801809925, 20750.48123796906, 20891.791082089174, 21123.47191320218, 21312.0, 21334.0, 21671.45821354467, 5752.137179423089, 5793.797217097382, 5928.525717942554, 5955.719520303134, 6045.244344456943, 5865.178874957509, 5959.165716799652, 5967.671778052206, 5974.223350964368, 5979.2824861016525, 4082.9183416331657, 5007.599392048645, 6584.9012264816065, 6586.077949087132, 6652.467802575782, 6412.807615771534, 6451.3548645135115, 6597.47220222381, 6606.339366063403, 6621.834454138637, 5666.178404131378, 5717.313922329347, 5717.685527295997, 5721.628094173865, 5733.9678857805575, 25892.0, 25999.0, 26026.958921643112, 26160.8691956539, 26253.606195907076, 2167.642339014061, 2235.474663454087, 2298.689676893615, 2350.847194932341, 2487.2662564543502, 14683.926580367137, 15713.13577753223, 15930.442434514736, 15944.760828587581, 16207.83792162075, 1825.1148193126323, 1840.7054871220673, 1882.9435116946513, 1896.781870084944, 1955.8337541309006, 74125.0, 94252.99999999932, 97787.0, 98014.0, 113234.0, 9011.369204155646, 10874.18443616732, 10884.455777211107, 11193.160512961398, 11672.88327116735, 13920.930395347958, 13950.232737199349, 13961.441542338396, 13972.161670299814, 13972.860271397156, 8299.709510167115, 8651.6971905983, 8664.696735614349, 8794.252488538417, 8795.164459376349, 8547.529885856213, 8653.17794809492, 8673.52295623734, 8676.481615717224, 8860.822783544292, 6645.867082658319, 6742.9662851685425, 6748.11983109704, 6752.459803215731, 6783.389494945479, 1817.2190412090924, 1841.042657817954, 1843.7234414837612, 1850.7964123946356, 1851.7685289338833, 828.1925123005142, 856.2550580994574, 882.75282920781, 912.8904531456135, 975.8731364922514, 20769.27307544229, 21017.264395746075, 21965.0, 22772.975216115316, 22855.885720571292, 924.1082355526949, 948.3882895532481, 948.5873644964463, 1011.9291649584605, 1039.4698703661188, 11509.02173315261, 11831.0, 11986.700332491757, 12022.158448908667, 12047.33739644328, 562154.0, 563601.0, 571766.0, 580142.0, 584366.0, 113117.43441282741, 117982.0, 121000.39499802445, 122566.0, 141873.0, 996.7707427291764, 998.4259051045677, 1065.8454524093963, 1067.1302888146136, 1067.1356201476829, 19332.03339833031, 19616.921069341322, 19688.80311196927, 19754.60490790205, 19875.0, 45851.541484584726, 50952.72618184575, 53650.73174634258, 56062.59843503782, 56395.71802140963, 82542.17457825344, 83652.58173709092, 85569.28861422862, 85710.0, 87820.33976262734, 6473.676316184078, 7862.449628526177, 8159.551224682699, 8277.751667449986, 8498.787530311793, 9409.905900940903, 10393.480325983519, 12335.568255111388, 13513.391897364445, 13546.119502232323, 9300.302477314093, 11111.444427778417, 11489.597864074718, 11560.30638161713, 11673.883261167619, 10706.518206680874, 11113.722156946142, 11298.209125361474, 11469.197156198987, 11535.711607209887, 11027.17296202772, 11369.772604548029, 11452.141089418494, 11606.76786464249, 11752.412379380825, 7095.432365410858, 7344.96327518359, 7484.550926944401, 7778.649960751893, 8542.821580496933, 9907.554160062671, 11235.55057797679, 11754.412279386168, 11815.0, 11838.644840654793], "value": 9779.338907093099, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.1930013041979, 1335.5993202039385, 1485.0792508644643, 1648.3818568036986, 1896.6396384686916, 7424.368928641072, 7678.385729141669, 8612.91387086129, 8843.513606751627, 8879.955600222005, 8653.826923461527, 8722.040575536701, 8817.647294108228, 8831.823363532741, 8837.779055523599, 2373.0, 2393.5930891748444, 2402.1112188490283, 2402.5074859653814, 2417.9395515112087, 1981.187713037655, 2352.8588284702887, 2395.784379405853, 2401.2076014915124, 2412.867292298923, 2359.138914296278, 2380.155044959032, 2386.486905315357, 2392.449736560592, 2392.7846493815555, 2323.4772176260376, 2345.2026311054237, 2348.0607756897207, 2350.0834674477055, 2391.330427480291, 1977.7527809023873, 2360.138549429463, 2369.561631098235, 2373.1931143411152, 2377.405648587853, 8683.044865064838, 8792.47245165292, 8810.823783524358, 8820.162084601952, 8877.911220887838, 5147.562457191143, 5324.1215199492035, 5338.706371149585, 5364.061289274361, 5374.731263436813, 3349.342075672533, 3532.8233588320736, 3567.678908898212, 3590.982045089784, 3595.8202089895663, 998.5007496251874, 1029.541853875026, 1031.448175226258, 1051.2063392138962, 1051.9263651544395, 11478.024367928736, 11529.884701152965, 11608.825867611993, 11611.361375124365, 11661.300321980709, 4075.0219947212454, 4108.5275193352545, 4384.978075109604, 4560.270356742905, 4567.520410356865, 9092.408993415407, 9105.408148470327, 9106.31702622306, 9108.772280692903, 9112.589933453011, 5207.895842083137, 5208.479152084761, 5209.6874187548865, 5210.21846722987, 5215.322008138994, 4386.8025938832825, 4415.558444155558, 4518.254488009507, 4691.296305554194, 4848.0, 3618.738288569644, 3674.9816250919107, 3772.6227377262053, 3787.3750831112557, 3791.696664266852, 1118.6028959719345, 1138.9237170873446, 1147.8106112491512, 1149.6148790155391, 1149.8620165580016, 867.7613656244583, 871.1201686296886, 877.1929824561291, 904.6291020681489, 943.3962264150949, 5528.419515950848, 5561.443855614406, 5870.240986736228, 5955.225820643289, 5971.581989260797, 367.6507318047865, 422.1493690214221, 442.0209236541077, 443.7359770936288, 450.16719069720756, 3859.305325041463, 3875.534935807721, 3911.882643520699, 3971.146203566247, 3982.5818289079807, 9000.729978100668, 10378.377297362182, 10733.946330268298, 10742.08692261151, 10809.459527023617, 10742.08692261151, 10746.785064298827, 10768.623098191525, 10771.89228107709, 10791.514381852836, 7855.4893931895385, 8137.511749295061, 8279.710210142615, 8281.627326770189, 8283.130271321545, 4540.818367265272, 5758.568107391879, 5796.884062318814, 5821.214136091573, 5838.4453476919625, 8290.29532489721, 9749.56126974302, 9882.802343952937, 10097.242706796873, 10185.439800811026, 10048.54781534818, 10055.69832905014, 10213.489325533843, 10251.487425628839, 10373.792524149323, 6515.804525864231, 6642.501812363996, 6956.721731130698, 7040.119985001875, 7052.0832291801735, 8316.875246871423, 8375.120612335617, 8468.195521425454, 8478.788030299293, 8492.065872754116, 7353.191148973716, 7448.068991376078, 7504.1370242420635, 7521.4734968551675, 7612.1246056701975, 7363.668634911334, 7378.889316660362, 7387.335139837441, 7400.666969986256, 7452.441066919894, 6892.414144797748, 6941.167059952838, 6965.686544105426, 6971.755988540377, 6980.616066116209, 4908.361912951294, 4963.53575695178, 4983.601311895112, 4984.1526940420945, 5047.444781074006, 4355.519123498026, 4865.659403841697, 4902.436219834622, 4986.775595098156, 5134.383873935151], "value": 4397.746492172686, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.10365297486436, 297.32210559923374, 304.32743636563197, 308.70981277599043, 309.73981855241607, 4535.931961020588, 4547.112948126528, 4963.726995015273, 5219.634625576211, 5555.472230138141, 4415.873952142199, 4430.911381772371, 5428.728563571815, 5456.262460214755, 5465.617406781527, 4145.54399016108, 4150.501939767232, 4151.626353628173, 4195.0, 4213.47331583552, 3505.2999295341738, 3618.764780289286, 4107.925497623696, 4213.578642135777, 4219.303814870543, 3636.236390358028, 3946.940795888064, 4099.692523060782, 4103.507579090498, 4181.0, 3455.4644030175364, 4082.81627326771, 4096.262672718909, 4107.732997355162, 4111.71218014739, 3095.0, 3433.6051354094348, 3572.356975744365, 3573.1053152064114, 3573.767705099186, 4987.905079866465, 5310.654807437543, 5331.0, 5374.946250537484, 5415.512603865671, 4120.773357465338, 4626.635142632931, 4684.4378674559275, 4707.411573553306, 4740.762961851928, 5803.680797556132, 5817.418258174191, 5823.737931793079, 5867.973104706702, 5882.088276317135, 3643.8360273787744, 3895.9610403896163, 3897.0, 3904.941425878614, 3909.7654140751647, 5194.844154675366, 5889.882202355929, 5917.6449413034925, 5928.7924922627935, 6015.1428071665605, 3797.525309336333, 3886.300465916162, 3896.5518965318784, 3903.1803321302277, 3907.0037140528984, 3350.011746534778, 3841.558220804643, 3968.146848427602, 3987.9232607195895, 4011.659008984269, 3866.478025466582, 4056.269871423172, 4385.3641222022625, 4478.39541661878, 4674.74288914113, 5774.913376299359, 5794.710264486759, 5810.099434587646, 5815.73829177688, 5839.182514447981, 1334.3995202159067, 1357.5384369314481, 1361.2309045389322, 1362.0397619678104, 1383.1770096792393, 762.6529928882345, 769.7036640893184, 776.6116941529235, 796.9561674107864, 813.2558708781517, 3892.377219644843, 4423.748544819555, 4487.192305384997, 4577.382053422812, 4656.46108957195, 4220.07158425146, 4565.3836732040745, 4624.445066591963, 4713.74074425903, 4801.991581767798, 3851.6533511984057, 4505.504394516601, 4518.683692141519, 4567.6802623816675, 4590.816367345269, 2796.678381986057, 2818.25316291183, 3151.9684803152136, 3152.0543836848856, 3159.7472202223767, 6162.859870923893, 6168.290646575701, 6174.905702795212, 6182.567220294626, 6208.671748094464, 5131.461196574381, 5744.0, 5786.842631473638, 5816.0, 6132.320607635473, 6142.938570614237, 6169.907451388232, 6187.504999600022, 6211.782587609412, 6268.968655156695, 5601.467860553241, 6054.878902421839, 6058.5153187745755, 6082.422169893853, 6087.969560152171, 5670.574706896917, 5877.382874798255, 5930.377310382348, 5946.762129514944, 5970.373110823301, 5334.733263336895, 5602.85992850182, 6000.729967151576, 6076.635401875901, 6180.969095154495, 3911.7457365271166, 3942.901427464222, 3947.427622994592, 3949.466821978996, 3992.2414741199077, 4958.380382320998, 5596.0, 5904.793332233351, 5969.970150149222, 6022.6386416813375, 4879.463259041574, 4997.325895824939, 5044.848654540369, 5464.1257398816, 5847.649141051551, 5544.3346798384455, 5781.479666830005, 5823.5923485355615, 5861.531077513703, 5887.0, 5127.923081153711, 5320.44135365781, 5646.096624540054, 5712.7714891403875, 5721.7425215866215, 5460.890782184413, 5859.648421094748, 5866.442687944638, 5873.4126587340925, 5875.294964604275, 5496.422875598005, 5736.340320863154, 5765.682887441231, 5766.740496677576, 5774.133879918046], "value": 4110.52617453646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.6200451756052, 713.9928600713993, 754.2080815144097, 757.1482082657011, 854.8333075050366, 15009.699806003873, 15706.45027424039, 15713.057216566986, 15715.764263536055, 15806.814488913335, 13830.792538111911, 13927.930360348184, 13959.232242226673, 13960.0, 14373.640658983531, 661.1042038038461, 805.4040010392312, 818.153211426174, 843.6541018182546, 844.8986121665408, 832.4089896173693, 834.7161964931922, 834.8288600836814, 835.1606635331483, 835.4026870787386, 885.7918389178537, 886.2024178239603, 886.6940905387631, 887.414306557672, 887.5828360670474, 696.2376198063088, 865.3726048614767, 880.4717169698162, 883.0286684646901, 889.937704360695, 657.628439931442, 658.2824721054026, 658.5159907468008, 658.5488940076063, 660.4188314283448, 14404.63988400288, 14444.711105777931, 14456.56630301082, 14470.49353272641, 14480.710385792225, 13471.932640336834, 13694.315284235849, 13753.931230343784, 13794.448222071105, 13984.440622375092, 12663.620091397273, 12710.555130570478, 12836.743265134644, 12856.55002074923, 12873.613791586267, 4438.733675979452, 4563.0, 4570.702904311209, 4576.656750743708, 4669.2062349400685, 118632.0, 120032.0, 120630.19054714186, 123971.38014309961, 125937.74062259351, 10699.465026748632, 10909.290896091728, 11188.629457860272, 11304.321740695585, 11310.434478276053, 21755.67366489504, 21969.67045494319, 21991.340259792232, 22012.889935550218, 22103.778962210174, 7812.140664526897, 7828.256315650005, 7861.882071768928, 7914.406419518559, 7918.6436610352675, 4263.765492897858, 4268.423762792046, 4312.741235525878, 4414.668899832525, 4458.621017213508, 3392.6437724039115, 3496.2133519957806, 3497.4928635347733, 3500.9474857877153, 3509.192885636318, 524.4545672500633, 635.9841003974846, 643.157463722525, 643.3566433566433, 644.7034364192524, 525.3459442993498, 546.4999525434183, 619.3373090792899, 667.8764428580728, 691.9031335613018, 8858.335624828034, 9128.49793261377, 9250.537473126316, 9298.488583127993, 9476.478793666276, 566.9348024977098, 600.3096439095076, 611.7950486587043, 643.7714611312916, 650.6844180572418, 4161.375793630979, 4634.652401069933, 4742.33607294979, 4745.240761478147, 4764.894656062486, 92005.07994919964, 110838.0, 142957.0, 154330.22834885755, 156512.0, 58365.70817145887, 122443.0, 129456.0, 131671.0, 136395.0, 110634.89365106246, 110776.89223107827, 111078.44460777644, 112788.0, 116409.41795291139, 8826.205641492297, 8866.512341821004, 8873.73378798637, 8908.10918908104, 9209.907900921173, 61806.0729089055, 62237.68881155565, 62896.74206515752, 63649.727005458706, 63967.502098573415, 90535.54732226297, 100403.49798250962, 100895.99104008866, 102453.0, 102555.97444025465, 11515.424228788359, 11940.462679179283, 12317.93841030825, 12415.813762793385, 12559.120861539604, 12846.894609935422, 13139.737205256033, 13193.934030329787, 13335.599932002055, 13456.327183640975, 12155.392230388623, 12252.264864108181, 12267.938660306641, 12393.380330983235, 12676.492940282285, 11945.641630750744, 12251.448684809384, 12336.0, 12343.506259749509, 12449.564265250672, 11593.130515211224, 11891.881081189078, 11936.940315298369, 12410.069244806857, 12481.500739970299, 9235.50945396345, 9682.419054856731, 9684.128428441474, 9866.753331166778, 9886.703398898044, 9716.659916902874, 9819.852702209615, 9829.262805289489, 9882.061204185591, 9895.703128906145], "value": 7627.052423816231, "unit": "score"}], "name": "dromaeo_css", "value": 7196.774669884271, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 118.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 124.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 110.0, 134.0, 166.0, 108.0, 131.0, 130.0, 109.0, 159.0, 105.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 184.0, 184.0, 211.0, 264.0, 184.0, 185.0, 260.0, 213.0], "value": 205.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 74.0, 158.0, 57.0, 57.0, 56.0, 66.0, 145.0, 47.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 135.0, 71.0, 74.0, 87.0, 123.0, 68.0, 69.0, 118.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 89.0, 92.0, 89.0, 90.0, 130.0, 92.0, 89.0, 92.0, 91.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 98.0, 99.0, 101.0, 108.0, 98.0, 100.0, 101.0, 99.0, 110.0], "value": 101.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 87.0, 87.0, 83.0, 83.0, 87.0, 83.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 52.0, 54.0, 73.0, 85.0, 84.0, 84.0, 54.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 76.0, 78.0, 70.0, 72.0, 72.0, 71.0, 74.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 86.0, 86.0, 88.0, 83.0, 89.0, 87.0, 77.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 139.0, 136.0, 139.0, 138.0, 138.0, 137.0, 142.0, 194.0, 139.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 174.0, 173.0, 173.0, 186.0, 246.0, 189.0, 173.0, 172.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 67.0, 69.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1525.2, "alertThreshold": 2.0}]} 21:42:50 INFO - Return code: 0 21:42:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:42:50 INFO - # TBPL SUCCESS # 21:42:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:42:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:42:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:42:50 INFO - 2016-08-31 21:42:50.110 screenresolution[1935:11463] starting screenresolution argv=screenresolution get 21:42:50 INFO - 2016-08-31 21:42:50.113 screenresolution[1935:11463] Display 0: 1600x1200x32@60 21:42:50 INFO - 2016-08-31 21:42:50.119 screenresolution[1936:11466] starting screenresolution argv=screenresolution list 21:42:50 INFO - Available Modes on Display 0 21:42:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:42:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:42:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:42:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:42:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:42:50 INFO - Intel Iris: 21:42:50 INFO - Chipset Model: Intel Iris 21:42:50 INFO - Type: GPU 21:42:50 INFO - Bus: Built-In 21:42:50 INFO - VRAM (Dynamic, Max): 1536 MB 21:42:50 INFO - Vendor: Intel (0x8086) 21:42:50 INFO - Device ID: 0x0a2e 21:42:50 INFO - Revision ID: 0x0009 21:42:50 INFO - Displays: 21:42:50 INFO - Display: 21:42:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:42:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:42:50 INFO - Display Serial Number: 1600x1200 60 21:42:50 INFO - Main Display: Yes 21:42:50 INFO - Mirror: Off 21:42:50 INFO - Online: Yes 21:42:50 INFO - Rotation: Supported 21:42:50 INFO - Return code: 0 21:42:50 INFO - Running post-action listener: _resource_record_post_action 21:42:50 INFO - [mozharness: 2016-09-01 04:42:50.353847Z] Finished run-tests step (success) 21:42:50 INFO - Running post-run listener: _resource_record_post_run 21:42:50 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 1806336; Write bytes: 706472448; Read time: 22; Write time: 1975 21:42:50 INFO - TinderboxPrint: CPU usage
53.6% 21:42:50 INFO - TinderboxPrint: I/O read bytes / time
1,806,336 / 22 21:42:50 INFO - TinderboxPrint: I/O write bytes / time
706,472,448 / 1,975 21:42:50 INFO - TinderboxPrint: CPU idle
2,255.4 (46.4%) 21:42:50 INFO - TinderboxPrint: CPU system
975.3 (20.1%) 21:42:50 INFO - TinderboxPrint: CPU user
1,631.0 (33.5%) 21:42:50 INFO - TinderboxPrint: Swap in / out
408,879,104 / 0 21:42:50 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 386052608; Write bytes: 378886144; Read time: 30376; Write time: 787 21:42:50 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1806336; Write bytes: 297153024; Read time: 22; Write time: 1120 21:42:50 INFO - Running post-run listener: _upload_blobber_files 21:42:50 INFO - Blob upload gear active. 21:42:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:42:50 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 21:42:50 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'] 21:42:50 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 21:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 21:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:42:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:52 INFO - (blobuploader) - INFO - Done attempting. 21:42:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:42:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:53 INFO - (blobuploader) - INFO - Done attempting. 21:42:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:42:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:42:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:42:55 INFO - (blobuploader) - INFO - Done attempting. 21:42:55 INFO - (blobuploader) - INFO - Iteration through files over. 21:42:55 INFO - Return code: 0 21:42:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:42:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:42:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca6c5c8a25a970fd705cf34fbff5176895f6cf7129260615c58af7fe31f323fdcf179d51405d37281adb6206a4fc8ccacdee90a0c08cd21dccad30863dc78ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a5d933530bf541914b59af50023dbaec8e8486184097398eeddc69e50b07a2354dbf505785844aa641169c16b7426242ab2c611e472c60d69ea4718819674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f349f006550c7be63d4a97858e264a02b0134fe524f576db574ba779fbe6f53f2be7d6dd5436254d5b9ba2aeb8e264be5c173bdc10d753552ab69ee70dc3388"} 21:42:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:42:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:42:55 INFO - Contents: 21:42:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca6c5c8a25a970fd705cf34fbff5176895f6cf7129260615c58af7fe31f323fdcf179d51405d37281adb6206a4fc8ccacdee90a0c08cd21dccad30863dc78ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a5d933530bf541914b59af50023dbaec8e8486184097398eeddc69e50b07a2354dbf505785844aa641169c16b7426242ab2c611e472c60d69ea4718819674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f349f006550c7be63d4a97858e264a02b0134fe524f576db574ba779fbe6f53f2be7d6dd5436254d5b9ba2aeb8e264be5c173bdc10d753552ab69ee70dc3388"} 21:42:55 INFO - Running post-run listener: copy_logs_to_upload_dir 21:42:55 INFO - Copying logs to upload dir... 21:42:55 INFO - mkdir: /builds/slave/test/build/upload/logs 21:42:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.597723 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-31 21:42:55.809973) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 21:42:55.813422) ========= 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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca6c5c8a25a970fd705cf34fbff5176895f6cf7129260615c58af7fe31f323fdcf179d51405d37281adb6206a4fc8ccacdee90a0c08cd21dccad30863dc78ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a5d933530bf541914b59af50023dbaec8e8486184097398eeddc69e50b07a2354dbf505785844aa641169c16b7426242ab2c611e472c60d69ea4718819674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f349f006550c7be63d4a97858e264a02b0134fe524f576db574ba779fbe6f53f2be7d6dd5436254d5b9ba2aeb8e264be5c173bdc10d753552ab69ee70dc3388"} build_url:https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011051 build_url: 'https://queue.taskcluster.net/v1/task/Ecekb6qUTzqvcDaEdN9h8Q/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aca6c5c8a25a970fd705cf34fbff5176895f6cf7129260615c58af7fe31f323fdcf179d51405d37281adb6206a4fc8ccacdee90a0c08cd21dccad30863dc78ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/583a5d933530bf541914b59af50023dbaec8e8486184097398eeddc69e50b07a2354dbf505785844aa641169c16b7426242ab2c611e472c60d69ea4718819674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f349f006550c7be63d4a97858e264a02b0134fe524f576db574ba779fbe6f53f2be7d6dd5436254d5b9ba2aeb8e264be5c173bdc10d753552ab69ee70dc3388"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 21:42:55.846341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:42:55.846656) ========= 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.t2ln2r9FaL/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.yOuNe6Cwxm/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 21:42:55.894874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 21:42:55.895200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 21:42:55.895514) ========= ========= Total master_lag: 0.21 =========