builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0319 starttime: 1471027011.69 results: success (0) buildid: 20160812094617 builduid: e9b6a77592dd40ca9a6e484afc6c1d87 revision: c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:51.691540) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:51.692081) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:51.692360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:51.717761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:51.718038) ========= 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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-12 11:36:51-- 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% 129M=0s 2016-08-12 11:36:51 (129 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127916 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:52.016371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:52.016705) ========= 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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.026163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:52.071370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 11:36:52.071766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e --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 c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-12 11:36:52,153 truncating revision to first 12 chars 2016-08-12 11:36:52,154 Setting DEBUG logging. 2016-08-12 11:36:52,154 attempt 1/10 2016-08-12 11:36:52,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4ad5f94a5bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 11:36:53,236 unpacking tar archive at: mozilla-central-c4ad5f94a5bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 11:36:53.429296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:53.429639) ========= script_repo_revision: c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:53.430027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:53.430297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 11:36:53.448123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-12 11:36:53.448406) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:36:53 INFO - MultiFileLogger online at 20160812 11:36:53 in /builds/slave/test 11:36:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:36:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:36:53 INFO - {'append_to_log': False, 11:36:53 INFO - 'base_work_dir': '/builds/slave/test', 11:36:53 INFO - 'blob_upload_branch': 'Firefox', 11:36:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:36:53 INFO - 'branch': 'Firefox', 11:36:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:36:53 INFO - 'config_files': ('talos/mac_config.py',), 11:36:53 INFO - 'default_actions': ('clobber', 11:36:53 INFO - 'read-buildbot-config', 11:36:53 INFO - 'download-and-extract', 11:36:53 INFO - 'populate-webroot', 11:36:53 INFO - 'create-virtualenv', 11:36:53 INFO - 'install', 11:36:53 INFO - 'run-tests'), 11:36:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:36:53 INFO - 'download_minidump_stackwalk': True, 11:36:53 INFO - 'download_symbols': 'ondemand', 11:36:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:36:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:36:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:36:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:36:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:36:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:36:53 INFO - 'installer_path': 'installer.exe', 11:36:53 INFO - 'log_level': 'info', 11:36:53 INFO - 'log_name': 'talos', 11:36:53 INFO - 'log_to_console': True, 11:36:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:36:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:36:53 INFO - 'opt_config_files': (), 11:36:53 INFO - 'pip_index': False, 11:36:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:36:53 INFO - 'cmd': ('bash', 11:36:53 INFO - '-c', 11:36:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:36:53 INFO - 'enabled': True, 11:36:53 INFO - 'halt_on_failure': False, 11:36:53 INFO - 'name': 'check_screen_resolution'},), 11:36:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:36:53 INFO - 'cmd': ('bash', 11:36:53 INFO - '-c', 11:36:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:36:53 INFO - 'enabled': True, 11:36:53 INFO - 'halt_on_failure': False, 11:36:53 INFO - 'name': 'check_screen_resolution'},), 11:36:53 INFO - 'run_cmd_checks_enabled': True, 11:36:53 INFO - 'sps_profile': False, 11:36:53 INFO - 'sps_profile_interval': 0, 11:36:53 INFO - 'suite': 'dromaeojs-e10s', 11:36:53 INFO - 'system_bits': '32', 11:36:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:36:53 INFO - 'title': 't-yosemite-r7-0319', 11:36:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:36:53 INFO - 'use_talos_json': True, 11:36:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:36:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:36:53 INFO - 'work_dir': 'build'} 11:36:53 INFO - [mozharness: 2016-08-12 18:36:53.643720Z] Running clobber step. 11:36:53 INFO - Running pre-action listener: _resource_record_pre_action 11:36:53 INFO - Running main action method: clobber 11:36:53 INFO - rmtree: /builds/slave/test/build 11:36:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:36:55 INFO - Running post-action listener: _resource_record_post_action 11:36:55 INFO - [mozharness: 2016-08-12 18:36:55.720904Z] Finished clobber step (success) 11:36:55 INFO - [mozharness: 2016-08-12 18:36:55.721035Z] Running read-buildbot-config step. 11:36:55 INFO - Running pre-action listener: _resource_record_pre_action 11:36:55 INFO - Running main action method: read_buildbot_config 11:36:55 INFO - Using buildbot properties: 11:36:55 INFO - { 11:36:55 INFO - "project": "", 11:36:55 INFO - "product": "firefox", 11:36:55 INFO - "script_repo_revision": "production", 11:36:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:36:55 INFO - "repository": "", 11:36:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:36:55 INFO - "buildid": "20160812094617", 11:36:55 INFO - "pgo_build": "False", 11:36:55 INFO - "basedir": "/builds/slave/test", 11:36:55 INFO - "buildnumber": 39, 11:36:55 INFO - "slavename": "t-yosemite-r7-0319", 11:36:55 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:36:55 INFO - "platform": "yosemite_r7", 11:36:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:36:55 INFO - "branch": "mozilla-central", 11:36:55 INFO - "repo_path": "mozilla-central", 11:36:55 INFO - "revision": "c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e", 11:36:55 INFO - "stage_platform": "macosx64", 11:36:55 INFO - "builduid": "e9b6a77592dd40ca9a6e484afc6c1d87", 11:36:55 INFO - "slavebuilddir": "test" 11:36:55 INFO - } 11:36:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:36:55 INFO - Running post-action listener: _resource_record_post_action 11:36:55 INFO - [mozharness: 2016-08-12 18:36:55.724466Z] Finished read-buildbot-config step (success) 11:36:55 INFO - [mozharness: 2016-08-12 18:36:55.724596Z] Running download-and-extract step. 11:36:55 INFO - Running pre-action listener: _resource_record_pre_action 11:36:55 INFO - Running main action method: download_and_extract 11:36:55 INFO - mkdir: /builds/slave/test/build/tests 11:36: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')]} 11:36:55 INFO - trying https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:36:55 INFO - Downloading https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:36:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:36:57 INFO - Downloaded 1199 bytes. 11:36:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:36:57 INFO - Using the following test package requirements: 11:36:57 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:36:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:36:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:36:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'jsshell-mac.zip'], 11:36:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:36:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:36:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:36:57 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:36:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:36:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:36:57 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:36:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:36:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:57 INFO - trying https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:36:57 INFO - Downloading https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:36:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:36:58 INFO - Downloaded 16328711 bytes. 11:36:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:37:04 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 11:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:04 INFO - trying https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:37:05 INFO - Downloaded 16328711 bytes. 11:37:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:37:12 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')]} 11:37:12 INFO - trying https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:37:12 INFO - Downloading https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:37:14 INFO - Downloaded 14413719 bytes. 11:37:14 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:14 INFO - trying https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/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 11:37:17 INFO - Downloaded 110967868 bytes. 11:37:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:37:17 INFO - mkdir: /builds/slave/test/properties 11:37:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:17 INFO - Contents: 11:37:17 INFO - build_url:https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:37:18 INFO - Running post-action listener: _resource_record_post_action 11:37:18 INFO - Running post-action listener: set_extra_try_arguments 11:37:18 INFO - [mozharness: 2016-08-12 18:37:18.209049Z] Finished download-and-extract step (success) 11:37:18 INFO - [mozharness: 2016-08-12 18:37:18.209221Z] Running populate-webroot step. 11:37:18 INFO - Running pre-action listener: _resource_record_pre_action 11:37:18 INFO - Running main action method: populate_webroot 11:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:18 INFO - '--tppagecycles', 11:37:18 INFO - '7'], 11:37:18 INFO - 'tests': ['tsvgm']}}, 11:37:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['damp', 'tps']}, 11:37:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['damp', 'tps']}, 11:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['dromaeo_dom']}, 11:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['basic_compositor_video']}, 11:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['a11yr', 11:37:18 INFO - 'ts_paint', 11:37:18 INFO - 'tpaint', 11:37:18 INFO - 'sessionrestore', 11:37:18 INFO - 'sessionrestore_no_auto_restore', 11:37:18 INFO - 'tabpaint']}, 11:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tsvgx', 11:37:18 INFO - 'tsvgr_opacity', 11:37:18 INFO - 'tart', 11:37:18 INFO - 'tscrollx', 11:37:18 INFO - 'cart']}, 11:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:18 INFO - 'tsvgr_opacity', 11:37:18 INFO - 'tart', 11:37:18 INFO - 'tscrollx', 11:37:18 INFO - 'cart']}, 11:37:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s'], 11:37:18 INFO - 'tests': ['tp5o']}, 11:37:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'tests': ['tp5o']}, 11:37:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--disable-e10s', 11:37:18 INFO - '--xperf_path', 11:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:18 INFO - 'tests': ['tp5n']}, 11:37:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:37:18 INFO - 'talos_options': ['--xperf_path', 11:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:18 INFO - 'tests': ['tp5n']}}, 11:37:18 INFO - 'talos.zip': {'path': '', 11:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:18 INFO - Running post-action listener: _resource_record_post_action 11:37:18 INFO - [mozharness: 2016-08-12 18:37:18.227624Z] Finished populate-webroot step (success) 11:37:18 INFO - [mozharness: 2016-08-12 18:37:18.227743Z] Running create-virtualenv step. 11:37:18 INFO - Running pre-action listener: _resource_record_pre_action 11:37:18 INFO - Running main action method: create_virtualenv 11:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:18 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 11:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:18 INFO - Using real prefix '/tools/python27' 11:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:21 INFO - Installing pip.................done. 11:37:21 INFO - Return code: 0 11:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:21 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')]} 11:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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')]} 11:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:21 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:21 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 11:37:21 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 11:37:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:21 INFO - 'HOME': '/Users/cltbld', 11:37:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:21 INFO - 'LOGNAME': 'cltbld', 11:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:21 INFO - 'MOZ_NO_REMOTE': '1', 11:37:21 INFO - 'NO_EM_RESTART': '1', 11:37:21 INFO - 'PAGER': '/bin/cat', 11:37:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:21 INFO - 'PWD': '/builds/slave/test', 11:37:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:21 INFO - 'SHELL': '/bin/bash', 11:37:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:21 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:21 INFO - 'USER': 'cltbld', 11:37:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:21 INFO - 'XPC_FLAGS': '0x0', 11:37:21 INFO - 'XPC_SERVICE_NAME': '0', 11:37:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:22 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 11:37:22 INFO - Cleaning up... 11:37:22 INFO - Return code: 0 11:37:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:37:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:22 INFO - 'HOME': '/Users/cltbld', 11:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:22 INFO - 'LOGNAME': 'cltbld', 11:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:22 INFO - 'MOZ_NO_REMOTE': '1', 11:37:22 INFO - 'NO_EM_RESTART': '1', 11:37:22 INFO - 'PAGER': '/bin/cat', 11:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:22 INFO - 'PWD': '/builds/slave/test', 11:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:22 INFO - 'SHELL': '/bin/bash', 11:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:22 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:22 INFO - 'USER': 'cltbld', 11:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:22 INFO - 'XPC_FLAGS': '0x0', 11:37:22 INFO - 'XPC_SERVICE_NAME': '0', 11:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:22 INFO - Downloading/unpacking psutil>=3.1.1 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37: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 11:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:25 INFO - Installing collected packages: psutil 11:37:25 INFO - Running setup.py install for psutil 11:37:25 INFO - building 'psutil._psutil_osx' extension 11:37:25 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 11:37:26 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 11:37:26 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 11:37:26 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 11:37:26 INFO - building 'psutil._psutil_posix' extension 11:37:26 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 11:37:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:37:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:37:26 INFO - ^ 11:37:26 INFO - 1 warning generated. 11:37:26 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 11:37:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:26 INFO - Successfully installed psutil 11:37:26 INFO - Cleaning up... 11:37:26 INFO - Return code: 0 11:37:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:37:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:26 INFO - 'HOME': '/Users/cltbld', 11:37:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:26 INFO - 'LOGNAME': 'cltbld', 11:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:26 INFO - 'MOZ_NO_REMOTE': '1', 11:37:26 INFO - 'NO_EM_RESTART': '1', 11:37:26 INFO - 'PAGER': '/bin/cat', 11:37:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:26 INFO - 'PWD': '/builds/slave/test', 11:37:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:26 INFO - 'SHELL': '/bin/bash', 11:37:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:26 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:26 INFO - 'USER': 'cltbld', 11:37:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:26 INFO - 'XPC_FLAGS': '0x0', 11:37:26 INFO - 'XPC_SERVICE_NAME': '0', 11:37:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37:27 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 11:37:27 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 11:37:27 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 11:37:27 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 11:37:27 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 11:37:27 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 11:37:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:37:29 INFO - Installing collected packages: mozsystemmonitor 11:37:29 INFO - Running setup.py install for mozsystemmonitor 11:37:29 INFO - Successfully installed mozsystemmonitor 11:37:29 INFO - Cleaning up... 11:37:29 INFO - Return code: 0 11:37:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:29 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:29 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 11:37:29 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 11:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:29 INFO - 'HOME': '/Users/cltbld', 11:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:29 INFO - 'LOGNAME': 'cltbld', 11:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:29 INFO - 'MOZ_NO_REMOTE': '1', 11:37:29 INFO - 'NO_EM_RESTART': '1', 11:37:29 INFO - 'PAGER': '/bin/cat', 11:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:29 INFO - 'PWD': '/builds/slave/test', 11:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:29 INFO - 'SHELL': '/bin/bash', 11:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:29 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:29 INFO - 'USER': 'cltbld', 11:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:29 INFO - 'XPC_FLAGS': '0x0', 11:37:29 INFO - 'XPC_SERVICE_NAME': '0', 11:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:30 INFO - Downloading/unpacking jsonschema==2.5.1 11:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 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 11:37:32 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:32 INFO - warning: no files found matching '*.txt' 11:37:32 INFO - no previously-included directories found matching 'build' 11:37:32 INFO - no previously-included directories found matching 'dist' 11:37:32 INFO - no previously-included directories found matching '.git*' 11:37:33 INFO - Installing collected packages: jsonschema, functools32 11:37:33 INFO - Running setup.py install for functools32 11:37:33 INFO - warning: no files found matching '*.txt' 11:37:33 INFO - no previously-included directories found matching 'build' 11:37:33 INFO - no previously-included directories found matching 'dist' 11:37:33 INFO - no previously-included directories found matching '.git*' 11:37:33 INFO - Successfully installed jsonschema functools32 11:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:37:33 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')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:33 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 11:37:33 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 11:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:33 INFO - 'HOME': '/Users/cltbld', 11:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PAGER': '/bin/cat', 11:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test', 11:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:33 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - 'XPC_FLAGS': '0x0', 11:37:33 INFO - 'XPC_SERVICE_NAME': '0', 11:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:37:33 INFO - Cleaning up... 11:37:33 INFO - Return code: 0 11:37:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:33 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')]} 11:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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')]} 11:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:33 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:33 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 11:37:33 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 11:37:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:33 INFO - 'HOME': '/Users/cltbld', 11:37:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:33 INFO - 'LOGNAME': 'cltbld', 11:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:33 INFO - 'MOZ_NO_REMOTE': '1', 11:37:33 INFO - 'NO_EM_RESTART': '1', 11:37:33 INFO - 'PAGER': '/bin/cat', 11:37:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:33 INFO - 'PWD': '/builds/slave/test', 11:37:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:33 INFO - 'SHELL': '/bin/bash', 11:37:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:33 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:33 INFO - 'USER': 'cltbld', 11:37:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:33 INFO - 'XPC_FLAGS': '0x0', 11:37:33 INFO - 'XPC_SERVICE_NAME': '0', 11:37:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:33 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:33 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 11:37:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:36 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 11:37:37 INFO - Downloading docopt-0.6.1.tar.gz 11:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:37 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:37 INFO - Running setup.py install for blobuploader 11:37:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:37 INFO - Running setup.py install for requests 11:37:38 INFO - Running setup.py install for docopt 11:37:38 INFO - Successfully installed blobuploader requests docopt 11:37:38 INFO - Cleaning up... 11:37:38 INFO - Return code: 0 11:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:38 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:38 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 11:37:38 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 11:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:38 INFO - 'HOME': '/Users/cltbld', 11:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:38 INFO - 'LOGNAME': 'cltbld', 11:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:38 INFO - 'MOZ_NO_REMOTE': '1', 11:37:38 INFO - 'NO_EM_RESTART': '1', 11:37:38 INFO - 'PAGER': '/bin/cat', 11:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:38 INFO - 'PWD': '/builds/slave/test', 11:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:38 INFO - 'SHELL': '/bin/bash', 11:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:38 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:38 INFO - 'USER': 'cltbld', 11:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:38 INFO - 'XPC_FLAGS': '0x0', 11:37:38 INFO - 'XPC_SERVICE_NAME': '0', 11:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:38 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-pFccag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:38 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-xWEsaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:38 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SAQzFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:38 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vLgX04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-RCHF62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-dZM4r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-uWkt02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-u6MFFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-n75Hed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-GYD9UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-1Mv_od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-fhgZn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Lf4zmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:39 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-kGGKJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-3UitWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_oSvij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:40 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-1mdoYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:40 INFO - Running setup.py install for manifestparser 11:37:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:40 INFO - Running setup.py install for mozcrash 11:37:40 INFO - Running setup.py install for mozdebug 11:37:40 INFO - Running setup.py install for mozdevice 11:37:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:40 INFO - Running setup.py install for mozfile 11:37:41 INFO - Running setup.py install for mozhttpd 11:37:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Running setup.py install for mozinfo 11:37:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Running setup.py install for mozInstall 11:37:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Running setup.py install for mozleak 11:37:41 INFO - Running setup.py install for mozlog 11:37:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:41 INFO - Running setup.py install for moznetwork 11:37:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Running setup.py install for mozprocess 11:37:42 INFO - Running setup.py install for mozprofile 11:37:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Running setup.py install for mozrunner 11:37:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Running setup.py install for mozscreenshot 11:37:42 INFO - Running setup.py install for moztest 11:37:42 INFO - Running setup.py install for mozversion 11:37:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:42 INFO - Cleaning up... 11:37:42 INFO - Return code: 0 11:37:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:42 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:42 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 11:37:42 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 11:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:42 INFO - 'HOME': '/Users/cltbld', 11:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:42 INFO - 'LOGNAME': 'cltbld', 11:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:42 INFO - 'MOZ_NO_REMOTE': '1', 11:37:42 INFO - 'NO_EM_RESTART': '1', 11:37:42 INFO - 'PAGER': '/bin/cat', 11:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:42 INFO - 'PWD': '/builds/slave/test', 11:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:42 INFO - 'SHELL': '/bin/bash', 11:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:42 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:42 INFO - 'USER': 'cltbld', 11:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:42 INFO - 'XPC_FLAGS': '0x0', 11:37:42 INFO - 'XPC_SERVICE_NAME': '0', 11:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-u0mJQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-BVPQSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-NHjU3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QeOabJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-nIf6LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-JTMuYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-CNVT_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:43 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)) 11:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:43 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-oy8nXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-__POqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-9oztcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-cwNoYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-zPv1Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-MR0STk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QhuSm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-42wOUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-iAHNBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:44 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)) 11:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:44 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-dBLEvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:45 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)) 11:37:45 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)) 11:37:45 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)) 11:37:45 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)) 11:37:45 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)) 11:37:45 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)) 11:37:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:47 INFO - Downloading blessings-1.6.tar.gz 11:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:47 INFO - Installing collected packages: blessings 11:37:47 INFO - Running setup.py install for blessings 11:37:48 INFO - Successfully installed blessings 11:37:48 INFO - Cleaning up... 11:37:48 INFO - Return code: 0 11:37:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:48 INFO - Reading from file tmpfile_stdout 11:37:48 INFO - Current package versions: 11:37:48 INFO - blessings == 1.6 11:37:48 INFO - blobuploader == 1.2.4 11:37:48 INFO - docopt == 0.6.1 11:37:48 INFO - functools32 == 3.2.3-2 11:37:48 INFO - jsonschema == 2.5.1 11:37:48 INFO - manifestparser == 1.1 11:37:48 INFO - mozInstall == 1.12 11:37:48 INFO - mozcrash == 0.17 11:37:48 INFO - mozdebug == 0.1 11:37:48 INFO - mozdevice == 0.48 11:37:48 INFO - mozfile == 1.2 11:37:48 INFO - mozhttpd == 0.7 11:37:48 INFO - mozinfo == 0.9 11:37:48 INFO - mozleak == 0.1 11:37:48 INFO - mozlog == 3.3 11:37:48 INFO - moznetwork == 0.27 11:37:48 INFO - mozprocess == 0.23 11:37:48 INFO - mozprofile == 0.28 11:37:48 INFO - mozrunner == 6.12 11:37:48 INFO - mozscreenshot == 0.1 11:37:48 INFO - mozsystemmonitor == 0.3 11:37:48 INFO - moztest == 0.7 11:37:48 INFO - mozversion == 1.4 11:37:48 INFO - psutil == 3.1.1 11:37:48 INFO - requests == 1.2.3 11:37:48 INFO - wsgiref == 0.1.2 11:37:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37: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')]} 11:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37: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')]} 11:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:48 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 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:48 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 11:37:48 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 11:37:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:48 INFO - 'HOME': '/Users/cltbld', 11:37:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:48 INFO - 'LOGNAME': 'cltbld', 11:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:48 INFO - 'MOZ_NO_REMOTE': '1', 11:37:48 INFO - 'NO_EM_RESTART': '1', 11:37:48 INFO - 'PAGER': '/bin/cat', 11:37:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:48 INFO - 'PWD': '/builds/slave/test', 11:37:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:48 INFO - 'SHELL': '/bin/bash', 11:37:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:48 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:48 INFO - 'USER': 'cltbld', 11:37:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:48 INFO - 'XPC_FLAGS': '0x0', 11:37:48 INFO - 'XPC_SERVICE_NAME': '0', 11:37:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 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)) 11:37:48 INFO - Cleaning up... 11:37:49 INFO - Return code: 0 11:37:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10be0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cbcaf870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, '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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 11:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:49 INFO - 'HOME': '/Users/cltbld', 11:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:49 INFO - 'LOGNAME': 'cltbld', 11:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:49 INFO - 'MOZ_NO_REMOTE': '1', 11:37:49 INFO - 'NO_EM_RESTART': '1', 11:37:49 INFO - 'PAGER': '/bin/cat', 11:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:49 INFO - 'PWD': '/builds/slave/test', 11:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:49 INFO - 'SHELL': '/bin/bash', 11:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:37:49 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:49 INFO - 'USER': 'cltbld', 11:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:49 INFO - 'XPC_FLAGS': '0x0', 11:37:49 INFO - 'XPC_SERVICE_NAME': '0', 11:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:37:49 INFO - Cleaning up... 11:37:49 INFO - Return code: 0 11:37:49 INFO - Running post-action listener: _resource_record_post_action 11:37:49 INFO - Running post-action listener: _start_resource_monitoring 11:37:49 INFO - Starting resource monitoring. 11:37:49 INFO - [mozharness: 2016-08-12 18:37:49.305358Z] Finished create-virtualenv step (success) 11:37:49 INFO - [mozharness: 2016-08-12 18:37:49.306348Z] Running install step. 11:37:49 INFO - Running pre-action listener: _resource_record_pre_action 11:37:49 INFO - Running main action method: install 11:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:49 INFO - Reading from file tmpfile_stdout 11:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:37:49 INFO - Reading from file tmpfile_stdout 11:37:49 INFO - Output received: 11:37:49 INFO - Usage: mozinstall [options] installer 11:37:49 INFO - Options: 11:37:49 INFO - -h, --help show this help message and exit 11:37:49 INFO - -d DEST, --destination=DEST 11:37:49 INFO - Directory to install application into. [default: 11:37:49 INFO - "/builds/slave/test"] 11:37:49 INFO - --app=APP Application being installed. [default: firefox] 11:37:49 INFO - mkdir: /builds/slave/test/build/application 11:37:49 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'] 11:37:49 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 11:38:24 INFO - Reading from file tmpfile_stdout 11:38:24 INFO - Output received: 11:38:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:38:24 INFO - Running post-action listener: _resource_record_post_action 11:38:24 INFO - [mozharness: 2016-08-12 18:38:24.770042Z] Finished install step (success) 11:38:24 INFO - [mozharness: 2016-08-12 18:38:24.770197Z] Running run-tests step. 11:38:24 INFO - Running pre-action listener: _resource_record_pre_action 11:38:24 INFO - Running main action method: run_tests 11:38:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:24 INFO - 2016-08-12 11:38:24.784 screenresolution[1629:7503] starting screenresolution argv=screenresolution get 11:38:24 INFO - 2016-08-12 11:38:24.787 screenresolution[1629:7503] Display 0: 1600x1200x32@60 11:38:24 INFO - 2016-08-12 11:38:24.792 screenresolution[1630:7505] starting screenresolution argv=screenresolution list 11:38:24 INFO - Available Modes on Display 0 11:38:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:25 INFO - Intel Iris: 11:38:25 INFO - Chipset Model: Intel Iris 11:38:25 INFO - Type: GPU 11:38:25 INFO - Bus: Built-In 11:38:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:25 INFO - Vendor: Intel (0x8086) 11:38:25 INFO - Device ID: 0x0a2e 11:38:25 INFO - Revision ID: 0x0009 11:38:25 INFO - Displays: 11:38:25 INFO - Display: 11:38:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:25 INFO - Display Serial Number: 1600x1200 60 11:38:25 INFO - Main Display: Yes 11:38:25 INFO - Mirror: Off 11:38:25 INFO - Online: Yes 11:38:25 INFO - Rotation: Supported 11:38:25 INFO - Return code: 0 11:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:25 INFO - Python 2.7.3 11:38:25 INFO - Return code: 0 11:38:25 INFO - grabbing minidump binary from tooltool 11:38:25 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')]} 11:38:25 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 0x10bd70d30>, '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 0x10bad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd68b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:25 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 11:38:25 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 11:38:25 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 11:38:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:25 INFO - Return code: 0 11:38:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:38:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:38:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dTvoNVa8Jn/Render', 11:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:25 INFO - 'HOME': '/Users/cltbld', 11:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:25 INFO - 'LOGNAME': 'cltbld', 11:38:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:25 INFO - 'MOZ_NO_REMOTE': '1', 11:38:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:25 INFO - 'NO_EM_RESTART': '1', 11:38:25 INFO - 'PAGER': '/bin/cat', 11:38:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:25 INFO - 'PWD': '/builds/slave/test', 11:38:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:25 INFO - 'SHELL': '/bin/bash', 11:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4tMAplW9zg/Listeners', 11:38:25 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 11:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:25 INFO - 'USER': 'cltbld', 11:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:25 INFO - 'XPC_FLAGS': '0x0', 11:38:25 INFO - 'XPC_SERVICE_NAME': '0', 11:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:38:25 INFO - mozversion application_buildid: 20160812094617 11:38:25 INFO - mozversion application_changeset: c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e 11:38:25 INFO - mozversion application_display_name: Nightly 11:38:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:25 INFO - mozversion application_name: Firefox 11:38:25 INFO - mozversion application_remotingname: firefox 11:38:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:38:25 INFO - mozversion application_vendor: Mozilla 11:38:25 INFO - mozversion application_version: 51.0a1 11:38:25 INFO - mozversion platform_buildid: 20160812094617 11:38:25 INFO - mozversion platform_changeset: c4ad5f94a5bc06aa2e6a49d49ab918aa1cea906e 11:38:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:38:25 INFO - mozversion platform_version: 51.0a1 11:38:25 INFO - using testdate: 1471027105 11:38:25 INFO - actual date: 1471027105 11:38:25 INFO - starting webserver on 'localhost:49268' 11:38:25 INFO - SUITE-START | Running 2 tests 11:38:25 INFO - TEST-START | dromaeo_css 11:38:25 INFO - operating with platform_type : mac_ 11:38:25 INFO - Initialising browser for dromaeo_css test... 11:38:25 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpkA5unb/profile http://localhost:49268/getInfo.html) 11:38:28 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 11:38:28 INFO - PROCESS | 1640 | colorDepth:24 11:38:28 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 11:38:28 INFO - PROCESS | 1640 | __metrics 11:38:28 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:38:29 INFO - TEST-INFO | 1640: exit 0 11:38:29 INFO - Browser initialized. 11:38:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:29 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpkA5unb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:41 INFO - PROCESS | 1643 | RSS: Main: 254808064 11:38:41 INFO - PROCESS | 1643 | 11:39:30 INFO - PROCESS | 1643 | 1471027170810 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] 11:41:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 11:41:43 INFO - PROCESS | 1643 | RSS: Main: 267358208 11:41:43 INFO - PROCESS | 1643 | 11:44:46 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 11:44:46 INFO - PROCESS | 1643 | RSS: Main: 277106688 11:44:46 INFO - PROCESS | 1643 | 11:47:48 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 11:47:49 INFO - PROCESS | 1643 | RSS: Main: 282869760 11:47:49 INFO - PROCESS | 1643 | 11:50:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 11:50:51 INFO - PROCESS | 1643 | RSS: Main: 281411584 11:50:51 INFO - PROCESS | 1643 | 11:53:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 11:53:55 INFO - PROCESS | 1643 | RSS: Main: 286482432 11:53:55 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 11:56:58 INFO - PROCESS | 1643 | RSS: Main: 287961088 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | __start_tp_report 11:56:58 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 11:56:58 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 11:56:58 INFO - PROCESS | 1643 | |i|pagename|runs| 11:56:58 INFO - PROCESS | 1643 | |0;dojo.html;2793.790465715071;3361.7982921024727;3392.983035084824;3423.794572325659;3441.604215515215;5278.709670968095;5500.312460942382;5505.311836020497;5524.944750552489;5547.11246200608;5554.805581804638;5571;5575.442455754423;5598.440155984389;5673.971630141844;5025.949740502603;5145.30538377318;5157.2006339017325;5200.791968321262;5269.973650131744;5211.609129315298;5212.21816727492;5221.981713565856;5260.473952604747;5289.550388217006;5018.723970181639;5095.592352611782;5105.463926287761;5131.538161565459;5145.176771716545;4064.552899181088;5136.768845401966;5150.27896094547;5156.3296771419855;5178.430372659004;5031.849044528633;5073.923891141636;5126.5642420394315;5137.74311284438;5143.151380022292;5486.835394938118;5519.668819870781;5565.276514053147;5608.327000759935;5623.156526521014;6066.514678825727;6097.664628445434;6106.877862442726;6123.387661233885;6131.356207598227;6145.692715364214;6169.280614447247;6183.87632247357;6192.287886892975;6225.723726636029;5550.250716153308;5633.971830140905;5646.124850648156;5695.03184458643;5729.455701708331;6179.412955769195;6256.124142620037;6266;6307.5269354798575;6329.208848893888;5962.731677074542;5993.790217342372;6011.819645410645;6023.488003519662;6054.091886217103;6109.938900611026;6148.1085242640465;6181.8454538636;6197.101420294032;6201.56589038772;5866;6037;6069.2110025696375;6100.572959892765;6113.506711826627;6111.98679349419;6147.200863887666;6149.84625384369;6156.722947467375;6169.105479705418;4884.8290309838985;4906.8773280668265;4939.259111133359;4940.135476291634;4945.282933974553;4346.304591265382;4380.0582874682095;4405.207062728739;4452.643788496913;4494.955050449519;5537.640053396516;5596.10462326034;5647.407022262685;5662.065759149777;5666.178404131378;6198.566100372931;6208.50331973441;6209.9379006210265;6225.315215326311;6232.657203853832;4481.619062379734;5495.587830912697;5516.9448305517235;5566.944330556643;5635.943640563624;5349.598780091509;5355.464453554613;5369.543588794918;5376.381716102698;5377.435369286169;5737.881113182889;5927.851803704855;6298.874022519615;6314.494840412664;6318.8420289492215;6098.481629061402;6105.368770830132;6120.2947619997085;6169.383061693795;6184.165137706532;6235.220597425322;6243.37566243372;6249.906266403452;6260.655663938527;6301.054841773587;5676.914846277226;6078.45293923549;6113.1135985281;6134.877302454015;6148.938510614837;6020.939790602038;6024.246969128859;6088.299845517645;6130.031268545553;6196.597221180609;5962.522998160223;5968.343482216866;5972.372900845522;5973.731182096903;6023.156758053964;5778.335491418373;5903.321118071305;5941.37615550361;5958.493528050164;5979.850503737442;5010.797408621977;5497.45025497447;5645.604807663424;5750.769969201185;5869.970650146722;5531.9723401382735;5910.7931222407005;5938.138969849434;5956.106584012433;5978.372270911492;5787;5788.942110578841;5796.072628379439;5814.709264536841;5824.854378640568 11:56:58 INFO - PROCESS | 1643 | |1;ext.html;473.6873663382168;477.21259921130155;527.2565682387832;533.9188144008383;548.6762809942134;32137.67862321376;40295.99260018501;40381.99045023872;40467.392989105116;40521.59478405215;41204.79397603008;41683.791581042125;41776.37335439971;41807.79096104515;41865.58134418655;9512.952435237814;9662.130408263254;9771.36486128403;9773.120419162275;9787.510624468783;9626.518674066303;9697.175740062103;9707.320487565874;9720.9792971738;9721.70834874955;9685.225181985425;9688.079632434943;9716.368436051634;9717.951410242938;9772.511374431286;9621.807563848753;9689.757756056084;9712.22302215821;9716.222702183808;9737.999999999965;9561.856572151424;9579.281553883417;9591.184749296319;9660.178884794801;9679.08048735369;39330.41004384936;39698.603013969776;39791.80624581267;39904.600953990666;39905.20189596221;3578.76738012031;3593.1376469647357;3694.8522059117604;3876.9919820846503;4137.482814648169;30780.692193078008;32093.1976700582;32150;32378.352432951207;32423;3220.0983724557163;3308.1894935740897;3353.4131526982924;3361.865525378982;3380.290139070798;490421;501562.44531441224;501757;503577.48211259075;503829;32617.836910815768;33746.32507349888;57270.713646432334;57485;57652.42347576554;34372.656273437446;34613.480797788055;34690.30619387598;34832.30335393278;34954.65045349565;14599.927000365142;14770;14770.92614536942;14778.630534236516;14790.482333118505;11971.341576213217;12302.569410070784;12407;12409.565665201675;12421.503139874303;7703.576303303372;7706.499077559941;7791.922080779233;7807.336376407955;7824.843503129906;3031.7726170536857;3232.062701816447;3251.6910893465083;3261;3297.472404415282;928.3965422475445;993.5529011944653;996.2926322311096;1070.7911957168433;1098.4452851310036;26558.336041599116;30180.69819301779;30486.695133048386;30496;30888.84555577253;1096.7696783675358;1104.8297837491705;1123.4102096399292;1173.6244401791516;1201.531402752927;14897.77653335201;15210.391584336723;15627.296771645077;15766.132862692662;15895.68208635844;702046;707048;707170;707648;710534;57628.42371576231;58192;58938.41061589415;58986.705066474395;59171.70414147988;1386.682651481097;1407.3174510362467;1416.405109853864;1423.9857601423853;1429.4210844607742;25533;27385.726142738316;27942.602869856833;29247.7075229245;29930.700692992792;35480.112997175274;50897.491025090756;51346.22980655368;51477;51547;604815;605669;607218;607841;608095;26619.33451663724;26820.8658956704;27126.864365678044;27472.45055098927;27609.44781104407;47183.056338873714;48089.5191048085;48159.518404815506;48205.75897120492;48626;38604.613953861226;38739;39192.6080739189;40210.597894020684;40325.39511907265;32275.70897164087;32334.35331293408;38840.417393739684;40371.59628403679;40502.79748601238;38913.027174320865;41474.341026358605;41589.792051040764;42647.507337244286;43674;39341.2131757369;39552.60447395489;41116;41381.37927931023;43081.784591076845;24503.63244551369;32422.189445264055;32516.512252315762;32645.18387040343;33243.00270991874 11:56:58 INFO - PROCESS | 1643 | |2;jquery.html;360.90255630979635;367.98896033119;377.91307999160193;385.5854955922381;401.24365570898846;17543.21055552503;19014.524636884067;21373.03821328042;21417.678734818972;21477.67783483249;15924.52226433206;20572.588548229065;21427.821469819155;21439.464013399673;21716.13135474583;4663.7668116594205;5172.870678233036;5791.652500849941;5981.850453738648;6005.429484198994;5195.844124676266;6175.938240617581;6196.16351792509;6204.069389591575;6213.844653883666;5641.069223578125;5999.820005399845;6051.092336149591;6098.024316109423;6212.223472065992;5775.682337471438;5852.648841069549;5853.8829223415505;5867.589268751168;5874.1776151338845;5077.289179514871;5275;5277.3139491866195;5281.471852814726;5289.86775330616;26603.600945985825;26682.46635067288;26746.86626566874;26761.929522819064;26880;2038.6738121900573;2244.9438764030865;2263.4907145892043;2696.8516731579757;3051.5880356151856;16086.678266434723;16092.597685057966;16448.671026579403;16464.506064818073;16651.91674041634;1836.8622353323553;1880.6990881459037;1910.761154855643;1965.3121407507401;1991.75103112111;77406.61296693537;118964;122693;123257;125094.3745281277;9149.679761208326;11386.772264554662;11651.708707282385;11754;11880.34658093813;12008;12274;14347.995640305287;14509.85490145106;14522.782158267635;8239.258466738022;8522;8543.188397102265;8582.570871456403;8650.567471626393;8398.832023359499;8401.453905496122;8406.243438090602;8484.024337201177;8538.487690738451;3625.9818700906326;3718.4236443350783;4335.479742430928;4388.210122178039;4584.908301834012;1916.9137388817537;1958.6681056881173;1985.8709183903;2004.2183548416128;2008.1565742388232;746.7423738810102;876.7808047988003;889.9466032038099;927.2118699105841;980.2060331131806;20369.47228957834;21196;21533.78466215349;22131.114755409602;22261.220857269916;837.4975014991079;854.8504011798035;913.680211925834;933.6265493802398;998.3161534348994;9560.90439095614;10620;11059.22585419029;11725.882741172649;11760.88239117615;508448;520552;522469;617803;624778.3805404811;118379.40810295893;133015;149784;153900;160269;964.9903500965041;992.335135459244;1008.7528555503802;1011.0546638892658;1012.711377257478;18559.44321670352;19058.904705476383;19660.705089423955;19973.800261997196;20014.399568012985;50266.24600631066;54743.45256547384;57242;57305.71347143238;57475.42524574701;58770;86565.60428403609;86985;87981.56009220169;90583;8028.31759300466;8122.390820688353;8387.329013679013;8459.308138372227;8478.491290522588;12212.633620991384;13194.274314912773;13269.336533173495;13677.521286754916;13926.721465570428;10029.849552256868;11128.610498632508;11414.429278536207;11660.650180494598;11750.70623234426;11287.266327688674;11359.716007099558;11498.482568284615;11500.48247828833;11505.482253298454;11229.101671866069;11464.484098215768;11999.76000480003;12007.639770806889;12081.973032292002;6792.422644075309;8071.878921816295;8191.79520511992;8233.423660343718;8251.092379838094;8288.046874609498;10454.215933805148;11396.316221026766;11524.884751152382;11774.999125074464 11:56:58 INFO - PROCESS | 1643 | |3;mootools.html;1515.613518552769;1542.0747551469117;1753.8070812210663;1831.7618709567755;1881.200489791839;7510.887336689947;7954.323882469983;8369.204925532073;8414.91585084149;8982.73051808446;8414.705485308015;8669.133086691329;8715.084916083815;8718.956405217965;8719.869201961976;2293.266154830451;2331.184085570045;2340.5903966805827;2344.308429013445;2347.2840783561005;2303.09027933966;2324.0703718512646;2348.4598542335275;2355.3640517060385;2360.7639236076425;2307.3885420363617;2340.2745149003777;2350.9294721158394;2352.023910077316;2354.846934949223;2305.1240528599023;2319.8840057997118;2329.219711396684;2329.580675478413;2332.7433982261855;2317.9768202317928;2320.048780000192;2323.512062466884;2323.7211534615953;2336.100601268507;8679.392442529026;8686.391952563323;8765.649374025095;8787.077356877564;8789.208971192624;5154.561862241714;5304.124819404794;5317.8404647860625;5322.1750628652235;5361;2714.484247992875;3149.9370012599848;3484.9651503484893;3604.567451905788;3618.4029635110173;1075.5643964194514;1075.93544387337;1084.295208114724;1085.473545330514;1089.553283153903;11345.205835591512;11447.42762861862;11497.25267857595;11619.95420412167;11668.591599294068;4533.818647254073;4593.356930029799;4766.475687674353;4768.594669453066;4782.0914026334885;9953.303268771117;10009.399436033862;10012.04885535873;10044.598216071276;10058.698239052841;5198.92201616976;5235.4502777207845;5276.815311464157;5286.022085914118;5294.285271488377;4248.787560621957;4354.325079612665;4786.353842231324;4824.662273640882;4832.226843704991;3835.5780864104927;3870.2646497165447;3956.4658771066115;3985.7807820570147;3988.700847436454;1072.3405105859997;1251.0929576057285;1270.7077372204444;1272.2811611439506;1283.9935800320939;846.8440578610276;906.909309069101;930.8417569013284;942.3639043645649;980.1619615228876;4967.329410529533;5793.102069179284;5793.826185214451;6068.817935461855;6093.817185484442;431.34866351808995;431.5059257150545;436.9388285640013;449.6447806233039;458.90363023765383;3535.7878527288444;3944.802759862053;3993.0815912340327;4095.692823038284;4103.712740108223;10375.325603835727;10574.154067674568;10605.045545900906;10702.571897124184;10807.40559269232;10640.574377024986;10653.9467302663;10671.199660025373;10671.786564268672;10676.306040107369;8144.633491492897;8235.629396677285;8246.422750407533;8253.968253968254;8263.876041859377;4470.754108524063;5733.3406658234835;6051.848703782441;6083.087536869505;6088.147659327609;8099.230573095547;9934.453605051502;10174.389536627827;10218;10246.436445995243;9945.701628951143;10182;10290.434026128634;10300.845487317845;10363.844542332023;6381.744730210739;6994.755183568551;7513.361364284097;7538.434617403607;7724.7682569523;8417.494950303002;8466.74599762008;8492.405531612727;8507;8527.275181609633;7389.593572353572;7498.475106742476;7520.7367742130955;7564.281393267631;7634.961825190839;7290.453216008927;7345.0084238627105;7363.484556081023;7477.663505142173;7539.246075392417;6950;7059.929400705927;7066.364027237573;7071.116110486189;7096.5742055474775;4950.628702847229;4982.900341993068;5071.366079240095;5087.414947280962;5115.948840511547;4968.602511799119;4981.053599816023;5128.1794912813775;5177.585793136615;5244.501772331622 11:56:58 INFO - PROCESS | 1643 | |4;prototype.html;300.4171906501389;305.37703085705164;312.2568287475807;314.7104663709387;315.07682490303404;4723.574878260956;5444.673319600826;5631.436856314366;5717.714114294289;5733.226014488043;5012.91963835008;5325.547328477074;5588.552915766739;5600.243967064445;5620.269364982547;4210.557891421403;4245.745255284685;4263.722858014235;4266.935995960063;4267.765272909989;3396.7961922284617;4068.8169032393466;4131.690123240769;4282.015136518587;4289.498675463594;4150.190712811003;4159.2721273777115;4171.812268447927;4187.68592355573;4235.301175306071;3677.043968568165;4226.873193804191;4227.175700738358;4233.703640745133;4252.149570085964;3339.6493368196234;3401.6598340166033;3658.743887927846;3660.4509323601405;3686.318031164243;4744.786484608201;5142.460041695643;5313.707746073965;5347.679139251619;5368.7115092377935;4116.176764647083;4582.931256031162;4734.692245004064;4808;4827.958386216696;5024.723640199824;5441.782328706847;5845.327787304472;5865.325487568899;5906.320773111104;3094.69053094691;3952.446657467957;4008.8596899108684;4010.438538604598;4021.7586944783407;5101.872453188663;5976.372480889488;6230.629261562449;6283.246010478726;6302.590331628429;4044.676425885922;4058.7564746115327;4075.97962010194;4082.8366865325647;4087.202995415865;3824.4836947011795;4056.1076563156057;4064.065264989069;4082.2447847148374;4115.403266526337;4170.435182362886;4387.407699960529;4772.973810630661;4776.689515181502;4787.497312782178;4963.90072198554;5194.532492075731;5904.232449781587;5987.491063259585;6002.279726432856;1134.3704244144578;1144.3864151546445;1323.2788130468919;1384.3424373422745;1390.1589538329165;746.6192241956533;903.8734577159203;909.1817364372118;909.5770466733001;934.3366209990846;4974.427940786783;5034.903534326363;5381;5403.540699040547;5486.91769623456;5460.754266058037;5768.3654797972185;5963.896679114378;5985.25184351956;6011.278646562353;5038.874028149326;5207.427183009866;5365.865853353697;5447.972760136253;5540.69793598504;3126.499760038383;3171.587693599817;3181.618205815317;3204.7916885402374;3236.821974791409;6027.668478233739;6265.238418801743;6366.395192456709;6383.425491705769;6410.423061924356;5171.896562068738;5258.92111618326;5822.417758224144;6196.442320191204;6239.812805615838;5227.26818245446;5823.5923485355615;6256.562040657202;6329.240491141;6333.398327158912;5602.85141545974;6033.276006879202;6036.517078633787;6059.818205453844;6096.847578810388;6046.3046749624355;6098.146259523759;6127.571070025056;6135.895538803058;6144.662043587646;6134.2332208473945;6382.712777924911;6385.96807015962;6400.871982560416;6425.787106446776;3928.0948739861715;3967.424723415146;3992.883771601056;4016.678665706795;4028.033272014754;5834.38738932406;5866.853328666817;5935.940640593712;6087.847803804941;6197.194364732556;5368.704721240213;5418.322709661293;5600.635958662837;5755.53955683536;5813.738381772746;4891.9755401222765;5857.150713146485;5900.321463031806;5905.5570832186895;5974.312954010171;5116.283720279238;5597.740508385581;5713.628614140068;5737.340205876378;5795.58060744163;5900.645961242168;5935.231128233517;5956.54064754138;5981.872507969487;6021.7591296347655;5367.255641916315;5823.242978412779;5851.473367396955;5857.924589590499;5886.3525012247765 11:56:58 INFO - PROCESS | 1643 | |5;yui.html;690.4683393786785;692.7644600835715;700.488643290398;711.9644017799109;754.8829931360634;15232.695346093085;15704.528864134065;15746.448874289403;15790.763138552931;15976.2011899405;14497.275136243199;14534.200618965953;14535.055221410601;14642.926785366084;14654.85345146551;836.9832603347944;860.0238729042551;865.1824026295153;866.4065115395974;866.6620018192909;683.5898460923456;826.4421515477059;850.26452118917;859.3340161374953;860.4192170285064;896.5651658945407;904.6471875968344;907.9001309855944;909.5361365703505;910.8406028944942;872.4198408058634;903.9683611073581;905.2034209895315;905.728281515546;905.868649045888;558.5029323901731;665.0855074272874;671.4628297362091;672.9831754206135;673.249327000396;13091.803622945568;14477;14917.328720207508;14935.327910244065;14996.550103496913;12931.935340323238;13915.095518791246;14518.92740536301;14655.853441465555;14875.256237188098;12116.09129315305;12118.575849845212;12124.454399552042;12175.0868684849;12269.141160118796;3843.7501562398356;3870.4774855394444;3878.4957955465893;3897.5322961244547;4020.4572382728543;116964;120948.79051209464;123876.38061809723;125269;126636;9538;10132.645357412455;11059.557617695364;11235.045021173128;11297.322160670221;23274.8836255821;23409.297721068397;23422.531549368916;23449.296521104396;23457.765422345557;8119.512829230265;8308.6676532938;8376.83246335082;8378.581070946428;8456.577171141418;4495.190865644216;4607.815687372467;4615.930761038587;4722.291656251589;4749.501302363271;3080.6919308069014;3479.5302634144573;3560.8219589020446;3617.222297206113;3634.327649384872;629.5750368501243;644.3105876711874;656.4420242793587;659.9835004124935;668.7091115364832;548.6680558262274;560.680412165062;624.194788722552;653.9112377890854;689.8723736108836;8610.655573777103;9396.718098457057;9502.619895204114;9560.008756044617;9628.614855405705;641.7914177892204;673.0577191931237;675.3213020914048;687.4191308344441;702.610051421466;4406.977965110218;4408.048526413864;4683.672859788467;4787.114383839001;4795.352627395327;88726.55636721905;118826.40586797011;144013;151278;153789;58727;84612.15387846166;126723;137158.31420842832;140494.29752851374;115122;118839;119527;120716.79283207231;123079;8423.368247381593;8945.865812012955;8958.731238062868;9028.593713282786;9083.409578377385;44526.55473445224;63811;66853.99719004316;67118;68737;84553.57723211344;85903.71144432714;87601.56199218963;93141;103571;12722.236665800081;13200.537981170613;13368.532101376406;13507.257100859548;13722.108062975874;14824.555263342118;15100.320485578395;15127.773083403978;15329.38682452734;15389.769153462483;13677.24775137377;14172.716545668824;14229.217393043482;14394.136351818925;14470.565883023526;13889.305534723022;13986.775340604849;14152.646183845487;14372.28138593087;14530.564083077525;11115;13578.796318055434;13764.17414955106;13829.585112446643;14455.49405770793;9277.304202184729;10866.486800721526;11372.488238029475;11521.596744113916;12011.219270747373;9875.851862221929;11280.661580152608;11642.301461912313;11689.298642081503;11706.531738730697 11:56:58 INFO - PROCESS | 1643 | __end_tp_report 11:56:58 INFO - PROCESS | 1643 | __start_cc_report 11:56:58 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,405 11:56:58 INFO - PROCESS | 1643 | __end_cc_report 11:56:58 INFO - PROCESS | 1643 | __startTimestamp1471028218407__endTimestamp 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | ------- Summary: start ------- 11:56:58 INFO - PROCESS | 1643 | Number of tests: 6 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5625.62 Median:5778.34 stddev:641.31 (11.1%) stddev-sans-first:603.57 11:56:58 INFO - PROCESS | 1643 | Values: 2793.8 3361.8 3393.0 3423.8 3441.6 5278.7 5500.3 5505.3 5524.9 5547.1 5554.8 5571.0 5575.4 5598.4 5674.0 5025.9 5145.3 5157.2 5200.8 5270.0 5211.6 5212.2 5222.0 5260.5 5289.6 5018.7 5095.6 5105.5 5131.5 5145.2 4064.6 5136.8 5150.3 5156.3 5178.4 5031.8 5073.9 5126.6 5137.7 5143.2 5486.8 5519.7 5565.3 5608.3 5623.2 6066.5 6097.7 6106.9 6123.4 6131.4 6145.7 6169.3 6183.9 6192.3 6225.7 5550.3 5634.0 5646.1 5695.0 5729.5 6179.4 6256.1 6266.0 6307.5 6329.2 5962.7 5993.8 6011.8 6023.5 6054.1 6109.9 6148.1 6181.8 6197.1 6201.6 5866.0 6037.0 6069.2 6100.6 6113.5 6112.0 6147.2 6149.8 6156.7 6169.1 4884.8 4906.9 4939.3 4940.1 4945.3 4346.3 4380.1 4405.2 4452.6 4495.0 5537.6 5596.1 5647.4 5662.1 5666.2 6198.6 6208.5 6209.9 6225.3 6232.7 4481.6 5495.6 5516.9 5566.9 5635.9 5349.6 5355.5 5369.5 5376.4 5377.4 5737.9 5927.9 6298.9 6314.5 6318.8 6098.5 6105.4 6120.3 6169.4 6184.2 6235.2 6243.4 6249.9 6260.7 6301.1 5676.9 6078.5 6113.1 6134.9 6148.9 6020.9 6024.2 6088.3 6130.0 6196.6 5962.5 5968.3 5972.4 5973.7 6023.2 5778.3 5903.3 5941.4 5958.5 5979.9 5010.8 5497.5 5645.6 5750.8 5870.0 5532.0 5910.8 5938.1 5956.1 5978.4 5787.0 5788.9 5796.1 5814.7 5824.9 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:71974.16 Median:40310.69 stddev:163760.16 (406.2%) stddev-sans-first:164131.56 11:56:58 INFO - PROCESS | 1643 | Values: 473.7 477.2 527.3 533.9 548.7 32137.7 40296.0 40382.0 40467.4 40521.6 41204.8 41683.8 41776.4 41807.8 41865.6 9513.0 9662.1 9771.4 9773.1 9787.5 9626.5 9697.2 9707.3 9721.0 9721.7 9685.2 9688.1 9716.4 9718.0 9772.5 9621.8 9689.8 9712.2 9716.2 9738.0 9561.9 9579.3 9591.2 9660.2 9679.1 39330.4 39698.6 39791.8 39904.6 39905.2 3578.8 3593.1 3694.9 3877.0 4137.5 30780.7 32093.2 32150.0 32378.4 32423.0 3220.1 3308.2 3353.4 3361.9 3380.3 490421.0 501562.4 501757.0 503577.5 503829.0 32617.8 33746.3 57270.7 57485.0 57652.4 34372.7 34613.5 34690.3 34832.3 34954.7 14599.9 14770.0 14770.9 14778.6 14790.5 11971.3 12302.6 12407.0 12409.6 12421.5 7703.6 7706.5 7791.9 7807.3 7824.8 3031.8 3232.1 3251.7 3261.0 3297.5 928.4 993.6 996.3 1070.8 1098.4 26558.3 30180.7 30486.7 30496.0 30888.8 1096.8 1104.8 1123.4 1173.6 1201.5 14897.8 15210.4 15627.3 15766.1 15895.7 702046.0 707048.0 707170.0 707648.0 710534.0 57628.4 58192.0 58938.4 58986.7 59171.7 1386.7 1407.3 1416.4 1424.0 1429.4 25533.0 27385.7 27942.6 29247.7 29930.7 35480.1 50897.5 51346.2 51477.0 51547.0 604815.0 605669.0 607218.0 607841.0 608095.0 26619.3 26820.9 27126.9 27472.5 27609.4 47183.1 48089.5 48159.5 48205.8 48626.0 38604.6 38739.0 39192.6 40210.6 40325.4 32275.7 32334.4 38840.4 40371.6 40502.8 38913.0 41474.3 41589.8 42647.5 43674.0 39341.2 39552.6 41116.0 41381.4 43081.8 24503.6 32422.2 32516.5 32645.2 33243.0 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34631.82 Median:26820.96 stddev:94520.14 (352.4%) stddev-sans-first:94750.27 11:56:58 INFO - PROCESS | 1643 | Values: 360.9 368.0 377.9 385.6 401.2 17543.2 19014.5 21373.0 21417.7 21477.7 15924.5 20572.6 21427.8 21439.5 21716.1 4663.8 5172.9 5791.7 5981.9 6005.4 5195.8 6175.9 6196.2 6204.1 6213.8 5641.1 5999.8 6051.1 6098.0 6212.2 5775.7 5852.6 5853.9 5867.6 5874.2 5077.3 5275.0 5277.3 5281.5 5289.9 26603.6 26682.5 26746.9 26761.9 26880.0 2038.7 2244.9 2263.5 2696.9 3051.6 16086.7 16092.6 16448.7 16464.5 16651.9 1836.9 1880.7 1910.8 1965.3 1991.8 77406.6 118964.0 122693.0 123257.0 125094.4 9149.7 11386.8 11651.7 11754.0 11880.3 12008.0 12274.0 14348.0 14509.9 14522.8 8239.3 8522.0 8543.2 8582.6 8650.6 8398.8 8401.5 8406.2 8484.0 8538.5 3626.0 3718.4 4335.5 4388.2 4584.9 1916.9 1958.7 1985.9 2004.2 2008.2 746.7 876.8 889.9 927.2 980.2 20369.5 21196.0 21533.8 22131.1 22261.2 837.5 854.9 913.7 933.6 998.3 9560.9 10620.0 11059.2 11725.9 11760.9 508448.0 520552.0 522469.0 617803.0 624778.4 118379.4 133015.0 149784.0 153900.0 160269.0 965.0 992.3 1008.8 1011.1 1012.7 18559.4 19058.9 19660.7 19973.8 20014.4 50266.2 54743.5 57242.0 57305.7 57475.4 58770.0 86565.6 86985.0 87981.6 90583.0 8028.3 8122.4 8387.3 8459.3 8478.5 12212.6 13194.3 13269.3 13677.5 13926.7 10029.8 11128.6 11414.4 11660.7 11750.7 11287.3 11359.7 11498.5 11500.5 11505.5 11229.1 11464.5 11999.8 12007.6 12082.0 6792.4 8071.9 8191.8 8233.4 8251.1 8288.0 10454.2 11396.3 11524.9 11775.0 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5665.07 Median:4679.92 stddev:3209.14 (68.6%) stddev-sans-first:3202.99 11:56:58 INFO - PROCESS | 1643 | Values: 1515.6 1542.1 1753.8 1831.8 1881.2 7510.9 7954.3 8369.2 8414.9 8982.7 8414.7 8669.1 8715.1 8719.0 8719.9 2293.3 2331.2 2340.6 2344.3 2347.3 2303.1 2324.1 2348.5 2355.4 2360.8 2307.4 2340.3 2350.9 2352.0 2354.8 2305.1 2319.9 2329.2 2329.6 2332.7 2318.0 2320.0 2323.5 2323.7 2336.1 8679.4 8686.4 8765.6 8787.1 8789.2 5154.6 5304.1 5317.8 5322.2 5361.0 2714.5 3149.9 3485.0 3604.6 3618.4 1075.6 1075.9 1084.3 1085.5 1089.6 11345.2 11447.4 11497.3 11620.0 11668.6 4533.8 4593.4 4766.5 4768.6 4782.1 9953.3 10009.4 10012.0 10044.6 10058.7 5198.9 5235.5 5276.8 5286.0 5294.3 4248.8 4354.3 4786.4 4824.7 4832.2 3835.6 3870.3 3956.5 3985.8 3988.7 1072.3 1251.1 1270.7 1272.3 1284.0 846.8 906.9 930.8 942.4 980.2 4967.3 5793.1 5793.8 6068.8 6093.8 431.3 431.5 436.9 449.6 458.9 3535.8 3944.8 3993.1 4095.7 4103.7 10375.3 10574.2 10605.0 10702.6 10807.4 10640.6 10653.9 10671.2 10671.8 10676.3 8144.6 8235.6 8246.4 8254.0 8263.9 4470.8 5733.3 6051.8 6083.1 6088.1 8099.2 9934.5 10174.4 10218.0 10246.4 9945.7 10182.0 10290.4 10300.8 10363.8 6381.7 6994.8 7513.4 7538.4 7724.8 8417.5 8466.7 8492.4 8507.0 8527.3 7389.6 7498.5 7520.7 7564.3 7635.0 7290.5 7345.0 7363.5 7477.7 7539.2 6950.0 7059.9 7066.4 7071.1 7096.6 4950.6 4982.9 5071.4 5087.4 5115.9 4968.6 4981.1 5128.2 5177.6 5244.5 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4766.73 Median:5366.56 stddev:1492.57 (27.8%) stddev-sans-first:1458.62 11:56:58 INFO - PROCESS | 1643 | Values: 300.4 305.4 312.3 314.7 315.1 4723.6 5444.7 5631.4 5717.7 5733.2 5012.9 5325.5 5588.6 5600.2 5620.3 4210.6 4245.7 4263.7 4266.9 4267.8 3396.8 4068.8 4131.7 4282.0 4289.5 4150.2 4159.3 4171.8 4187.7 4235.3 3677.0 4226.9 4227.2 4233.7 4252.1 3339.6 3401.7 3658.7 3660.5 3686.3 4744.8 5142.5 5313.7 5347.7 5368.7 4116.2 4582.9 4734.7 4808.0 4828.0 5024.7 5441.8 5845.3 5865.3 5906.3 3094.7 3952.4 4008.9 4010.4 4021.8 5101.9 5976.4 6230.6 6283.2 6302.6 4044.7 4058.8 4076.0 4082.8 4087.2 3824.5 4056.1 4064.1 4082.2 4115.4 4170.4 4387.4 4773.0 4776.7 4787.5 4963.9 5194.5 5904.2 5987.5 6002.3 1134.4 1144.4 1323.3 1384.3 1390.2 746.6 903.9 909.2 909.6 934.3 4974.4 5034.9 5381.0 5403.5 5486.9 5460.8 5768.4 5963.9 5985.3 6011.3 5038.9 5207.4 5365.9 5448.0 5540.7 3126.5 3171.6 3181.6 3204.8 3236.8 6027.7 6265.2 6366.4 6383.4 6410.4 5171.9 5258.9 5822.4 6196.4 6239.8 5227.3 5823.6 6256.6 6329.2 6333.4 5602.9 6033.3 6036.5 6059.8 6096.8 6046.3 6098.1 6127.6 6135.9 6144.7 6134.2 6382.7 6386.0 6400.9 6425.8 3928.1 3967.4 3992.9 4016.7 4028.0 5834.4 5866.9 5935.9 6087.8 6197.2 5368.7 5418.3 5600.6 5755.5 5813.7 4892.0 5857.2 5900.3 5905.6 5974.3 5116.3 5597.7 5713.6 5737.3 5795.6 5900.6 5935.2 5956.5 5981.9 6021.8 5367.3 5823.2 5851.5 5857.9 5886.4 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:24549.15 Median:3857.11 stddev:38857.86 (1007.4%) stddev-sans-first:38925.58 11:56:58 INFO - PROCESS | 1643 | Values: 690.5 692.8 700.5 712.0 754.9 15232.7 15704.5 15746.4 15790.8 15976.2 14497.3 14534.2 14535.1 14642.9 14654.9 837.0 860.0 865.2 866.4 866.7 683.6 826.4 850.3 859.3 860.4 896.6 904.6 907.9 909.5 910.8 872.4 904.0 905.2 905.7 905.9 558.5 665.1 671.5 673.0 673.2 13091.8 14477.0 14917.3 14935.3 14996.6 12931.9 13915.1 14518.9 14655.9 14875.3 12116.1 12118.6 12124.5 12175.1 12269.1 3843.8 3870.5 3878.5 3897.5 4020.5 116964.0 120948.8 123876.4 125269.0 126636.0 9538.0 10132.6 11059.6 11235.0 11297.3 23274.9 23409.3 23422.5 23449.3 23457.8 8119.5 8308.7 8376.8 8378.6 8456.6 4495.2 4607.8 4615.9 4722.3 4749.5 3080.7 3479.5 3560.8 3617.2 3634.3 629.6 644.3 656.4 660.0 668.7 548.7 560.7 624.2 653.9 689.9 8610.7 9396.7 9502.6 9560.0 9628.6 641.8 673.1 675.3 687.4 702.6 4407.0 4408.0 4683.7 4787.1 4795.4 88726.6 118826.4 144013.0 151278.0 153789.0 58727.0 84612.2 126723.0 137158.3 140494.3 115122.0 118839.0 119527.0 120716.8 123079.0 8423.4 8945.9 8958.7 9028.6 9083.4 44526.6 63811.0 66854.0 67118.0 68737.0 84553.6 85903.7 87601.6 93141.0 103571.0 12722.2 13200.5 13368.5 13507.3 13722.1 14824.6 15100.3 15127.8 15329.4 15389.8 13677.2 14172.7 14229.2 14394.1 14470.6 13889.3 13986.8 14152.6 14372.3 14530.6 11115.0 13578.8 13764.2 13829.6 14455.5 9277.3 10866.5 11372.5 11521.6 12011.2 9875.9 11280.7 11642.3 11689.3 11706.5 11:56:58 INFO - PROCESS | 1643 | -------- Summary: end -------- 11:56:58 INFO - PROCESS | 1643 | 11:56:58 INFO - TEST-INFO | 1643: exit 0 11:56:59 INFO - TEST-OK | dromaeo_css | took 1113638ms 11:56:59 INFO - TEST-START | kraken 11:56:59 INFO - operating with platform_type : mac_ 11:56:59 INFO - Initialising browser for kraken test... 11:56:59 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp_V1xYe/profile http://localhost:49268/getInfo.html) 11:57:01 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 11:57:01 INFO - PROCESS | 1655 | colorDepth:24 11:57:01 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 11:57:01 INFO - PROCESS | 1655 | __metrics 11:57:01 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 11:57:02 INFO - TEST-INFO | 1655: exit 0 11:57:02 INFO - Browser initialized. 11:57:02 INFO - Running cycle 1/1 for kraken test... 11:57:02 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmp_V1xYe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:14 INFO - PROCESS | 1657 | RSS: Main: 254672896 11:57:14 INFO - PROCESS | 1657 | 11:57:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:18 INFO - PROCESS | 1657 | RSS: Main: 267304960 11:57:18 INFO - PROCESS | 1657 | 11:57:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 11:57:21 INFO - PROCESS | 1657 | RSS: Main: 275980288 11:57:21 INFO - PROCESS | 1657 | 11:57:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 11:57:25 INFO - PROCESS | 1657 | RSS: Main: 278908928 11:57:25 INFO - PROCESS | 1657 | 11:57:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 11:57:28 INFO - PROCESS | 1657 | RSS: Main: 280256512 11:57:28 INFO - PROCESS | 1657 | 11:57:30 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:30 INFO - PROCESS | 1657 | RSS: Main: 280543232 11:57:30 INFO - PROCESS | 1657 | 11:57:33 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:34 INFO - PROCESS | 1657 | RSS: Main: 281927680 11:57:34 INFO - PROCESS | 1657 | 11:57:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:38 INFO - PROCESS | 1657 | RSS: Main: 281616384 11:57:38 INFO - PROCESS | 1657 | 11:57:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 11:57:41 INFO - PROCESS | 1657 | RSS: Main: 282427392 11:57:41 INFO - PROCESS | 1657 | 11:57:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:44 INFO - PROCESS | 1657 | RSS: Main: 281825280 11:57:44 INFO - PROCESS | 1657 | 11:57:45 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:46 INFO - PROCESS | 1657 | RSS: Main: 282030080 11:57:46 INFO - PROCESS | 1657 | 11:57:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:49 INFO - PROCESS | 1657 | RSS: Main: 282251264 11:57:49 INFO - PROCESS | 1657 | 11:57:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:53 INFO - PROCESS | 1657 | RSS: Main: 282001408 11:57:53 INFO - PROCESS | 1657 | 11:57:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:56 INFO - PROCESS | 1657 | RSS: Main: 282763264 11:57:56 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 11:57:58 INFO - PROCESS | 1657 | RSS: Main: 283496448 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | __start_tp_report 11:57:58 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 11:57:58 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 11:57:58 INFO - PROCESS | 1657 | |i|pagename|runs| 11:57:58 INFO - PROCESS | 1657 | |0;ai-astar;106;119;108;115;117;118;115;118;118;116 11:57:58 INFO - PROCESS | 1657 | |1;audio-beat-detection;139;109;133;157;114;127;159;147;206;110 11:57:58 INFO - PROCESS | 1657 | |2;audio-dft;198;200;233;277;198;196;198;197;193;196 11:57:58 INFO - PROCESS | 1657 | |3;audio-fft;71;81;75;147;59;60;60;62;138;72 11:57:58 INFO - PROCESS | 1657 | |4;audio-oscillator;74;72;117;72;75;107;114;72;72;118 11:57:58 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;92;89;91;88;92;88;92;91;138;133 11:57:58 INFO - PROCESS | 1657 | |6;imaging-darkroom;151;116;98;97;95;154;127;98;97;97 11:57:58 INFO - PROCESS | 1657 | |7;imaging-desaturate;140;147;94;96;92;142;144;118;96;90 11:57:58 INFO - PROCESS | 1657 | |8;json-parse-financial;56;59;56;56;56;57;55;56;57;58 11:57:58 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;70;72;71;91;79;80;66;74;79;77 11:57:58 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;86;88;85;84;90;76;102;87;88;89 11:57:58 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;146;147;128;163;156;160;139;137;174;162 11:57:58 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;212;166;231;231;186;175;171;212;154;236 11:57:58 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;69;66;70;66;70;68;66;70;98;86 11:57:58 INFO - PROCESS | 1657 | __end_tp_report 11:57:58 INFO - PROCESS | 1657 | __start_cc_report 11:57:58 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1057 11:57:58 INFO - PROCESS | 1657 | __end_cc_report 11:57:58 INFO - PROCESS | 1657 | __startTimestamp1471028278883__endTimestamp 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | ------- Summary: start ------- 11:57:58 INFO - PROCESS | 1657 | Number of tests: 14 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:115.00 Median:117.50 stddev:4.45 (3.8%) stddev-sans-first:3.32 11:57:58 INFO - PROCESS | 1657 | Values: 106.0 119.0 108.0 115.0 117.0 118.0 115.0 118.0 118.0 116.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:143.00 stddev:29.46 (20.6%) stddev-sans-first:31.24 11:57:58 INFO - PROCESS | 1657 | Values: 139.0 109.0 133.0 157.0 114.0 127.0 159.0 147.0 206.0 110.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:208.60 Median:198.00 stddev:26.63 (13.4%) stddev-sans-first:27.96 11:57:58 INFO - PROCESS | 1657 | Values: 198.0 200.0 233.0 277.0 198.0 196.0 198.0 197.0 193.0 196.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:82.50 Median:66.50 stddev:32.53 (48.9%) stddev-sans-first:34.24 11:57:58 INFO - PROCESS | 1657 | Values: 71.0 81.0 75.0 147.0 59.0 60.0 60.0 62.0 138.0 72.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:72.00 stddev:21.47 (29.8%) stddev-sans-first:22.05 11:57:58 INFO - PROCESS | 1657 | Values: 74.0 72.0 117.0 72.0 75.0 107.0 114.0 72.0 72.0 118.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:91.00 stddev:19.13 (21.0%) stddev-sans-first:20.10 11:57:58 INFO - PROCESS | 1657 | Values: 92.0 89.0 91.0 88.0 92.0 88.0 92.0 91.0 138.0 133.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:113.00 Median:97.00 stddev:23.27 (24.0%) stddev-sans-first:20.21 11:57:58 INFO - PROCESS | 1657 | Values: 151.0 116.0 98.0 97.0 95.0 154.0 127.0 98.0 97.0 97.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:115.90 Median:91.00 stddev:24.80 (27.3%) stddev-sans-first:24.73 11:57:58 INFO - PROCESS | 1657 | Values: 140.0 147.0 94.0 96.0 92.0 142.0 144.0 118.0 96.0 90.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:1.17 (2.1%) stddev-sans-first:1.22 11:57:58 INFO - PROCESS | 1657 | Values: 56.0 59.0 56.0 56.0 56.0 57.0 55.0 56.0 57.0 58.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:75.90 Median:78.00 stddev:7.00 (9.0%) stddev-sans-first:7.09 11:57:58 INFO - PROCESS | 1657 | Values: 70.0 72.0 71.0 91.0 79.0 80.0 66.0 74.0 79.0 77.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:6.43 (7.4%) stddev-sans-first:6.80 11:57:58 INFO - PROCESS | 1657 | Values: 86.0 88.0 85.0 84.0 90.0 76.0 102.0 87.0 88.0 89.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:158.00 stddev:14.18 (9.0%) stddev-sans-first:14.91 11:57:58 INFO - PROCESS | 1657 | Values: 146.0 147.0 128.0 163.0 156.0 160.0 139.0 137.0 174.0 162.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.40 Median:212.00 stddev:30.50 (14.4%) stddev-sans-first:31.89 11:57:58 INFO - PROCESS | 1657 | Values: 212.0 166.0 231.0 231.0 186.0 175.0 171.0 212.0 154.0 236.0 11:57:58 INFO - PROCESS | 1657 | 11:57:58 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:70.00 stddev:10.59 (15.1%) stddev-sans-first:11.14 11:57:58 INFO - PROCESS | 1657 | Values: 69.0 66.0 70.0 66.0 70.0 68.0 66.0 70.0 98.0 86.0 11:57:58 INFO - PROCESS | 1657 | -------- Summary: end -------- 11:57:58 INFO - PROCESS | 1657 | 11:57:59 INFO - TEST-INFO | 1657: exit 0 11:57:59 INFO - TEST-OK | kraken | took 60884ms 11:57:59 INFO - SUITE-END | took 1174s 11:58:00 INFO - Completed test suite (00:19:34) 11:58:00 INFO - javascript benchmark 11:58:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.549183392707, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2793.790465715071, 3361.7982921024727, 3392.983035084824, 3423.794572325659, 3441.604215515215, 5278.709670968095, 5500.312460942382, 5505.311836020497, 5524.944750552489, 5547.11246200608, 5554.805581804638, 5571.0, 5575.442455754423, 5598.440155984389, 5673.971630141844, 5025.949740502603, 5145.30538377318, 5157.2006339017325, 5200.791968321262, 5269.973650131744, 5211.609129315298, 5212.21816727492, 5221.981713565856, 5260.473952604747, 5289.550388217006, 5018.723970181639, 5095.592352611782, 5105.463926287761, 5131.538161565459, 5145.176771716545, 4064.552899181088, 5136.768845401966, 5150.27896094547, 5156.3296771419855, 5178.430372659004, 5031.849044528633, 5073.923891141636, 5126.5642420394315, 5137.74311284438, 5143.151380022292, 5486.835394938118, 5519.668819870781, 5565.276514053147, 5608.327000759935, 5623.156526521014, 6066.514678825727, 6097.664628445434, 6106.877862442726, 6123.387661233885, 6131.356207598227, 6145.692715364214, 6169.280614447247, 6183.87632247357, 6192.287886892975, 6225.723726636029, 5550.250716153308, 5633.971830140905, 5646.124850648156, 5695.03184458643, 5729.455701708331, 6179.412955769195, 6256.124142620037, 6266.0, 6307.5269354798575, 6329.208848893888, 5962.731677074542, 5993.790217342372, 6011.819645410645, 6023.488003519662, 6054.091886217103, 6109.938900611026, 6148.1085242640465, 6181.8454538636, 6197.101420294032, 6201.56589038772, 5866.0, 6037.0, 6069.2110025696375, 6100.572959892765, 6113.506711826627, 6111.98679349419, 6147.200863887666, 6149.84625384369, 6156.722947467375, 6169.105479705418, 4884.8290309838985, 4906.8773280668265, 4939.259111133359, 4940.135476291634, 4945.282933974553, 4346.304591265382, 4380.0582874682095, 4405.207062728739, 4452.643788496913, 4494.955050449519, 5537.640053396516, 5596.10462326034, 5647.407022262685, 5662.065759149777, 5666.178404131378, 6198.566100372931, 6208.50331973441, 6209.9379006210265, 6225.315215326311, 6232.657203853832, 4481.619062379734, 5495.587830912697, 5516.9448305517235, 5566.944330556643, 5635.943640563624, 5349.598780091509, 5355.464453554613, 5369.543588794918, 5376.381716102698, 5377.435369286169, 5737.881113182889, 5927.851803704855, 6298.874022519615, 6314.494840412664, 6318.8420289492215, 6098.481629061402, 6105.368770830132, 6120.2947619997085, 6169.383061693795, 6184.165137706532, 6235.220597425322, 6243.37566243372, 6249.906266403452, 6260.655663938527, 6301.054841773587, 5676.914846277226, 6078.45293923549, 6113.1135985281, 6134.877302454015, 6148.938510614837, 6020.939790602038, 6024.246969128859, 6088.299845517645, 6130.031268545553, 6196.597221180609, 5962.522998160223, 5968.343482216866, 5972.372900845522, 5973.731182096903, 6023.156758053964, 5778.335491418373, 5903.321118071305, 5941.37615550361, 5958.493528050164, 5979.850503737442, 5010.797408621977, 5497.45025497447, 5645.604807663424, 5750.769969201185, 5869.970650146722, 5531.9723401382735, 5910.7931222407005, 5938.138969849434, 5956.106584012433, 5978.372270911492, 5787.0, 5788.942110578841, 5796.072628379439, 5814.709264536841, 5824.854378640568], "value": 5584.794852685717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.6873663382168, 477.21259921130155, 527.2565682387832, 533.9188144008383, 548.6762809942134, 32137.67862321376, 40295.99260018501, 40381.99045023872, 40467.392989105116, 40521.59478405215, 41204.79397603008, 41683.791581042125, 41776.37335439971, 41807.79096104515, 41865.58134418655, 9512.952435237814, 9662.130408263254, 9771.36486128403, 9773.120419162275, 9787.510624468783, 9626.518674066303, 9697.175740062103, 9707.320487565874, 9720.9792971738, 9721.70834874955, 9685.225181985425, 9688.079632434943, 9716.368436051634, 9717.951410242938, 9772.511374431286, 9621.807563848753, 9689.757756056084, 9712.22302215821, 9716.222702183808, 9737.999999999965, 9561.856572151424, 9579.281553883417, 9591.184749296319, 9660.178884794801, 9679.08048735369, 39330.41004384936, 39698.603013969776, 39791.80624581267, 39904.600953990666, 39905.20189596221, 3578.76738012031, 3593.1376469647357, 3694.8522059117604, 3876.9919820846503, 4137.482814648169, 30780.692193078008, 32093.1976700582, 32150.0, 32378.352432951207, 32423.0, 3220.0983724557163, 3308.1894935740897, 3353.4131526982924, 3361.865525378982, 3380.290139070798, 490421.0, 501562.44531441224, 501757.0, 503577.48211259075, 503829.0, 32617.836910815768, 33746.32507349888, 57270.713646432334, 57485.0, 57652.42347576554, 34372.656273437446, 34613.480797788055, 34690.30619387598, 34832.30335393278, 34954.65045349565, 14599.927000365142, 14770.0, 14770.92614536942, 14778.630534236516, 14790.482333118505, 11971.341576213217, 12302.569410070784, 12407.0, 12409.565665201675, 12421.503139874303, 7703.576303303372, 7706.499077559941, 7791.922080779233, 7807.336376407955, 7824.843503129906, 3031.7726170536857, 3232.062701816447, 3251.6910893465083, 3261.0, 3297.472404415282, 928.3965422475445, 993.5529011944653, 996.2926322311096, 1070.7911957168433, 1098.4452851310036, 26558.336041599116, 30180.69819301779, 30486.695133048386, 30496.0, 30888.84555577253, 1096.7696783675358, 1104.8297837491705, 1123.4102096399292, 1173.6244401791516, 1201.531402752927, 14897.77653335201, 15210.391584336723, 15627.296771645077, 15766.132862692662, 15895.68208635844, 702046.0, 707048.0, 707170.0, 707648.0, 710534.0, 57628.42371576231, 58192.0, 58938.41061589415, 58986.705066474395, 59171.70414147988, 1386.682651481097, 1407.3174510362467, 1416.405109853864, 1423.9857601423853, 1429.4210844607742, 25533.0, 27385.726142738316, 27942.602869856833, 29247.7075229245, 29930.700692992792, 35480.112997175274, 50897.491025090756, 51346.22980655368, 51477.0, 51547.0, 604815.0, 605669.0, 607218.0, 607841.0, 608095.0, 26619.33451663724, 26820.8658956704, 27126.864365678044, 27472.45055098927, 27609.44781104407, 47183.056338873714, 48089.5191048085, 48159.518404815506, 48205.75897120492, 48626.0, 38604.613953861226, 38739.0, 39192.6080739189, 40210.597894020684, 40325.39511907265, 32275.70897164087, 32334.35331293408, 38840.417393739684, 40371.59628403679, 40502.79748601238, 38913.027174320865, 41474.341026358605, 41589.792051040764, 42647.507337244286, 43674.0, 39341.2131757369, 39552.60447395489, 41116.0, 41381.37927931023, 43081.784591076845, 24503.63244551369, 32422.189445264055, 32516.512252315762, 32645.18387040343, 33243.00270991874], "value": 19000.360614233607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.90255630979635, 367.98896033119, 377.91307999160193, 385.5854955922381, 401.24365570898846, 17543.21055552503, 19014.524636884067, 21373.03821328042, 21417.678734818972, 21477.67783483249, 15924.52226433206, 20572.588548229065, 21427.821469819155, 21439.464013399673, 21716.13135474583, 4663.7668116594205, 5172.870678233036, 5791.652500849941, 5981.850453738648, 6005.429484198994, 5195.844124676266, 6175.938240617581, 6196.16351792509, 6204.069389591575, 6213.844653883666, 5641.069223578125, 5999.820005399845, 6051.092336149591, 6098.024316109423, 6212.223472065992, 5775.682337471438, 5852.648841069549, 5853.8829223415505, 5867.589268751168, 5874.1776151338845, 5077.289179514871, 5275.0, 5277.3139491866195, 5281.471852814726, 5289.86775330616, 26603.600945985825, 26682.46635067288, 26746.86626566874, 26761.929522819064, 26880.0, 2038.6738121900573, 2244.9438764030865, 2263.4907145892043, 2696.8516731579757, 3051.5880356151856, 16086.678266434723, 16092.597685057966, 16448.671026579403, 16464.506064818073, 16651.91674041634, 1836.8622353323553, 1880.6990881459037, 1910.761154855643, 1965.3121407507401, 1991.75103112111, 77406.61296693537, 118964.0, 122693.0, 123257.0, 125094.3745281277, 9149.679761208326, 11386.772264554662, 11651.708707282385, 11754.0, 11880.34658093813, 12008.0, 12274.0, 14347.995640305287, 14509.85490145106, 14522.782158267635, 8239.258466738022, 8522.0, 8543.188397102265, 8582.570871456403, 8650.567471626393, 8398.832023359499, 8401.453905496122, 8406.243438090602, 8484.024337201177, 8538.487690738451, 3625.9818700906326, 3718.4236443350783, 4335.479742430928, 4388.210122178039, 4584.908301834012, 1916.9137388817537, 1958.6681056881173, 1985.8709183903, 2004.2183548416128, 2008.1565742388232, 746.7423738810102, 876.7808047988003, 889.9466032038099, 927.2118699105841, 980.2060331131806, 20369.47228957834, 21196.0, 21533.78466215349, 22131.114755409602, 22261.220857269916, 837.4975014991079, 854.8504011798035, 913.680211925834, 933.6265493802398, 998.3161534348994, 9560.90439095614, 10620.0, 11059.22585419029, 11725.882741172649, 11760.88239117615, 508448.0, 520552.0, 522469.0, 617803.0, 624778.3805404811, 118379.40810295893, 133015.0, 149784.0, 153900.0, 160269.0, 964.9903500965041, 992.335135459244, 1008.7528555503802, 1011.0546638892658, 1012.711377257478, 18559.44321670352, 19058.904705476383, 19660.705089423955, 19973.800261997196, 20014.399568012985, 50266.24600631066, 54743.45256547384, 57242.0, 57305.71347143238, 57475.42524574701, 58770.0, 86565.60428403609, 86985.0, 87981.56009220169, 90583.0, 8028.31759300466, 8122.390820688353, 8387.329013679013, 8459.308138372227, 8478.491290522588, 12212.633620991384, 13194.274314912773, 13269.336533173495, 13677.521286754916, 13926.721465570428, 10029.849552256868, 11128.610498632508, 11414.429278536207, 11660.650180494598, 11750.70623234426, 11287.266327688674, 11359.716007099558, 11498.482568284615, 11500.48247828833, 11505.482253298454, 11229.101671866069, 11464.484098215768, 11999.76000480003, 12007.639770806889, 12081.973032292002, 6792.422644075309, 8071.878921816295, 8191.79520511992, 8233.423660343718, 8251.092379838094, 8288.046874609498, 10454.215933805148, 11396.316221026766, 11524.884751152382, 11774.999125074464], "value": 9724.241332634718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.613518552769, 1542.0747551469117, 1753.8070812210663, 1831.7618709567755, 1881.200489791839, 7510.887336689947, 7954.323882469983, 8369.204925532073, 8414.91585084149, 8982.73051808446, 8414.705485308015, 8669.133086691329, 8715.084916083815, 8718.956405217965, 8719.869201961976, 2293.266154830451, 2331.184085570045, 2340.5903966805827, 2344.308429013445, 2347.2840783561005, 2303.09027933966, 2324.0703718512646, 2348.4598542335275, 2355.3640517060385, 2360.7639236076425, 2307.3885420363617, 2340.2745149003777, 2350.9294721158394, 2352.023910077316, 2354.846934949223, 2305.1240528599023, 2319.8840057997118, 2329.219711396684, 2329.580675478413, 2332.7433982261855, 2317.9768202317928, 2320.048780000192, 2323.512062466884, 2323.7211534615953, 2336.100601268507, 8679.392442529026, 8686.391952563323, 8765.649374025095, 8787.077356877564, 8789.208971192624, 5154.561862241714, 5304.124819404794, 5317.8404647860625, 5322.1750628652235, 5361.0, 2714.484247992875, 3149.9370012599848, 3484.9651503484893, 3604.567451905788, 3618.4029635110173, 1075.5643964194514, 1075.93544387337, 1084.295208114724, 1085.473545330514, 1089.553283153903, 11345.205835591512, 11447.42762861862, 11497.25267857595, 11619.95420412167, 11668.591599294068, 4533.818647254073, 4593.356930029799, 4766.475687674353, 4768.594669453066, 4782.0914026334885, 9953.303268771117, 10009.399436033862, 10012.04885535873, 10044.598216071276, 10058.698239052841, 5198.92201616976, 5235.4502777207845, 5276.815311464157, 5286.022085914118, 5294.285271488377, 4248.787560621957, 4354.325079612665, 4786.353842231324, 4824.662273640882, 4832.226843704991, 3835.5780864104927, 3870.2646497165447, 3956.4658771066115, 3985.7807820570147, 3988.700847436454, 1072.3405105859997, 1251.0929576057285, 1270.7077372204444, 1272.2811611439506, 1283.9935800320939, 846.8440578610276, 906.909309069101, 930.8417569013284, 942.3639043645649, 980.1619615228876, 4967.329410529533, 5793.102069179284, 5793.826185214451, 6068.817935461855, 6093.817185484442, 431.34866351808995, 431.5059257150545, 436.9388285640013, 449.6447806233039, 458.90363023765383, 3535.7878527288444, 3944.802759862053, 3993.0815912340327, 4095.692823038284, 4103.712740108223, 10375.325603835727, 10574.154067674568, 10605.045545900906, 10702.571897124184, 10807.40559269232, 10640.574377024986, 10653.9467302663, 10671.199660025373, 10671.786564268672, 10676.306040107369, 8144.633491492897, 8235.629396677285, 8246.422750407533, 8253.968253968254, 8263.876041859377, 4470.754108524063, 5733.3406658234835, 6051.848703782441, 6083.087536869505, 6088.147659327609, 8099.230573095547, 9934.453605051502, 10174.389536627827, 10218.0, 10246.436445995243, 9945.701628951143, 10182.0, 10290.434026128634, 10300.845487317845, 10363.844542332023, 6381.744730210739, 6994.755183568551, 7513.361364284097, 7538.434617403607, 7724.7682569523, 8417.494950303002, 8466.74599762008, 8492.405531612727, 8507.0, 8527.275181609633, 7389.593572353572, 7498.475106742476, 7520.7367742130955, 7564.281393267631, 7634.961825190839, 7290.453216008927, 7345.0084238627105, 7363.484556081023, 7477.663505142173, 7539.246075392417, 6950.0, 7059.929400705927, 7066.364027237573, 7071.116110486189, 7096.5742055474775, 4950.628702847229, 4982.900341993068, 5071.366079240095, 5087.414947280962, 5115.948840511547, 4968.602511799119, 4981.053599816023, 5128.1794912813775, 5177.585793136615, 5244.501772331622], "value": 4473.420543482834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4171906501389, 305.37703085705164, 312.2568287475807, 314.7104663709387, 315.07682490303404, 4723.574878260956, 5444.673319600826, 5631.436856314366, 5717.714114294289, 5733.226014488043, 5012.91963835008, 5325.547328477074, 5588.552915766739, 5600.243967064445, 5620.269364982547, 4210.557891421403, 4245.745255284685, 4263.722858014235, 4266.935995960063, 4267.765272909989, 3396.7961922284617, 4068.8169032393466, 4131.690123240769, 4282.015136518587, 4289.498675463594, 4150.190712811003, 4159.2721273777115, 4171.812268447927, 4187.68592355573, 4235.301175306071, 3677.043968568165, 4226.873193804191, 4227.175700738358, 4233.703640745133, 4252.149570085964, 3339.6493368196234, 3401.6598340166033, 3658.743887927846, 3660.4509323601405, 3686.318031164243, 4744.786484608201, 5142.460041695643, 5313.707746073965, 5347.679139251619, 5368.7115092377935, 4116.176764647083, 4582.931256031162, 4734.692245004064, 4808.0, 4827.958386216696, 5024.723640199824, 5441.782328706847, 5845.327787304472, 5865.325487568899, 5906.320773111104, 3094.69053094691, 3952.446657467957, 4008.8596899108684, 4010.438538604598, 4021.7586944783407, 5101.872453188663, 5976.372480889488, 6230.629261562449, 6283.246010478726, 6302.590331628429, 4044.676425885922, 4058.7564746115327, 4075.97962010194, 4082.8366865325647, 4087.202995415865, 3824.4836947011795, 4056.1076563156057, 4064.065264989069, 4082.2447847148374, 4115.403266526337, 4170.435182362886, 4387.407699960529, 4772.973810630661, 4776.689515181502, 4787.497312782178, 4963.90072198554, 5194.532492075731, 5904.232449781587, 5987.491063259585, 6002.279726432856, 1134.3704244144578, 1144.3864151546445, 1323.2788130468919, 1384.3424373422745, 1390.1589538329165, 746.6192241956533, 903.8734577159203, 909.1817364372118, 909.5770466733001, 934.3366209990846, 4974.427940786783, 5034.903534326363, 5381.0, 5403.540699040547, 5486.91769623456, 5460.754266058037, 5768.3654797972185, 5963.896679114378, 5985.25184351956, 6011.278646562353, 5038.874028149326, 5207.427183009866, 5365.865853353697, 5447.972760136253, 5540.69793598504, 3126.499760038383, 3171.587693599817, 3181.618205815317, 3204.7916885402374, 3236.821974791409, 6027.668478233739, 6265.238418801743, 6366.395192456709, 6383.425491705769, 6410.423061924356, 5171.896562068738, 5258.92111618326, 5822.417758224144, 6196.442320191204, 6239.812805615838, 5227.26818245446, 5823.5923485355615, 6256.562040657202, 6329.240491141, 6333.398327158912, 5602.85141545974, 6033.276006879202, 6036.517078633787, 6059.818205453844, 6096.847578810388, 6046.3046749624355, 6098.146259523759, 6127.571070025056, 6135.895538803058, 6144.662043587646, 6134.2332208473945, 6382.712777924911, 6385.96807015962, 6400.871982560416, 6425.787106446776, 3928.0948739861715, 3967.424723415146, 3992.883771601056, 4016.678665706795, 4028.033272014754, 5834.38738932406, 5866.853328666817, 5935.940640593712, 6087.847803804941, 6197.194364732556, 5368.704721240213, 5418.322709661293, 5600.635958662837, 5755.53955683536, 5813.738381772746, 4891.9755401222765, 5857.150713146485, 5900.321463031806, 5905.5570832186895, 5974.312954010171, 5116.283720279238, 5597.740508385581, 5713.628614140068, 5737.340205876378, 5795.58060744163, 5900.645961242168, 5935.231128233517, 5956.54064754138, 5981.872507969487, 6021.7591296347655, 5367.255641916315, 5823.242978412779, 5851.473367396955, 5857.924589590499, 5886.3525012247765], "value": 4278.23346115833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.4683393786785, 692.7644600835715, 700.488643290398, 711.9644017799109, 754.8829931360634, 15232.695346093085, 15704.528864134065, 15746.448874289403, 15790.763138552931, 15976.2011899405, 14497.275136243199, 14534.200618965953, 14535.055221410601, 14642.926785366084, 14654.85345146551, 836.9832603347944, 860.0238729042551, 865.1824026295153, 866.4065115395974, 866.6620018192909, 683.5898460923456, 826.4421515477059, 850.26452118917, 859.3340161374953, 860.4192170285064, 896.5651658945407, 904.6471875968344, 907.9001309855944, 909.5361365703505, 910.8406028944942, 872.4198408058634, 903.9683611073581, 905.2034209895315, 905.728281515546, 905.868649045888, 558.5029323901731, 665.0855074272874, 671.4628297362091, 672.9831754206135, 673.249327000396, 13091.803622945568, 14477.0, 14917.328720207508, 14935.327910244065, 14996.550103496913, 12931.935340323238, 13915.095518791246, 14518.92740536301, 14655.853441465555, 14875.256237188098, 12116.09129315305, 12118.575849845212, 12124.454399552042, 12175.0868684849, 12269.141160118796, 3843.7501562398356, 3870.4774855394444, 3878.4957955465893, 3897.5322961244547, 4020.4572382728543, 116964.0, 120948.79051209464, 123876.38061809723, 125269.0, 126636.0, 9538.0, 10132.645357412455, 11059.557617695364, 11235.045021173128, 11297.322160670221, 23274.8836255821, 23409.297721068397, 23422.531549368916, 23449.296521104396, 23457.765422345557, 8119.512829230265, 8308.6676532938, 8376.83246335082, 8378.581070946428, 8456.577171141418, 4495.190865644216, 4607.815687372467, 4615.930761038587, 4722.291656251589, 4749.501302363271, 3080.6919308069014, 3479.5302634144573, 3560.8219589020446, 3617.222297206113, 3634.327649384872, 629.5750368501243, 644.3105876711874, 656.4420242793587, 659.9835004124935, 668.7091115364832, 548.6680558262274, 560.680412165062, 624.194788722552, 653.9112377890854, 689.8723736108836, 8610.655573777103, 9396.718098457057, 9502.619895204114, 9560.008756044617, 9628.614855405705, 641.7914177892204, 673.0577191931237, 675.3213020914048, 687.4191308344441, 702.610051421466, 4406.977965110218, 4408.048526413864, 4683.672859788467, 4787.114383839001, 4795.352627395327, 88726.55636721905, 118826.40586797011, 144013.0, 151278.0, 153789.0, 58727.0, 84612.15387846166, 126723.0, 137158.31420842832, 140494.29752851374, 115122.0, 118839.0, 119527.0, 120716.79283207231, 123079.0, 8423.368247381593, 8945.865812012955, 8958.731238062868, 9028.593713282786, 9083.409578377385, 44526.55473445224, 63811.0, 66853.99719004316, 67118.0, 68737.0, 84553.57723211344, 85903.71144432714, 87601.56199218963, 93141.0, 103571.0, 12722.236665800081, 13200.537981170613, 13368.532101376406, 13507.257100859548, 13722.108062975874, 14824.555263342118, 15100.320485578395, 15127.773083403978, 15329.38682452734, 15389.769153462483, 13677.24775137377, 14172.716545668824, 14229.217393043482, 14394.136351818925, 14470.565883023526, 13889.305534723022, 13986.775340604849, 14152.646183845487, 14372.28138593087, 14530.564083077525, 11115.0, 13578.796318055434, 13764.17414955106, 13829.585112446643, 14455.49405770793, 9277.304202184729, 10866.486800721526, 11372.488238029475, 11521.596744113916, 12011.219270747373, 9875.851862221929, 11280.661580152608, 11642.301461912313, 11689.298642081503, 11706.531738730697], "value": 7850.384053893705, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 108.0, 115.0, 117.0, 118.0, 115.0, 118.0, 118.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 133.0, 157.0, 114.0, 127.0, 159.0, 147.0, 206.0, 110.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 233.0, 277.0, 198.0, 196.0, 198.0, 197.0, 193.0, 196.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 81.0, 75.0, 147.0, 59.0, 60.0, 60.0, 62.0, 138.0, 72.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 117.0, 72.0, 75.0, 107.0, 114.0, 72.0, 72.0, 118.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 91.0, 88.0, 92.0, 88.0, 92.0, 91.0, 138.0, 133.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 116.0, 98.0, 97.0, 95.0, 154.0, 127.0, 98.0, 97.0, 97.0], "value": 113.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 94.0, 96.0, 92.0, 142.0, 144.0, 118.0, 96.0, 90.0], "value": 115.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 56.0, 56.0, 57.0, 55.0, 56.0, 57.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 71.0, 91.0, 79.0, 80.0, 66.0, 74.0, 79.0, 77.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 84.0, 90.0, 76.0, 102.0, 87.0, 88.0, 89.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 128.0, 163.0, 156.0, 160.0, 139.0, 137.0, 174.0, 162.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 166.0, 231.0, 231.0, 186.0, 175.0, 171.0, 212.0, 154.0, 236.0], "value": 197.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 70.0, 66.0, 70.0, 68.0, 66.0, 70.0, 98.0, 86.0], "value": 72.9, "unit": "score"}]}]} 11:58:00 INFO - Return code: 0 11:58:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:58:00 ERROR - # TBPL SUCCESS # 11:58:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:58:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:58:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:58:00 INFO - 2016-08-12 11:58:00.169 screenresolution[1662:10712] starting screenresolution argv=screenresolution get 11:58:00 INFO - 2016-08-12 11:58:00.172 screenresolution[1662:10712] Display 0: 1600x1200x32@60 11:58:00 INFO - 2016-08-12 11:58:00.178 screenresolution[1663:10715] starting screenresolution argv=screenresolution list 11:58:00 INFO - Available Modes on Display 0 11:58:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:58:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:58:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:58:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:58:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:58:00 INFO - Intel Iris: 11:58:00 INFO - Chipset Model: Intel Iris 11:58:00 INFO - Type: GPU 11:58:00 INFO - Bus: Built-In 11:58:00 INFO - VRAM (Dynamic, Max): 1536 MB 11:58:00 INFO - Vendor: Intel (0x8086) 11:58:00 INFO - Device ID: 0x0a2e 11:58:00 INFO - Revision ID: 0x0009 11:58:00 INFO - Displays: 11:58:00 INFO - Display: 11:58:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:58:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:58:00 INFO - Display Serial Number: 1600x1200 60 11:58:00 INFO - Main Display: Yes 11:58:00 INFO - Mirror: Off 11:58:00 INFO - Online: Yes 11:58:00 INFO - Rotation: Supported 11:58:00 INFO - Return code: 0 11:58:00 INFO - Running post-action listener: _resource_record_post_action 11:58:00 INFO - [mozharness: 2016-08-12 18:58:00.419991Z] Finished run-tests step (success) 11:58:00 INFO - Running post-run listener: _resource_record_post_run 11:58:00 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37110784; Write bytes: 706196480; Read time: 241; Write time: 2028 11:58:00 INFO - TinderboxPrint: CPU usage
54.2% 11:58:00 INFO - TinderboxPrint: I/O read bytes / time
37,110,784 / 241 11:58:00 INFO - TinderboxPrint: I/O write bytes / time
706,196,480 / 2,028 11:58:00 INFO - TinderboxPrint: CPU idle
2,216.3 (45.8%) 11:58:00 INFO - TinderboxPrint: CPU system
979.0 (20.2%) 11:58:00 INFO - TinderboxPrint: CPU user
1,646.4 (34.0%) 11:58:00 INFO - TinderboxPrint: Swap in / out
441,479,168 / 0 11:58:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397543936; Write bytes: 391415296; Read time: 30526; Write time: 811 11:58:00 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35087360; Write bytes: 298921472; Read time: 219; Write time: 1169 11:58:00 INFO - Running post-run listener: _upload_blobber_files 11:58:00 INFO - Blob upload gear active. 11:58:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:58:00 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 11:58:00 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'] 11:58:00 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 11:58:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:58:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:02 INFO - (blobuploader) - INFO - Done attempting. 11:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:03 INFO - (blobuploader) - INFO - Done attempting. 11:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:05 INFO - (blobuploader) - INFO - Done attempting. 11:58:05 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:05 INFO - Return code: 0 11:58:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058521b70a4ae9390cc2a52b226909eb7efc5b9386d7023b6f68313cddc3278a902975ceb5a21893fe78f73778a6b5e2ed4f59be1b950879e1a7cbf20826b521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066de789f061545282f999409604a01d41764e52b3d224ba08bbd9378d21935f89915e01ecbe6913b2f4f444066ff88aaa6bd7bdadf7730101e53554756ff8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97489717f5500b7dc8f6fa91a6014d5a8bf50dd2f45817d1ceef1c1f8fa76cae8d2daa4bd48544c568772d535d8c28ffc845148f27bde60b40f60ef3564f8a98"} 11:58:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:05 INFO - Contents: 11:58:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058521b70a4ae9390cc2a52b226909eb7efc5b9386d7023b6f68313cddc3278a902975ceb5a21893fe78f73778a6b5e2ed4f59be1b950879e1a7cbf20826b521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066de789f061545282f999409604a01d41764e52b3d224ba08bbd9378d21935f89915e01ecbe6913b2f4f444066ff88aaa6bd7bdadf7730101e53554756ff8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97489717f5500b7dc8f6fa91a6014d5a8bf50dd2f45817d1ceef1c1f8fa76cae8d2daa4bd48544c568772d535d8c28ffc845148f27bde60b40f60ef3564f8a98"} 11:58:05 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:05 INFO - Copying logs to upload dir... 11:58:05 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.216726 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-12 11:58:05.699818) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:58:05.702923) ========= 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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058521b70a4ae9390cc2a52b226909eb7efc5b9386d7023b6f68313cddc3278a902975ceb5a21893fe78f73778a6b5e2ed4f59be1b950879e1a7cbf20826b521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066de789f061545282f999409604a01d41764e52b3d224ba08bbd9378d21935f89915e01ecbe6913b2f4f444066ff88aaa6bd7bdadf7730101e53554756ff8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97489717f5500b7dc8f6fa91a6014d5a8bf50dd2f45817d1ceef1c1f8fa76cae8d2daa4bd48544c568772d535d8c28ffc845148f27bde60b40f60ef3564f8a98"} build_url:https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009960 build_url: 'https://queue.taskcluster.net/v1/task/C7JUPVozSvWNEugC1tnc2g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/058521b70a4ae9390cc2a52b226909eb7efc5b9386d7023b6f68313cddc3278a902975ceb5a21893fe78f73778a6b5e2ed4f59be1b950879e1a7cbf20826b521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066de789f061545282f999409604a01d41764e52b3d224ba08bbd9378d21935f89915e01ecbe6913b2f4f444066ff88aaa6bd7bdadf7730101e53554756ff8ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97489717f5500b7dc8f6fa91a6014d5a8bf50dd2f45817d1ceef1c1f8fa76cae8d2daa4bd48544c568772d535d8c28ffc845148f27bde60b40f60ef3564f8a98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 11:58:05.733661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:58:05.734235) ========= 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.dTvoNVa8Jn/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.4tMAplW9zg/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 11:58:05.783504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:58:05.783831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 11:58:05.784150) ========= ========= Total master_lag: 0.32 =========