builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0146 starttime: 1472380532.09 results: success (0) buildid: 20160827055712 builduid: 65c8787e2cd94a6b8a6faedfa5414b90 revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:32.089327) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:32.089790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:32.090469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:32.530499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:32.530754) ========= 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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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-28 03:35:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.6M=0.001s 2016-08-28 03:35:33 (16.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.534400 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:33.095229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:33.095586) ========= 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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.028277 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:33.146341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-28 03:35:33.146751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1a5b53a831e5a6c20de1b081c774feb3ff76756c --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 1a5b53a831e5a6c20de1b081c774feb3ff76756c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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-28 03:35:33,224 truncating revision to first 12 chars 2016-08-28 03:35:33,224 Setting DEBUG logging. 2016-08-28 03:35:33,224 attempt 1/10 2016-08-28 03:35:33,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1a5b53a831e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-28 03:35:34,231 unpacking tar archive at: mozilla-central-1a5b53a831e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-28 03:35:34.417238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:34.417516) ========= script_repo_revision: 1a5b53a831e5a6c20de1b081c774feb3ff76756c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:34.418240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:34.418521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 03:35:34.436068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-28 03:35:34.436374) ========= /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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:35:34 INFO - MultiFileLogger online at 20160828 03:35:34 in /builds/slave/test 03:35:34 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 03:35:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:34 INFO - {'append_to_log': False, 03:35:34 INFO - 'base_work_dir': '/builds/slave/test', 03:35:34 INFO - 'blob_upload_branch': 'Firefox', 03:35:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:34 INFO - 'branch': 'Firefox', 03:35:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:34 INFO - 'config_files': ('talos/mac_config.py',), 03:35:34 INFO - 'default_actions': ('clobber', 03:35:34 INFO - 'read-buildbot-config', 03:35:34 INFO - 'download-and-extract', 03:35:34 INFO - 'populate-webroot', 03:35:34 INFO - 'create-virtualenv', 03:35:34 INFO - 'install', 03:35:34 INFO - 'run-tests'), 03:35:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:34 INFO - 'download_minidump_stackwalk': True, 03:35:34 INFO - 'download_symbols': 'ondemand', 03:35:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:34 INFO - 'installer_path': 'installer.exe', 03:35:34 INFO - 'log_level': 'info', 03:35:34 INFO - 'log_name': 'talos', 03:35:34 INFO - 'log_to_console': True, 03:35:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:35:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:35:34 INFO - 'opt_config_files': (), 03:35:34 INFO - 'pip_index': False, 03:35:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:35:34 INFO - 'cmd': ('bash', 03:35:34 INFO - '-c', 03:35:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:35:34 INFO - 'enabled': True, 03:35:34 INFO - 'halt_on_failure': False, 03:35:34 INFO - 'name': 'check_screen_resolution'},), 03:35:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:35:34 INFO - 'cmd': ('bash', 03:35:34 INFO - '-c', 03:35:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:35:34 INFO - 'enabled': True, 03:35:34 INFO - 'halt_on_failure': False, 03:35:34 INFO - 'name': 'check_screen_resolution'},), 03:35:34 INFO - 'run_cmd_checks_enabled': True, 03:35:34 INFO - 'sps_profile': False, 03:35:34 INFO - 'sps_profile_interval': 0, 03:35:34 INFO - 'suite': 'dromaeojs-e10s', 03:35:34 INFO - 'system_bits': '32', 03:35:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:34 INFO - 'title': 't-yosemite-r7-0146', 03:35:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:34 INFO - 'use_talos_json': True, 03:35:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:34 INFO - 'work_dir': 'build'} 03:35:34 INFO - [mozharness: 2016-08-28 10:35:34.621691Z] Running clobber step. 03:35:34 INFO - Running pre-action listener: _resource_record_pre_action 03:35:34 INFO - Running main action method: clobber 03:35:34 INFO - rmtree: /builds/slave/test/build 03:35:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:36 INFO - Running post-action listener: _resource_record_post_action 03:35:36 INFO - [mozharness: 2016-08-28 10:35:36.718064Z] Finished clobber step (success) 03:35:36 INFO - [mozharness: 2016-08-28 10:35:36.718224Z] Running read-buildbot-config step. 03:35:36 INFO - Running pre-action listener: _resource_record_pre_action 03:35:36 INFO - Running main action method: read_buildbot_config 03:35:36 INFO - Using buildbot properties: 03:35:36 INFO - { 03:35:36 INFO - "project": "", 03:35:36 INFO - "product": "firefox", 03:35:36 INFO - "script_repo_revision": "production", 03:35:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:35:36 INFO - "repository": "", 03:35:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:35:36 INFO - "buildid": "20160827055712", 03:35:36 INFO - "pgo_build": "False", 03:35:36 INFO - "basedir": "/builds/slave/test", 03:35:36 INFO - "buildnumber": 16, 03:35:36 INFO - "slavename": "t-yosemite-r7-0146", 03:35:36 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:35:36 INFO - "platform": "yosemite_r7", 03:35:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:35:36 INFO - "branch": "mozilla-central", 03:35:36 INFO - "repo_path": "mozilla-central", 03:35:36 INFO - "revision": "1a5b53a831e5a6c20de1b081c774feb3ff76756c", 03:35:36 INFO - "stage_platform": "macosx64", 03:35:36 INFO - "builduid": "65c8787e2cd94a6b8a6faedfa5414b90", 03:35:36 INFO - "slavebuilddir": "test" 03:35:36 INFO - } 03:35:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 03:35:36 INFO - Running post-action listener: _resource_record_post_action 03:35:36 INFO - [mozharness: 2016-08-28 10:35:36.721719Z] Finished read-buildbot-config step (success) 03:35:36 INFO - [mozharness: 2016-08-28 10:35:36.721833Z] Running download-and-extract step. 03:35:36 INFO - Running pre-action listener: _resource_record_pre_action 03:35:36 INFO - Running main action method: download_and_extract 03:35:36 INFO - mkdir: /builds/slave/test/build/tests 03:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:36 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 03:35:36 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:37 INFO - Downloaded 1199 bytes. 03:35:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 03:35:37 INFO - Using the following test package requirements: 03:35:37 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:35:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 03:35:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 03:35:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'jsshell-mac.zip'], 03:35:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 03:35:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 03:35:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 03:35:37 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 03:35:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 03:35:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 03:35:37 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 03:35:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:35:37 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')]} 03:35:37 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:35:37 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:38 INFO - Downloaded 16369283 bytes. 03:35:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 03:35:45 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 03:35:45 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')]} 03:35:45 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 03:35:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:46 INFO - Downloaded 16369283 bytes. 03:35:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 03:35:53 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')]} 03:35:53 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 03:35:53 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:54 INFO - Downloaded 14413998 bytes. 03:35:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 03:35:54 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')]} 03:35:54 INFO - trying https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 03:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/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 03:35:58 INFO - Downloaded 111541368 bytes. 03:35:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:35:58 INFO - mkdir: /builds/slave/test/properties 03:35:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:35:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:35:58 INFO - Contents: 03:35:58 INFO - build_url:https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 03:35:58 INFO - Running post-action listener: _resource_record_post_action 03:35:58 INFO - Running post-action listener: set_extra_try_arguments 03:35:58 INFO - [mozharness: 2016-08-28 10:35:58.776344Z] Finished download-and-extract step (success) 03:35:58 INFO - [mozharness: 2016-08-28 10:35:58.776467Z] Running populate-webroot step. 03:35:58 INFO - Running pre-action listener: _resource_record_pre_action 03:35:58 INFO - Running main action method: populate_webroot 03:35:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:35:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:35:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:35:58 INFO - '--tppagecycles', 03:35:58 INFO - '7'], 03:35:58 INFO - 'tests': ['tsvgm']}}, 03:35:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:35:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:35:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:35:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:35:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:35:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['damp', 'tps']}, 03:35:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'tests': ['damp', 'tps']}, 03:35:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['dromaeo_dom']}, 03:35:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:35:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['basic_compositor_video']}, 03:35:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:35:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'other-e10s': {'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['a11yr', 03:35:58 INFO - 'ts_paint', 03:35:58 INFO - 'tpaint', 03:35:58 INFO - 'sessionrestore', 03:35:58 INFO - 'sessionrestore_no_auto_restore', 03:35:58 INFO - 'tabpaint']}, 03:35:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['tsvgx', 03:35:58 INFO - 'tsvgr_opacity', 03:35:58 INFO - 'tart', 03:35:58 INFO - 'tscrollx', 03:35:58 INFO - 'cart']}, 03:35:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:35:58 INFO - 'tsvgr_opacity', 03:35:58 INFO - 'tart', 03:35:58 INFO - 'tscrollx', 03:35:58 INFO - 'cart']}, 03:35:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'talos_options': ['--disable-e10s'], 03:35:58 INFO - 'tests': ['tp5o']}, 03:35:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'tests': ['tp5o']}, 03:35:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'talos_options': ['--disable-e10s', 03:35:58 INFO - '--xperf_path', 03:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:58 INFO - 'tests': ['tp5n']}, 03:35:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:35:58 INFO - 'talos_options': ['--xperf_path', 03:35:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:35:58 INFO - 'tests': ['tp5n']}}, 03:35:58 INFO - 'talos.zip': {'path': '', 03:35:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:35:58 INFO - Running post-action listener: _resource_record_post_action 03:35:58 INFO - [mozharness: 2016-08-28 10:35:58.795488Z] Finished populate-webroot step (success) 03:35:58 INFO - [mozharness: 2016-08-28 10:35:58.795601Z] Running create-virtualenv step. 03:35:58 INFO - Running pre-action listener: _resource_record_pre_action 03:35:58 INFO - Running main action method: create_virtualenv 03:35:58 INFO - Creating virtualenv /builds/slave/test/build/venv 03:35:58 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 03:35:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:35:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:35:58 INFO - Using real prefix '/tools/python27' 03:35:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:35:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:02 INFO - Installing pip.................done. 03:36:02 INFO - Return code: 0 03:36:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:02 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')]} 03:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:02 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')]} 03:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:02 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:02 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 03:36:02 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 03:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:02 INFO - 'HOME': '/Users/cltbld', 03:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:02 INFO - 'LOGNAME': 'cltbld', 03:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:02 INFO - 'MOZ_NO_REMOTE': '1', 03:36:02 INFO - 'NO_EM_RESTART': '1', 03:36:02 INFO - 'PAGER': '/bin/cat', 03:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:02 INFO - 'PWD': '/builds/slave/test', 03:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:02 INFO - 'SHELL': '/bin/bash', 03:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:02 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:02 INFO - 'USER': 'cltbld', 03:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:02 INFO - 'XPC_FLAGS': '0x0', 03:36:02 INFO - 'XPC_SERVICE_NAME': '0', 03:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:02 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 03:36:02 INFO - Cleaning up... 03:36:02 INFO - Return code: 0 03:36:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:02 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')]} 03:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:02 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')]} 03:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:02 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:02 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 03:36:02 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 03:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:02 INFO - 'HOME': '/Users/cltbld', 03:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:02 INFO - 'LOGNAME': 'cltbld', 03:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:02 INFO - 'MOZ_NO_REMOTE': '1', 03:36:02 INFO - 'NO_EM_RESTART': '1', 03:36:02 INFO - 'PAGER': '/bin/cat', 03:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:02 INFO - 'PWD': '/builds/slave/test', 03:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:02 INFO - 'SHELL': '/bin/bash', 03:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:02 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:02 INFO - 'USER': 'cltbld', 03:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:02 INFO - 'XPC_FLAGS': '0x0', 03:36:02 INFO - 'XPC_SERVICE_NAME': '0', 03:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:03 INFO - Downloading/unpacking psutil>=3.1.1 03:36:03 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 03:36:03 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 03:36:03 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 03:36:03 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 03:36:03 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 03:36:03 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 03:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:06 INFO - Installing collected packages: psutil 03:36:06 INFO - Running setup.py install for psutil 03:36:06 INFO - building 'psutil._psutil_osx' extension 03:36:06 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 03:36:07 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 03:36:07 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 03:36:07 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 03:36:07 INFO - building 'psutil._psutil_posix' extension 03:36:07 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 03:36:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:36:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:36:07 INFO - ^ 03:36:07 INFO - 1 warning generated. 03:36:07 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 03:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:07 INFO - Successfully installed psutil 03:36:07 INFO - Cleaning up... 03:36:07 INFO - Return code: 0 03:36:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:07 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')]} 03:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 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')]} 03:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:07 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:07 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 03:36:07 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 03:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:07 INFO - 'HOME': '/Users/cltbld', 03:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:07 INFO - 'LOGNAME': 'cltbld', 03:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:07 INFO - 'MOZ_NO_REMOTE': '1', 03:36:07 INFO - 'NO_EM_RESTART': '1', 03:36:07 INFO - 'PAGER': '/bin/cat', 03:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:07 INFO - 'PWD': '/builds/slave/test', 03:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:07 INFO - 'SHELL': '/bin/bash', 03:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:07 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:07 INFO - 'USER': 'cltbld', 03:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:07 INFO - 'XPC_FLAGS': '0x0', 03:36:07 INFO - 'XPC_SERVICE_NAME': '0', 03:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:10 INFO - Installing collected packages: mozsystemmonitor 03:36:10 INFO - Running setup.py install for mozsystemmonitor 03:36:10 INFO - Successfully installed mozsystemmonitor 03:36:10 INFO - Cleaning up... 03:36:10 INFO - Return code: 0 03:36:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:10 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')]} 03:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:10 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')]} 03:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:10 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:10 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 03:36:10 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 03:36:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:10 INFO - 'HOME': '/Users/cltbld', 03:36:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:10 INFO - 'LOGNAME': 'cltbld', 03:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:10 INFO - 'MOZ_NO_REMOTE': '1', 03:36:10 INFO - 'NO_EM_RESTART': '1', 03:36:10 INFO - 'PAGER': '/bin/cat', 03:36:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:10 INFO - 'PWD': '/builds/slave/test', 03:36:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:10 INFO - 'SHELL': '/bin/bash', 03:36:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:10 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:10 INFO - 'USER': 'cltbld', 03:36:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:10 INFO - 'XPC_FLAGS': '0x0', 03:36:10 INFO - 'XPC_SERVICE_NAME': '0', 03:36:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:11 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 03:36:11 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 03:36:11 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 03:36:11 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 03:36:11 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 03:36:11 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 03:36:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:14 INFO - warning: no files found matching '*.txt' 03:36:14 INFO - no previously-included directories found matching 'build' 03:36:14 INFO - no previously-included directories found matching 'dist' 03:36:14 INFO - no previously-included directories found matching '.git*' 03:36:14 INFO - Installing collected packages: jsonschema, functools32 03:36:14 INFO - Running setup.py install for functools32 03:36:14 INFO - warning: no files found matching '*.txt' 03:36:14 INFO - no previously-included directories found matching 'build' 03:36:14 INFO - no previously-included directories found matching 'dist' 03:36:14 INFO - no previously-included directories found matching '.git*' 03:36:14 INFO - Successfully installed jsonschema functools32 03:36:14 INFO - Cleaning up... 03:36:14 INFO - Return code: 0 03:36:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:14 INFO - 'HOME': '/Users/cltbld', 03:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:14 INFO - 'LOGNAME': 'cltbld', 03:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:14 INFO - 'MOZ_NO_REMOTE': '1', 03:36:14 INFO - 'NO_EM_RESTART': '1', 03:36:14 INFO - 'PAGER': '/bin/cat', 03:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:14 INFO - 'PWD': '/builds/slave/test', 03:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:14 INFO - 'SHELL': '/bin/bash', 03:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:14 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:14 INFO - 'USER': 'cltbld', 03:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:14 INFO - 'XPC_FLAGS': '0x0', 03:36:14 INFO - 'XPC_SERVICE_NAME': '0', 03:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:14 INFO - Cleaning up... 03:36:14 INFO - Return code: 0 03:36:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:14 INFO - 'HOME': '/Users/cltbld', 03:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:14 INFO - 'LOGNAME': 'cltbld', 03:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:14 INFO - 'MOZ_NO_REMOTE': '1', 03:36:14 INFO - 'NO_EM_RESTART': '1', 03:36:14 INFO - 'PAGER': '/bin/cat', 03:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:14 INFO - 'PWD': '/builds/slave/test', 03:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:14 INFO - 'SHELL': '/bin/bash', 03:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:14 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:14 INFO - 'USER': 'cltbld', 03:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:14 INFO - 'XPC_FLAGS': '0x0', 03:36:14 INFO - 'XPC_SERVICE_NAME': '0', 03:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:14 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 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 03:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:18 INFO - Downloading docopt-0.6.1.tar.gz 03:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:18 INFO - Running setup.py install for blobuploader 03:36:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:18 INFO - Running setup.py install for requests 03:36:19 INFO - Running setup.py install for docopt 03:36:19 INFO - Successfully installed blobuploader requests docopt 03:36:19 INFO - Cleaning up... 03:36:19 INFO - Return code: 0 03:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:19 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:19 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 03:36:19 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 03:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:19 INFO - 'HOME': '/Users/cltbld', 03:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:19 INFO - 'LOGNAME': 'cltbld', 03:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:19 INFO - 'MOZ_NO_REMOTE': '1', 03:36:19 INFO - 'NO_EM_RESTART': '1', 03:36:19 INFO - 'PAGER': '/bin/cat', 03:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:19 INFO - 'PWD': '/builds/slave/test', 03:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:19 INFO - 'SHELL': '/bin/bash', 03:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:19 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:19 INFO - 'USER': 'cltbld', 03:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:19 INFO - 'XPC_FLAGS': '0x0', 03:36:19 INFO - 'XPC_SERVICE_NAME': '0', 03:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:19 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-dzuAJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:19 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-LGqMeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:19 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-2KXV1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-CaHL4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Y4wRQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-s4Kxhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Wz9275-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-2k3t_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-dTX6ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-7mCVI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-55XESD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:20 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Gl0m9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:21 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-FtDuHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:21 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-_b5w4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:21 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-RQhCQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:21 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-YEFXbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:21 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3Z0mgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:21 INFO - Running setup.py install for manifestparser 03:36:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:21 INFO - Running setup.py install for mozcrash 03:36:21 INFO - Running setup.py install for mozdebug 03:36:21 INFO - Running setup.py install for mozdevice 03:36:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Running setup.py install for mozfile 03:36:22 INFO - Running setup.py install for mozhttpd 03:36:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Running setup.py install for mozinfo 03:36:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Running setup.py install for mozInstall 03:36:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:22 INFO - Running setup.py install for mozleak 03:36:22 INFO - Running setup.py install for mozlog 03:36:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for moznetwork 03:36:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozprocess 03:36:23 INFO - Running setup.py install for mozprofile 03:36:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozrunner 03:36:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:23 INFO - Running setup.py install for mozscreenshot 03:36:23 INFO - Running setup.py install for moztest 03:36:23 INFO - Running setup.py install for mozversion 03:36:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:24 INFO - Cleaning up... 03:36:24 INFO - Return code: 0 03:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:24 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:24 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 03:36:24 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 03:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:24 INFO - 'HOME': '/Users/cltbld', 03:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:24 INFO - 'LOGNAME': 'cltbld', 03:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:24 INFO - 'MOZ_NO_REMOTE': '1', 03:36:24 INFO - 'NO_EM_RESTART': '1', 03:36:24 INFO - 'PAGER': '/bin/cat', 03:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:24 INFO - 'PWD': '/builds/slave/test', 03:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:24 INFO - 'SHELL': '/bin/bash', 03:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:24 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:24 INFO - 'USER': 'cltbld', 03:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:24 INFO - 'XPC_FLAGS': '0x0', 03:36:24 INFO - 'XPC_SERVICE_NAME': '0', 03:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-vSsEoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:24 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)) 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-I8m4sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:24 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)) 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-fm6345-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:24 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)) 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-CMQ07U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:24 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)) 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-UG0ars-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:24 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)) 03:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:24 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-O0Nnqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-pHccBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-A_aOBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-j9AyJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3qT18R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-UeN1Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-nrOqae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DYJbpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-MjiBfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-m5C9xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:25 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)) 03:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:25 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Ewqv6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:26 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)) 03:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:26 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-y4uXFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 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)) 03:36:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:28 INFO - Downloading blessings-1.6.tar.gz 03:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:28 INFO - Installing collected packages: blessings 03:36:28 INFO - Running setup.py install for blessings 03:36:28 INFO - Successfully installed blessings 03:36:28 INFO - Cleaning up... 03:36:29 INFO - Return code: 0 03:36:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:29 INFO - Reading from file tmpfile_stdout 03:36:29 INFO - Current package versions: 03:36:29 INFO - blessings == 1.6 03:36:29 INFO - blobuploader == 1.2.4 03:36:29 INFO - docopt == 0.6.1 03:36:29 INFO - functools32 == 3.2.3-2 03:36:29 INFO - jsonschema == 2.5.1 03:36:29 INFO - manifestparser == 1.1 03:36:29 INFO - mozInstall == 1.12 03:36:29 INFO - mozcrash == 0.17 03:36:29 INFO - mozdebug == 0.1 03:36:29 INFO - mozdevice == 0.48 03:36:29 INFO - mozfile == 1.2 03:36:29 INFO - mozhttpd == 0.7 03:36:29 INFO - mozinfo == 0.9 03:36:29 INFO - mozleak == 0.1 03:36:29 INFO - mozlog == 3.3 03:36:29 INFO - moznetwork == 0.27 03:36:29 INFO - mozprocess == 0.23 03:36:29 INFO - mozprofile == 0.28 03:36:29 INFO - mozrunner == 6.12 03:36:29 INFO - mozscreenshot == 0.1 03:36:29 INFO - mozsystemmonitor == 0.3 03:36:29 INFO - moztest == 0.7 03:36:29 INFO - mozversion == 1.4 03:36:29 INFO - psutil == 3.1.1 03:36:29 INFO - requests == 1.2.3 03:36:29 INFO - wsgiref == 0.1.2 03:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:29 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 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36:29 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 03:36:29 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 03:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:29 INFO - 'HOME': '/Users/cltbld', 03:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PAGER': '/bin/cat', 03:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:29 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - 'XPC_FLAGS': '0x0', 03:36:29 INFO - 'XPC_SERVICE_NAME': '0', 03:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 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)) 03:36:29 INFO - Cleaning up... 03:36:29 INFO - Return code: 0 03:36:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fed1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff66618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9329d43ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, '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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 03:36: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'] in /builds/slave/test/build 03:36: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 03:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:29 INFO - 'HOME': '/Users/cltbld', 03:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PAGER': '/bin/cat', 03:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:36:29 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - 'XPC_FLAGS': '0x0', 03:36:29 INFO - 'XPC_SERVICE_NAME': '0', 03:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:29 INFO - Cleaning up... 03:36:29 INFO - Return code: 0 03:36:29 INFO - Running post-action listener: _resource_record_post_action 03:36:29 INFO - Running post-action listener: _start_resource_monitoring 03:36:29 INFO - Starting resource monitoring. 03:36:29 INFO - [mozharness: 2016-08-28 10:36:29.861733Z] Finished create-virtualenv step (success) 03:36:29 INFO - [mozharness: 2016-08-28 10:36:29.862719Z] Running install step. 03:36:29 INFO - Running pre-action listener: _resource_record_pre_action 03:36:29 INFO - Running main action method: install 03:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:30 INFO - Reading from file tmpfile_stdout 03:36:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:30 INFO - Reading from file tmpfile_stdout 03:36:30 INFO - Output received: 03:36:30 INFO - Usage: mozinstall [options] installer 03:36:30 INFO - Options: 03:36:30 INFO - -h, --help show this help message and exit 03:36:30 INFO - -d DEST, --destination=DEST 03:36:30 INFO - Directory to install application into. [default: 03:36:30 INFO - "/builds/slave/test"] 03:36:30 INFO - --app=APP Application being installed. [default: firefox] 03:36:30 INFO - mkdir: /builds/slave/test/build/application 03:36:30 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'] 03:36:30 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 03:37:04 INFO - Reading from file tmpfile_stdout 03:37:04 INFO - Output received: 03:37:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:37:04 INFO - Running post-action listener: _resource_record_post_action 03:37:04 INFO - [mozharness: 2016-08-28 10:37:04.424588Z] Finished install step (success) 03:37:04 INFO - [mozharness: 2016-08-28 10:37:04.424721Z] Running run-tests step. 03:37:04 INFO - Running pre-action listener: _resource_record_pre_action 03:37:04 INFO - Running main action method: run_tests 03:37:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:04 INFO - 2016-08-28 03:37:04.439 screenresolution[1747:20950] starting screenresolution argv=screenresolution get 03:37:04 INFO - 2016-08-28 03:37:04.441 screenresolution[1747:20950] Display 0: 1600x1200x32@60 03:37:04 INFO - 2016-08-28 03:37:04.447 screenresolution[1748:20952] starting screenresolution argv=screenresolution list 03:37:04 INFO - Available Modes on Display 0 03:37:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:04 INFO - Intel Iris: 03:37:04 INFO - Chipset Model: Intel Iris 03:37:04 INFO - Type: GPU 03:37:04 INFO - Bus: Built-In 03:37:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:04 INFO - Vendor: Intel (0x8086) 03:37:04 INFO - Device ID: 0x0a2e 03:37:04 INFO - Revision ID: 0x0009 03:37:04 INFO - Displays: 03:37:04 INFO - Display: 03:37:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:04 INFO - Display Serial Number: 1600x1200 60 03:37:04 INFO - Main Display: Yes 03:37:04 INFO - Mirror: Off 03:37:04 INFO - Online: Yes 03:37:04 INFO - Rotation: Supported 03:37:04 INFO - Return code: 0 03:37:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:04 INFO - Python 2.7.3 03:37:04 INFO - Return code: 0 03:37:04 INFO - grabbing minidump binary from tooltool 03: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')]} 03:37:04 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 0x10fe35d30>, '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 0x10fb9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fe2db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:04 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 03:37:04 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 03:37:04 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 03:37:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:04 INFO - Return code: 0 03:37:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:37:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:37:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:04 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 03:37:04 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 03:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WW6JvGIDpo/Render', 03:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:04 INFO - 'HOME': '/Users/cltbld', 03:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:04 INFO - 'LOGNAME': 'cltbld', 03:37:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:04 INFO - 'MOZ_NO_REMOTE': '1', 03:37:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:04 INFO - 'NO_EM_RESTART': '1', 03:37:04 INFO - 'PAGER': '/bin/cat', 03:37:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:04 INFO - 'PWD': '/builds/slave/test', 03:37:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:04 INFO - 'SHELL': '/bin/bash', 03:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tG8sMCe7Hc/Listeners', 03:37:04 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 03:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:04 INFO - 'USER': 'cltbld', 03:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:04 INFO - 'XPC_FLAGS': '0x0', 03:37:04 INFO - 'XPC_SERVICE_NAME': '0', 03:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:04 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/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 03:37:05 INFO - mozversion application_buildid: 20160827055712 03:37:05 INFO - mozversion application_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 03:37:05 INFO - mozversion application_display_name: Nightly 03:37:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:05 INFO - mozversion application_name: Firefox 03:37:05 INFO - mozversion application_remotingname: firefox 03:37:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:37:05 INFO - mozversion application_vendor: Mozilla 03:37:05 INFO - mozversion application_version: 51.0a1 03:37:05 INFO - mozversion platform_buildid: 20160827055712 03:37:05 INFO - mozversion platform_changeset: 1a5b53a831e5a6c20de1b081c774feb3ff76756c 03:37:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:37:05 INFO - mozversion platform_version: 51.0a1 03:37:05 INFO - using testdate: 1472380625 03:37:05 INFO - actual date: 1472380625 03:37:05 INFO - starting webserver on 'localhost:49271' 03:37:05 INFO - SUITE-START | Running 2 tests 03:37:05 INFO - TEST-START | dromaeo_css 03:37:05 INFO - operating with platform_type : mac_ 03:37:05 INFO - Initialising browser for dromaeo_css test... 03:37:05 INFO - TEST-INFO | started process 1758 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpIp_vxc/profile http://localhost:49271/getInfo.html) 03:37:08 INFO - PROCESS | 1758 | __metrics Screen width/height:1600/1200 03:37:08 INFO - PROCESS | 1758 | colorDepth:24 03:37:08 INFO - PROCESS | 1758 | Browser inner width/height: 1024/689 03:37:08 INFO - PROCESS | 1758 | __metrics 03:37:08 ERROR - PROCESS | 1758 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:37:08 INFO - TEST-INFO | 1758: exit 0 03:37:08 INFO - Browser initialized. 03:37:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:08 INFO - TEST-INFO | started process 1762 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpIp_vxc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:20 INFO - PROCESS | 1762 | RSS: Main: 243732480 03:37:20 INFO - PROCESS | 1762 | 03:38:10 INFO - PROCESS | 1762 | 1472380690533 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] 03:40:22 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 03:40:24 INFO - PROCESS | 1762 | RSS: Main: 262307840 03:40:24 INFO - PROCESS | 1762 | 03:43:26 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 03:43:27 INFO - PROCESS | 1762 | RSS: Main: 268861440 03:43:27 INFO - PROCESS | 1762 | 03:46:29 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 03:46:29 INFO - PROCESS | 1762 | RSS: Main: 271073280 03:46:29 INFO - PROCESS | 1762 | 03:49:31 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 03:49:32 INFO - PROCESS | 1762 | RSS: Main: 268120064 03:49:32 INFO - PROCESS | 1762 | 03:52:34 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 03:52:35 INFO - PROCESS | 1762 | RSS: Main: 273498112 03:52:35 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 03:55:38 INFO - PROCESS | 1762 | RSS: Main: 276152320 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | __start_tp_report 03:55:38 INFO - PROCESS | 1762 | _x_x_mozilla_page_load 03:55:38 INFO - PROCESS | 1762 | _x_x_mozilla_page_load_details 03:55:38 INFO - PROCESS | 1762 | |i|pagename|runs| 03:55:38 INFO - PROCESS | 1762 | |0;dojo.html;3435.6392578779232;3453.671901169388;3470.028392050227;3483;3493.3013397320533;5163.690178589278;5173.249878767577;5721.370649228582;5858.824235272943;5938.257717785277;5796.5652576056755;5901.144334071557;5913.526917846583;5927.199828023216;5936.940630593693;4430.645548356124;5211.4788521147775;5312.2828418163435;5322.2282768998475;5401.162819762943;5426.294581704373;5441.428649991753;5480.616356855022;5505.862353441156;5528.44715528448;5228.895422091537;5240.161574148118;5370.275012873251;5387.757550910218;5405.18922161675;5252.65857719247;5295.7881684732565;5310.36275646921;5338.252644629755;5376.086065368897;4292;5192.9936432656295;5317.46825317469;5323.813666521692;5365;5002.974985125051;5706.457886500776;5794.82615521535;5826.951148793216;5966.343702192756;6177.135201071854;6236.158118653969;6245.406686364788;6257.906131408033;6261.123442718023;6260;6262;6273.843153921189;6278.968605156945;6290.21372328459;5850.12248162779;5970.582059255898;5983.431574000463;6021.277446706424;6035.034394496947;6459.741610335534;6459.806205813739;6469.353064693493;6472.708728107246;6473.967630161819;6241.625502469776;6248.812535623939;6250.218722659668;6250.968745156336;6285.685715714196;6150.7232174552255;6219.657918814418;6226.937730622636;6234.501239900887;6286.52851036165;5273.920891186635;6131.988221943329;6256.343083976117;6280.937190628035;6293.685315734195;6206.751729930843;6253.906191407133;6274.309825919146;6289.937100628935;6322.778702745381;4320.65434765218;4981.252812078144;5040.470750571138;5116.232565115188;5121.4622464641425;3653.7990410527677;3732.9626703732615;4505.43682039745;4529.139463501924;4557.863264102082;4888.706677599284;5498.257735205776;5915.142304365843;5968.552358573124;5983.880322393615;5328.6802791832615;6159.476444502267;6179.258488981351;6194.977828658311;6205.069239614004;5930.614510056919;5946;5953.374895635982;5973;5992.730327135289;4703.365045718852;5583.3858275589655;5597.328320601554;5598.3282006159525;5598.692071936082;6243.219597550306;6355.872882542416;6358.618482891041;6368.713407896748;6499.545031847725;6306.747730090929;6306.936930630818;6308.211473565804;6323.304436511888;6328.810135695937;6415.775447859489;6448.774292899726;6469.288378278292;6513.088167656627;6539.444147247537;6119.624418755179;6159.106929495288;6202.56582039271;6252.499800015897;6279.654618995999;6264.812055638338;6271.811845644638;6278.560500764903;6279.466245369012;6280.403361680633;6206.596571222856;6229.159063526366;6231.2522497300615;6239.032949892774;6250.218722659668;6089.086637004485;6096.556923351527;6159.938400616115;6181.876362472815;6212.192414986023;4483.663725220556;5971.701414929323;6022.548308876764;6121.173641558333;6121.693915304128;6188.535859810442;6201.596896201732;6215.533834962305;6216.689165541795;6243.406876346739;5948.643081415129;6027.186329845415;6097.115918191926;6101.481374083075;6109.389061093855 03:55:38 INFO - PROCESS | 1762 | |1;ext.html;466.7642840365615;491.0596208261178;492.576384309494;496.21102447109087;538.3244028743927;30641.08076757698;40983.385249221246;41019.9745006375;41086.794566027165;41094;32006.67993320066;42299;42453;42681.359779603255;42887.14225715484;9645.276604254674;9856.310058295921;9859.556319965583;9863.013698630115;9863.802723945517;7495.475316727831;9715.951420242889;9823.410595364301;9837.754056148582;9851.90148098517;9807.06832850878;9827.410355378664;9869.111779939803;9900.55447504864;9928.305018648698;9796.461194634328;9814.312998090136;9846.704598862045;9851.753706157331;9867.309288349818;9641.42151470914;9728.270379721549;9728.41629502225;9729.221662267002;9760.95119524405;39199;39371.8031409844;39508.407373889415;39829.402558961636;39875.20249595021;3387;3444.5866496020385;3588.372034893883;3744.475773391727;4054.9391759123637;30755.077347679606;31098.53352199719;31121.06636800877;31220.843895780603;31684.366312673617;2568.460623269116;3072.296055809245;3159.557661927332;3187.6971687689866;3203.791753536036;444837;488686.55656721845;503670;503888;504395.47802261123;59711.701441492514;59965.10052349218;60345.06031806311;60488.697556512816;60521;34452.82773586116;35309.29381412357;63391.39303283636;63697.044544331875;63741.36258637447;16500.75248871268;16944.49166525006;16945.068021258703;16969.23638436273;17034.829651703323;12731.936340318425;12924.159929604546;13024.934875325564;13048.673783155307;13049.28228947398;15419;19294.614107717767;19315.80684193168;19355.709664355047;19366.806331936783;6619;7892.960535197287;7923.6830526778285;8005.359571234288;8031.036275646959;800.3157300507982;874.3529787956993;989.7970915962211;1032.3031953431405;1102.239454776202;23345.832708364513;30043.549346759817;30547.847260764;31079.84460077685;31185.844070779956;932.7621456528542;996.2129917365345;1024.262530977695;1060.347886050089;1125.8029844777132;13414;15288.617784555252;15337.53987380358;15661.765073523906;16001.919990400207;677671;679589.6020519866;684885;684955;685356;57266.71366643223;57676.71161644165;57707.13439298414;57739.95820292623;57874.7106264466;1307.9476820927057;1336.3652265173964;1374.223563686514;1376.2224343246035;1379.2414172205247;24221.878890605432;27227.732672079477;29506.55740163942;29563.26091847721;29638.369889656275;47100.528994710985;50378.2443263344;50777;50788.49211507838;50906.49093509017;510591;622441;624195;624654;624759;26565.867170664795;26641;26945.461090778466;26974.055908043123;26981.865090674422;46192.30711539397;46766.532334676216;47417.76291118522;47845;48370;38717.419238712006;39291.60708392879;39791.204175915744;39798.801005994785;39968.2006359877;36742.08144796402;38134;39007.804960975016;40545;40723.185536289704;28102.87588496437;29270.560941585467;36327.27345453129;38014;38707.80646096751;34696.82651586726;35091.64908350884;35707.10732231715;35979.64020359763;35981.460278096376;21137.577248454636;22584.5483090334;25304.873475632503;25563.616545751458;25691.35771605725 03:55:38 INFO - PROCESS | 1762 | |2;jquery.html;366.3095065800965;375.885354966735;386.1446895127293;386.30850777108975;408.6934798900824;19404.22383104676;20757.377278681626;21405.03677334518;21456.463588410297;21509.67735483969;11656.592019279327;11848.881511184885;11973.580924667638;12058.517659293619;12194;5286.233496143057;5368.812091576796;5486.670799752028;5538.529225015878;5542.307211598551;5344.866378340534;5381.4349493303225;5427;5446.2375267462585;5495.2856128703215;5276.841694749163;5385.084535628953;5398.838034858941;5419.214213938996;5447.700376479292;5445.047116754572;5459.372172200208;5664.348599911001;5981.222441082631;6057.151998720183;5810.4189581041555;5819.970900145472;5852.619579727304;5858.76564937402;5901.321348044987;24835.751642483523;25006;25584.616230756554;25604.35989100269;25623.97504099834;2105.6841473778904;2130.648443006902;2425.333033415807;2456.3981824452944;2809.4381123775124;9870.654527091518;10003.199744020534;14233.217173055478;15159.805497588706;15582.987105838085;1309.8493673227606;1737.391912830512;1781.153951872863;1863.8322550970477;1923.8172373624484;120835.58328833374;123785.76214237833;124458.37770811179;125422.37288813588;128184;9485;9558.856617150748;9832.262580306506;11215.439228038565;11791.88208117908;13619.86380136186;14391.280435978158;14429.567112986628;14432.494862679965;14484.130952142694;7314.597697126603;8266.545340006238;8320.126386729306;8527.232549070613;8622.827543449095;8510.659573616986;8544.74365769028;8548.700795472128;8623;8716.91283087161;4451.642249114051;4458.308962110878;4469.329600559877;4498.032922921588;4561.312314443677;1864.4313484387121;1911.694128939363;1936.4384328544845;1960.617679552502;1963.7643482782157;839.7102999465175;904.5567671840882;915.7756349694367;955.5508910811907;962.4562122400821;16737.581560461087;18214;19171.616567668567;19347.226110955406;21156;889.3107841422819;936.7517607833793;938.8685584018243;950.8716323296405;1008.7578981044496;9050.502222377832;10401.5839366426;11241.381724005094;11268.774624507463;11296.943515282372;586633;591574;598750;608803.9559802173;609164.8625270536;110763;125408.37295813645;127207;131833;140318;969.898160693117;978.8287049766404;1013.2198207380424;1017.1811691588342;1020.1125021231576;19057.951812650437;19843.503912401728;19874.403767886986;20035.499112522302;20143.496412589804;42878.49925252601;56222.43777562336;56378.16058627734;58072.4192758067;59229.40770592411;70007.9498807508;74594.62702686452;76079;80363.79454308073;83756.58121709352;11758.764824703287;11795.764084718428;11889.405529723306;12060.396980151132;12196.695082623006;12936.676583085498;13164.934175329063;13452.663683407993;13487.527936522174;13487.865121348661;11396.715082123013;11561.42192890369;11667.59163429276;11685.824712629148;11833.290002599872;9376.437413755197;10832.187585931244;11203;11486.770264594828;11588.76822463529;8824.867626985471;10159.136473399843;11460.426978651201;11804.527818887149;11961.880381196424;9699.418034917928;10839.67480975572;11334.433278335886;11735.295882247092;12088.335141567299;8757.737267881974;9204.447733136034;9555.426674399558;11352.829707554229;11751 03:55:38 INFO - PROCESS | 1762 | |3;mootools.html;1500.0774523667944;1531.5558488038469;1740.1734176266275;1830.2404502131617;1878.5491482044313;7834.451588388815;8306.750797476077;8522.957385213082;8772.342074344426;8819.162179592937;8490.193431624002;8682.392232543725;8686.91313086869;8699.52152631605;8716.041235464094;2318.1422873536817;2343.320437073247;2366.479374537608;2370.20598099636;2374.5963186258377;1960.255103060842;2333;2341.730700969385;2394.904203831845;2400.1119585753295;2324.69778928739;2372.6915500984846;2383.7497062808416;2385.844920080198;2389.51015041916;2329.196427232602;2359.304005318435;2371.5256948610177;2375.762423757628;2378.892949817254;2345.2260753951155;2345.7067866516686;2346.307839187427;2348.2720356689483;2348.7651234876375;8774.64901403943;8841.955790221007;8848.336374771918;8853.513056781874;8889.911100888972;5106.540411362995;5175.560077393426;5209.583233341362;5238.978399212155;5243.8164664236565;3445.13871532117;3555.839987200582;3584.982075089608;3612.6567976042234;3645.453182022691;1010.6210171185805;1050.1388861133873;1059.2479339668844;1066.221658189526;1071.1056268016216;11341.943290283578;11495.597654082067;11575.421228938603;11582.710432239177;11606.303621782636;4327.415798867176;4467.754273514923;4659.301104834302;4737.620990320766;4764.213904705754;9869.259805514615;9877.456739879231;9888;9892.55483503244;9953.900460995297;5193.5585475234275;5211.114110601206;5220.9738951305;5227.973860130675;5248.107821670249;4331.112122014979;4681.859544213679;4791.952080479151;4815.085133824562;4832.106060378841;3442.915481623281;3777.112378591029;3815.37046387343;3956.911849241424;3976.264391087658;1278.5844600504872;1284.1845428153003;1285.3252042677668;1293.1917551530294;1298.6818229533635;813.772143799737;838.6435764800058;884.9646014159362;885.274075258282;899.1143723432414;5708.942910570841;5790.276215473066;5949.434803693643;6003.429674181033;6119.296280927661;426.7866066966517;434.4807954494412;439.387055058192;444.1428043875287;445.80607435765546;3972.56301806801;3989.2221016901426;4060.7969601520394;4094.344904815215;4104.8152833121985;10336.121429678562;10520.368777873353;10656.840147397796;10668.94665526683;10677.252592318464;10169.898301017043;10612.310199836986;10631.096356809603;10653.733656658645;10731.678049658523;6482.935170648328;6887.863502522027;8099.352051835956;8152.144024877421;8229.218224268685;5002.87492812668;5377.247185394126;5887.676177810262;6106.084087386927;6165.876682466415;9782.80434391294;9909.900900990899;9969.252306077218;10003.449810260505;10006.949965250127;7969.8406031880195;9814.509274536102;9880.654177103766;10007.699769006942;10105.141063009727;6820.31796820314;7250.347468727839;7344.70621175147;7447.329740323397;7526.962365188139;8320.12638672955;8328.791780205544;8334.958325208578;8352.665893364197;8368.037675667376;6994.475414343843;7294.416446684359;7389.741359052622;7432.442566807619;7475.401967842451;7280.781576552712;7294.197638259893;7302.634868256672;7355.411567074728;7397.186309506058;6897.7585784497305;6931.826704332432;6937.202221744564;6991.720331186695;7020.122484689414;4609.884752881205;4673.813047478063;5059.316992206005;5066.986602679405;5135.845924622267;4735.479097299225;4776.116418462596;4860;5005.924911126263;5067 03:55:38 INFO - PROCESS | 1762 | |4;prototype.html;231.80296747764402;268.8910991048625;270.4725784719796;309.8559169985956;317.17059888391833;5072.4166720827025;5241.816536421226;5624.212610234566;5703.686297253655;5713.885932166969;5557.110862262039;5562.221289019531;5579.38626751057;5602.7758889644465;5605.7197140142935;4000.359942409222;4087.7751723655188;4155.833766649331;4206.074663574024;4209;3268.18615668304;3570.6250843661433;3598.208394153282;3613.6567026132607;4126.31915733905;3303.702666759991;3434.1071321456475;3725.590185079639;4179.955011247188;4244.87265382039;4049.088954985134;4143.1713657268665;4155.542890282067;4193.916121677565;4201.579842015789;3310.9239497163517;3432.433648448003;3584.390653588896;3597.820108994566;3605.6574625410544;4719.622430205575;5042;5067.949320506785;5291.682499050069;5447.45525447456;4652.255169450041;4812.37439132914;4818.180909245437;4848.345473361122;4859.975700121512;4797.968436786073;5577.832665020056;5800.7679692812235;5834.387389324144;5903.763849446017;3406.659334066598;3973.960260397388;3998.6401223889698;4004.198110850129;4011.498562679665;4784.234522476387;5893.292804863444;6193.721282542297;6240.687965601747;6253.749850005995;4043.9890027493125;4052.756834589934;4057.2899742544937;4061.7766022869027;4082.5509193988637;4139.730917490354;4141.3020661529235;4147.543770185277;4152.730072545275;4168.541460439349;4271.508776490681;4622.930656040162;4755.904881902343;4814.542618451242;4828.2998965150555;4780.49804770501;5609.6353737007785;5874.412558744091;5889.087191485327;5922.911156332659;1134.4781400555837;1157.560127151677;1343.810727506164;1385.1342910680823;1412.1244828206577;742.265157494077;861.5476874640739;866.6620018192909;876.8860048193694;884.6417201033463;4261.232978063978;4407.559244075567;4890.535399137077;4991.226359914219;5296.841094767163;5304.549113325334;6132.7546898124465;6147.385261473817;6157.322694503601;6186.267845003406;5171.340494723603;5305.920411193835;5443.230949941285;5476.123820188751;5522.92303000919;2499.7500249974855;2547.592385218356;2847.5443928971267;2974.895878644237;3092.4433601951864;5617.129344951539;5749.597528173072;5990.221271234712;6371.299157092716;6375.74497020114;5458.553483326921;5983.401659834069;6220.626762394271;6345.555811093179;6449.290578036413;5123.820666276662;5329.147336426231;5550.944490555043;6034.668093254825;6155.907661384993;5517.282753242052;5857.853553661193;5925.851853703692;6166.784162554289;6259.405356491126;6087.66517841523;6089.056196289582;6116.418940200674;6144.863200307957;6207.503399728102;6209.503239740719;6424.164858568356;6427.967860160857;6441.871162576628;6447.614382678439;3565.9286814264087;3759.699224062123;3793.0517370657335;3879.7866117363815;3975.8271309964207;5460.7542660579575;5533.335999679904;5599.832005039855;6224.661697735009;6376.713047912948;5172.586193104467;5216.869578260574;5227.555657769132;5699.943000570107;5983.995361553928;5877.706114694333;5937.198478205387;5962.70186490665;5982.192404025575;6057.878842423215;5796.246487956539;5825.70871456417;5832.708364581838;5854.941450585439;5869.236999190078;5544.889102217852;5561.833145005657;5681.545476361964;5894.557908156819;5949.583529152917;4991.825286114969;5094.745262736922;5359.839204823861;5824.204381896629;5867.9413205867395 03:55:38 INFO - PROCESS | 1762 | |5;yui.html;640.196553325576;692.9052097685657;693.2859155070277;696.3906581740977;753.4624935925829;16975.745363819537;17298.221580028898;17715.37996170133;17747.73378399322;17768.91115544422;16118.83881161188;16271;16310.184490775473;16640.334386624552;16695.74956375655;551.9641223320491;713.5932518464477;831.1356189562847;860.6901515454431;890.9376343655947;729.4055344893922;769.2000319667567;807.5760225881401;877.8727084572733;880.5157163560049;788.9053313602376;873.9912600873973;897.161154320709;918.6233644205877;919.2645883293372;913.7989642278689;922.617113897735;922.861570764384;923.6997975657904;924.875141855851;664.8769977554168;666.8366250268667;684.8390628202368;687.8521117959613;689.4725534965755;15189.392424303014;15319.004264722756;15436.3825446982;15450.227488625524;15459;11513.5970241042;14787.33456994427;14830;14833.70332593353;14964.925175374163;11927.165098443113;12027.27836329823;12115.273083615011;12116.878831211663;12133.817992730115;3849.095462566295;3864.613538646141;3890.610938906115;3909.8240579174008;4029.9194016119804;91464.54267728618;125872;126546;130041;131765.3411732935;10730.570777168827;11000.119990400908;11425.257358271685;11438.542458301741;11516.481758320895;19406.70889936652;23012.309630711105;23865.045398183876;23867.94244978358;23947.880260598584;8052.718154864551;8112.22933821286;8150.38872084596;8164.6325915333955;8423.536705481258;4360.4767427908855;4380.846670366585;4455.353973673799;4523.25366314561;4526.88682782933;3615.1865830188;3720.4233343831747;3744.831482583236;3745.9438108428394;3783.281176576442;667.5060455263167;678.372505432473;694.198201077756;697.7557854750796;699.5732603112098;517.7385420362692;526.6445149524056;592.6384905207819;626.4362074133226;655.7409823119841;8977.685780997634;9207.125323094295;9277.721668349961;9283.39657922233;9339.626414943326;524.5803357314134;588.185363271863;641.3746597067915;672.9360710732473;674.2111729276758;3418.9487157692656;4197.433346498245;4413.44831896013;4553.385292985405;4696.624270058387;107395.46302268439;150780;152397;152873;155795;100110;107730.46134769276;132572.33713831563;133661.33169334286;134046;80964.59517702374;113479;114693;114917;116094.8390516084;9054.637814487347;9208.539573021188;9495.28785341116;9582.472963987047;9822.214222862296;56712;60186.49533761691;60445;61226.387736122066;64224.67887660532;88922.55538722264;90927;91592;91794;92215;12902.61301659196;12948.09363344557;13045.478180873039;13078.149920255153;13548.932255338661;14551.41794328215;14624.634384140481;14810.536849599415;14913.478028269392;15173;13344.866551334362;13720.245386503439;14235.288235588387;14263.928680356532;14270;11280.605178818701;13319;13490.055696101179;13616.523421680193;13647.181169129486;11190.440477976232;13115.868841311465;13805.585832425044;14000.159990400609;14137.36381862798;10915.052160953801;11188.440577971232;11319.490622921823;11420.200585958903;11757.941210293893;8737.781555461164;10188.745281368025;10649.733756656145;11508.82736758966;11694 03:55:38 INFO - PROCESS | 1762 | __end_tp_report 03:55:38 INFO - PROCESS | 1762 | __start_cc_report 03:55:38 INFO - PROCESS | 1762 | _x_x_mozilla_cycle_collect,376 03:55:38 INFO - PROCESS | 1762 | __end_cc_report 03:55:38 INFO - PROCESS | 1762 | __startTimestamp1472381738525__endTimestamp 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | ------- Summary: start ------- 03:55:38 INFO - PROCESS | 1762 | Number of tests: 6 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#0] dojo.html Cycles:165 Average:5783.87 Median:6089.09 stddev:697.12 (11.4%) stddev-sans-first:674.48 03:55:38 INFO - PROCESS | 1762 | Values: 3435.6 3453.7 3470.0 3483.0 3493.3 5163.7 5173.2 5721.4 5858.8 5938.3 5796.6 5901.1 5913.5 5927.2 5936.9 4430.6 5211.5 5312.3 5322.2 5401.2 5426.3 5441.4 5480.6 5505.9 5528.4 5228.9 5240.2 5370.3 5387.8 5405.2 5252.7 5295.8 5310.4 5338.3 5376.1 4292.0 5193.0 5317.5 5323.8 5365.0 5003.0 5706.5 5794.8 5827.0 5966.3 6177.1 6236.2 6245.4 6257.9 6261.1 6260.0 6262.0 6273.8 6279.0 6290.2 5850.1 5970.6 5983.4 6021.3 6035.0 6459.7 6459.8 6469.4 6472.7 6474.0 6241.6 6248.8 6250.2 6251.0 6285.7 6150.7 6219.7 6226.9 6234.5 6286.5 5273.9 6132.0 6256.3 6280.9 6293.7 6206.8 6253.9 6274.3 6289.9 6322.8 4320.7 4981.3 5040.5 5116.2 5121.5 3653.8 3733.0 4505.4 4529.1 4557.9 4888.7 5498.3 5915.1 5968.6 5983.9 5328.7 6159.5 6179.3 6195.0 6205.1 5930.6 5946.0 5953.4 5973.0 5992.7 4703.4 5583.4 5597.3 5598.3 5598.7 6243.2 6355.9 6358.6 6368.7 6499.5 6306.7 6306.9 6308.2 6323.3 6328.8 6415.8 6448.8 6469.3 6513.1 6539.4 6119.6 6159.1 6202.6 6252.5 6279.7 6264.8 6271.8 6278.6 6279.5 6280.4 6206.6 6229.2 6231.3 6239.0 6250.2 6089.1 6096.6 6159.9 6181.9 6212.2 4483.7 5971.7 6022.5 6121.2 6121.7 6188.5 6201.6 6215.5 6216.7 6243.4 5948.6 6027.2 6097.1 6101.5 6109.4 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#1] ext.html Cycles:180 Average:71582.16 Median:22011.57 stddev:159882.92 (726.4%) stddev-sans-first:160242.28 03:55:38 INFO - PROCESS | 1762 | Values: 466.8 491.1 492.6 496.2 538.3 30641.1 40983.4 41020.0 41086.8 41094.0 32006.7 42299.0 42453.0 42681.4 42887.1 9645.3 9856.3 9859.6 9863.0 9863.8 7495.5 9716.0 9823.4 9837.8 9851.9 9807.1 9827.4 9869.1 9900.6 9928.3 9796.5 9814.3 9846.7 9851.8 9867.3 9641.4 9728.3 9728.4 9729.2 9761.0 39199.0 39371.8 39508.4 39829.4 39875.2 3387.0 3444.6 3588.4 3744.5 4054.9 30755.1 31098.5 31121.1 31220.8 31684.4 2568.5 3072.3 3159.6 3187.7 3203.8 444837.0 488686.6 503670.0 503888.0 504395.5 59711.7 59965.1 60345.1 60488.7 60521.0 34452.8 35309.3 63391.4 63697.0 63741.4 16500.8 16944.5 16945.1 16969.2 17034.8 12731.9 12924.2 13024.9 13048.7 13049.3 15419.0 19294.6 19315.8 19355.7 19366.8 6619.0 7893.0 7923.7 8005.4 8031.0 800.3 874.4 989.8 1032.3 1102.2 23345.8 30043.5 30547.8 31079.8 31185.8 932.8 996.2 1024.3 1060.3 1125.8 13414.0 15288.6 15337.5 15661.8 16001.9 677671.0 679589.6 684885.0 684955.0 685356.0 57266.7 57676.7 57707.1 57740.0 57874.7 1307.9 1336.4 1374.2 1376.2 1379.2 24221.9 27227.7 29506.6 29563.3 29638.4 47100.5 50378.2 50777.0 50788.5 50906.5 510591.0 622441.0 624195.0 624654.0 624759.0 26565.9 26641.0 26945.5 26974.1 26981.9 46192.3 46766.5 47417.8 47845.0 48370.0 38717.4 39291.6 39791.2 39798.8 39968.2 36742.1 38134.0 39007.8 40545.0 40723.2 28102.9 29270.6 36327.3 38014.0 38707.8 34696.8 35091.6 35707.1 35979.6 35981.5 21137.6 22584.5 25304.9 25563.6 25691.4 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#2] jquery.html Cycles:180 Average:35155.01 Median:2440.87 stddev:100129.01 (4102.2%) stddev-sans-first:100375.82 03:55:38 INFO - PROCESS | 1762 | Values: 366.3 375.9 386.1 386.3 408.7 19404.2 20757.4 21405.0 21456.5 21509.7 11656.6 11848.9 11973.6 12058.5 12194.0 5286.2 5368.8 5486.7 5538.5 5542.3 5344.9 5381.4 5427.0 5446.2 5495.3 5276.8 5385.1 5398.8 5419.2 5447.7 5445.0 5459.4 5664.3 5981.2 6057.2 5810.4 5820.0 5852.6 5858.8 5901.3 24835.8 25006.0 25584.6 25604.4 25624.0 2105.7 2130.6 2425.3 2456.4 2809.4 9870.7 10003.2 14233.2 15159.8 15583.0 1309.8 1737.4 1781.2 1863.8 1923.8 120835.6 123785.8 124458.4 125422.4 128184.0 9485.0 9558.9 9832.3 11215.4 11791.9 13619.9 14391.3 14429.6 14432.5 14484.1 7314.6 8266.5 8320.1 8527.2 8622.8 8510.7 8544.7 8548.7 8623.0 8716.9 4451.6 4458.3 4469.3 4498.0 4561.3 1864.4 1911.7 1936.4 1960.6 1963.8 839.7 904.6 915.8 955.6 962.5 16737.6 18214.0 19171.6 19347.2 21156.0 889.3 936.8 938.9 950.9 1008.8 9050.5 10401.6 11241.4 11268.8 11296.9 586633.0 591574.0 598750.0 608804.0 609164.9 110763.0 125408.4 127207.0 131833.0 140318.0 969.9 978.8 1013.2 1017.2 1020.1 19058.0 19843.5 19874.4 20035.5 20143.5 42878.5 56222.4 56378.2 58072.4 59229.4 70007.9 74594.6 76079.0 80363.8 83756.6 11758.8 11795.8 11889.4 12060.4 12196.7 12936.7 13164.9 13452.7 13487.5 13487.9 11396.7 11561.4 11667.6 11685.8 11833.3 9376.4 10832.2 11203.0 11486.8 11588.8 8824.9 10159.1 11460.4 11804.5 11961.9 9699.4 10839.7 11334.4 11735.3 12088.3 8757.7 9204.4 9555.4 11352.8 11751.0 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#3] mootools.html Cycles:180 Average:5621.06 Median:4803.52 stddev:3165.73 (65.9%) stddev-sans-first:3159.46 03:55:38 INFO - PROCESS | 1762 | Values: 1500.1 1531.6 1740.2 1830.2 1878.5 7834.5 8306.8 8523.0 8772.3 8819.2 8490.2 8682.4 8686.9 8699.5 8716.0 2318.1 2343.3 2366.5 2370.2 2374.6 1960.3 2333.0 2341.7 2394.9 2400.1 2324.7 2372.7 2383.7 2385.8 2389.5 2329.2 2359.3 2371.5 2375.8 2378.9 2345.2 2345.7 2346.3 2348.3 2348.8 8774.6 8842.0 8848.3 8853.5 8889.9 5106.5 5175.6 5209.6 5239.0 5243.8 3445.1 3555.8 3585.0 3612.7 3645.5 1010.6 1050.1 1059.2 1066.2 1071.1 11341.9 11495.6 11575.4 11582.7 11606.3 4327.4 4467.8 4659.3 4737.6 4764.2 9869.3 9877.5 9888.0 9892.6 9953.9 5193.6 5211.1 5221.0 5228.0 5248.1 4331.1 4681.9 4792.0 4815.1 4832.1 3442.9 3777.1 3815.4 3956.9 3976.3 1278.6 1284.2 1285.3 1293.2 1298.7 813.8 838.6 885.0 885.3 899.1 5708.9 5790.3 5949.4 6003.4 6119.3 426.8 434.5 439.4 444.1 445.8 3972.6 3989.2 4060.8 4094.3 4104.8 10336.1 10520.4 10656.8 10668.9 10677.3 10169.9 10612.3 10631.1 10653.7 10731.7 6482.9 6887.9 8099.4 8152.1 8229.2 5002.9 5377.2 5887.7 6106.1 6165.9 9782.8 9909.9 9969.3 10003.4 10006.9 7969.8 9814.5 9880.7 10007.7 10105.1 6820.3 7250.3 7344.7 7447.3 7527.0 8320.1 8328.8 8335.0 8352.7 8368.0 6994.5 7294.4 7389.7 7432.4 7475.4 7280.8 7294.2 7302.6 7355.4 7397.2 6897.8 6931.8 6937.2 6991.7 7020.1 4609.9 4673.8 5059.3 5067.0 5135.8 4735.5 4776.1 4860.0 5005.9 5067.0 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#4] prototype.html Cycles:180 Average:4710.85 Median:5300.70 stddev:1516.56 (28.6%) stddev-sans-first:1483.08 03:55:38 INFO - PROCESS | 1762 | Values: 231.8 268.9 270.5 309.9 317.2 5072.4 5241.8 5624.2 5703.7 5713.9 5557.1 5562.2 5579.4 5602.8 5605.7 4000.4 4087.8 4155.8 4206.1 4209.0 3268.2 3570.6 3598.2 3613.7 4126.3 3303.7 3434.1 3725.6 4180.0 4244.9 4049.1 4143.2 4155.5 4193.9 4201.6 3310.9 3432.4 3584.4 3597.8 3605.7 4719.6 5042.0 5067.9 5291.7 5447.5 4652.3 4812.4 4818.2 4848.3 4860.0 4798.0 5577.8 5800.8 5834.4 5903.8 3406.7 3974.0 3998.6 4004.2 4011.5 4784.2 5893.3 6193.7 6240.7 6253.7 4044.0 4052.8 4057.3 4061.8 4082.6 4139.7 4141.3 4147.5 4152.7 4168.5 4271.5 4622.9 4755.9 4814.5 4828.3 4780.5 5609.6 5874.4 5889.1 5922.9 1134.5 1157.6 1343.8 1385.1 1412.1 742.3 861.5 866.7 876.9 884.6 4261.2 4407.6 4890.5 4991.2 5296.8 5304.5 6132.8 6147.4 6157.3 6186.3 5171.3 5305.9 5443.2 5476.1 5522.9 2499.8 2547.6 2847.5 2974.9 3092.4 5617.1 5749.6 5990.2 6371.3 6375.7 5458.6 5983.4 6220.6 6345.6 6449.3 5123.8 5329.1 5550.9 6034.7 6155.9 5517.3 5857.9 5925.9 6166.8 6259.4 6087.7 6089.1 6116.4 6144.9 6207.5 6209.5 6424.2 6428.0 6441.9 6447.6 3565.9 3759.7 3793.1 3879.8 3975.8 5460.8 5533.3 5599.8 6224.7 6376.7 5172.6 5216.9 5227.6 5699.9 5984.0 5877.7 5937.2 5962.7 5982.2 6057.9 5796.2 5825.7 5832.7 5854.9 5869.2 5544.9 5561.8 5681.5 5894.6 5949.6 4991.8 5094.7 5359.8 5824.2 5867.9 03:55:38 INFO - PROCESS | 1762 | 03:55:38 INFO - PROCESS | 1762 | [#5] yui.html Cycles:180 Average:24882.18 Median:3745.39 stddev:39469.49 (1053.8%) stddev-sans-first:39538.24 03:55:38 INFO - PROCESS | 1762 | Values: 640.2 692.9 693.3 696.4 753.5 16975.7 17298.2 17715.4 17747.7 17768.9 16118.8 16271.0 16310.2 16640.3 16695.7 552.0 713.6 831.1 860.7 890.9 729.4 769.2 807.6 877.9 880.5 788.9 874.0 897.2 918.6 919.3 913.8 922.6 922.9 923.7 924.9 664.9 666.8 684.8 687.9 689.5 15189.4 15319.0 15436.4 15450.2 15459.0 11513.6 14787.3 14830.0 14833.7 14964.9 11927.2 12027.3 12115.3 12116.9 12133.8 3849.1 3864.6 3890.6 3909.8 4029.9 91464.5 125872.0 126546.0 130041.0 131765.3 10730.6 11000.1 11425.3 11438.5 11516.5 19406.7 23012.3 23865.0 23867.9 23947.9 8052.7 8112.2 8150.4 8164.6 8423.5 4360.5 4380.8 4455.4 4523.3 4526.9 3615.2 3720.4 3744.8 3745.9 3783.3 667.5 678.4 694.2 697.8 699.6 517.7 526.6 592.6 626.4 655.7 8977.7 9207.1 9277.7 9283.4 9339.6 524.6 588.2 641.4 672.9 674.2 3418.9 4197.4 4413.4 4553.4 4696.6 107395.5 150780.0 152397.0 152873.0 155795.0 100110.0 107730.5 132572.3 133661.3 134046.0 80964.6 113479.0 114693.0 114917.0 116094.8 9054.6 9208.5 9495.3 9582.5 9822.2 56712.0 60186.5 60445.0 61226.4 64224.7 88922.6 90927.0 91592.0 91794.0 92215.0 12902.6 12948.1 13045.5 13078.1 13548.9 14551.4 14624.6 14810.5 14913.5 15173.0 13344.9 13720.2 14235.3 14263.9 14270.0 11280.6 13319.0 13490.1 13616.5 13647.2 11190.4 13115.9 13805.6 14000.2 14137.4 10915.1 11188.4 11319.5 11420.2 11757.9 8737.8 10188.7 10649.7 11508.8 11694.0 03:55:38 INFO - PROCESS | 1762 | -------- Summary: end -------- 03:55:38 INFO - PROCESS | 1762 | 03:55:39 INFO - TEST-INFO | 1762: exit 0 03:55:39 INFO - TEST-OK | dromaeo_css | took 1114091ms 03:55:39 INFO - TEST-START | kraken 03:55:39 INFO - operating with platform_type : mac_ 03:55:39 INFO - Initialising browser for kraken test... 03:55:39 INFO - TEST-INFO | started process 1773 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpW3M3kT/profile http://localhost:49271/getInfo.html) 03:55:41 INFO - PROCESS | 1773 | __metrics Screen width/height:1600/1200 03:55:41 INFO - PROCESS | 1773 | colorDepth:24 03:55:41 INFO - PROCESS | 1773 | Browser inner width/height: 1024/689 03:55:41 INFO - PROCESS | 1773 | __metrics 03:55:42 ERROR - PROCESS | 1773 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:55:42 INFO - TEST-INFO | 1773: exit 0 03:55:42 INFO - Browser initialized. 03:55:42 INFO - Running cycle 1/1 for kraken test... 03:55:42 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpW3M3kT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:54 INFO - PROCESS | 1775 | RSS: Main: 243822592 03:55:54 INFO - PROCESS | 1775 | 03:55:57 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:58 INFO - PROCESS | 1775 | RSS: Main: 256569344 03:55:58 INFO - PROCESS | 1775 | 03:56:01 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 03:56:02 INFO - PROCESS | 1775 | RSS: Main: 265191424 03:56:02 INFO - PROCESS | 1775 | 03:56:05 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 03:56:06 INFO - PROCESS | 1775 | RSS: Main: 262901760 03:56:06 INFO - PROCESS | 1775 | 03:56:08 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 03:56:08 INFO - PROCESS | 1775 | RSS: Main: 264376320 03:56:08 INFO - PROCESS | 1775 | 03:56:10 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:11 INFO - PROCESS | 1775 | RSS: Main: 264654848 03:56:11 INFO - PROCESS | 1775 | 03:56:14 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:14 INFO - PROCESS | 1775 | RSS: Main: 265928704 03:56:14 INFO - PROCESS | 1775 | 03:56:18 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:18 INFO - PROCESS | 1775 | RSS: Main: 266158080 03:56:18 INFO - PROCESS | 1775 | 03:56:21 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 03:56:22 INFO - PROCESS | 1775 | RSS: Main: 266215424 03:56:22 INFO - PROCESS | 1775 | 03:56:23 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:24 INFO - PROCESS | 1775 | RSS: Main: 266280960 03:56:24 INFO - PROCESS | 1775 | 03:56:26 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:27 INFO - PROCESS | 1775 | RSS: Main: 266227712 03:56:27 INFO - PROCESS | 1775 | 03:56:29 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:30 INFO - PROCESS | 1775 | RSS: Main: 266293248 03:56:30 INFO - PROCESS | 1775 | 03:56:32 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:33 INFO - PROCESS | 1775 | RSS: Main: 266629120 03:56:33 INFO - PROCESS | 1775 | 03:56:36 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:37 INFO - PROCESS | 1775 | RSS: Main: 266375168 03:56:37 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 03:56:39 INFO - PROCESS | 1775 | RSS: Main: 268333056 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | __start_tp_report 03:56:39 INFO - PROCESS | 1775 | _x_x_mozilla_page_load 03:56:39 INFO - PROCESS | 1775 | _x_x_mozilla_page_load_details 03:56:39 INFO - PROCESS | 1775 | |i|pagename|runs| 03:56:39 INFO - PROCESS | 1775 | |0;ai-astar;108;113;115;115;131;174;95;169;173;191 03:56:39 INFO - PROCESS | 1775 | |1;audio-beat-detection;170;147;147;160;108;129;132;136;194;142 03:56:39 INFO - PROCESS | 1775 | |2;audio-dft;199;256;283;202;192;195;196;196;193;197 03:56:39 INFO - PROCESS | 1775 | |3;audio-fft;72;81;74;143;59;61;61;66;132;66 03:56:39 INFO - PROCESS | 1775 | |4;audio-oscillator;70;71;126;81;72;77;108;68;71;108 03:56:39 INFO - PROCESS | 1775 | |5;imaging-gaussian-blur;96;132;126;85;91;85;90;85;99;131 03:56:39 INFO - PROCESS | 1775 | |6;imaging-darkroom;98;122;170;107;98;98;164;98;127;176 03:56:39 INFO - PROCESS | 1775 | |7;imaging-desaturate;94;93;89;90;97;89;92;94;92;91 03:56:39 INFO - PROCESS | 1775 | |8;json-parse-financial;51;69;91;91;90;90;58;57;59;58 03:56:39 INFO - PROCESS | 1775 | |9;json-stringify-tinderbox;69;69;73;71;72;77;76;70;70;70 03:56:39 INFO - PROCESS | 1775 | |10;stanford-crypto-aes;87;87;92;100;100;86;88;85;104;114 03:56:39 INFO - PROCESS | 1775 | |11;stanford-crypto-ccm;150;148;158;146;140;142;143;166;204;139 03:56:39 INFO - PROCESS | 1775 | |12;stanford-crypto-pbkdf2;174;249;250;168;252;247;223;176;173;172 03:56:39 INFO - PROCESS | 1775 | |13;stanford-crypto-sha256-iterative;68;68;71;65;72;69;67;70;67;67 03:56:39 INFO - PROCESS | 1775 | __end_tp_report 03:56:39 INFO - PROCESS | 1775 | __start_cc_report 03:56:39 INFO - PROCESS | 1775 | _x_x_mozilla_cycle_collect,969 03:56:39 INFO - PROCESS | 1775 | __end_cc_report 03:56:39 INFO - PROCESS | 1775 | __startTimestamp1472381799372__endTimestamp 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | ------- Summary: start ------- 03:56:39 INFO - PROCESS | 1775 | Number of tests: 14 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#0] ai-astar Cycles:10 Average:138.40 Median:171.00 stddev:34.59 (20.2%) stddev-sans-first:34.90 03:56:39 INFO - PROCESS | 1775 | Values: 108.0 113.0 115.0 115.0 131.0 174.0 95.0 169.0 173.0 191.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:147.00 stddev:23.85 (16.2%) stddev-sans-first:23.74 03:56:39 INFO - PROCESS | 1775 | Values: 170.0 147.0 147.0 160.0 108.0 129.0 132.0 136.0 194.0 142.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#2] audio-dft Cycles:10 Average:210.90 Median:198.00 stddev:31.66 (16.0%) stddev-sans-first:33.29 03:56:39 INFO - PROCESS | 1775 | Values: 199.0 256.0 283.0 202.0 192.0 195.0 196.0 196.0 193.0 197.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#3] audio-fft Cycles:10 Average:81.50 Median:66.00 stddev:30.38 (46.0%) stddev-sans-first:32.03 03:56:39 INFO - PROCESS | 1775 | Values: 72.0 81.0 74.0 143.0 59.0 61.0 61.0 66.0 132.0 66.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:71.00 stddev:20.80 (29.3%) stddev-sans-first:21.32 03:56:39 INFO - PROCESS | 1775 | Values: 70.0 71.0 126.0 81.0 72.0 77.0 108.0 68.0 71.0 108.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#5] imaging-gaussian-blur Cycles:10 Average:102.00 Median:87.50 stddev:19.70 (22.5%) stddev-sans-first:20.78 03:56:39 INFO - PROCESS | 1775 | Values: 96.0 132.0 126.0 85.0 91.0 85.0 90.0 85.0 99.0 131.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#6] imaging-darkroom Cycles:10 Average:125.80 Median:137.00 stddev:32.31 (23.6%) stddev-sans-first:32.66 03:56:39 INFO - PROCESS | 1775 | Values: 98.0 122.0 170.0 107.0 98.0 98.0 164.0 98.0 127.0 176.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:92.50 stddev:2.51 (2.7%) stddev-sans-first:2.57 03:56:39 INFO - PROCESS | 1775 | Values: 94.0 93.0 89.0 90.0 97.0 89.0 92.0 94.0 92.0 91.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:79.50 stddev:17.00 (21.4%) stddev-sans-first:16.36 03:56:39 INFO - PROCESS | 1775 | Values: 51.0 69.0 91.0 91.0 90.0 90.0 58.0 57.0 59.0 58.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:2.83 (4.0%) stddev-sans-first:2.83 03:56:39 INFO - PROCESS | 1775 | Values: 69.0 69.0 73.0 71.0 72.0 77.0 76.0 70.0 70.0 70.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:86.50 stddev:9.74 (11.3%) stddev-sans-first:9.97 03:56:39 INFO - PROCESS | 1775 | Values: 87.0 87.0 92.0 100.0 100.0 86.0 88.0 85.0 104.0 114.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:149.00 stddev:19.61 (13.2%) stddev-sans-first:20.75 03:56:39 INFO - PROCESS | 1775 | Values: 150.0 148.0 158.0 146.0 140.0 142.0 143.0 166.0 204.0 139.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:208.40 Median:235.00 stddev:38.62 (16.4%) stddev-sans-first:38.91 03:56:39 INFO - PROCESS | 1775 | Values: 174.0 249.0 250.0 168.0 252.0 247.0 223.0 176.0 173.0 172.0 03:56:39 INFO - PROCESS | 1775 | 03:56:39 INFO - PROCESS | 1775 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.12 (3.1%) stddev-sans-first:2.24 03:56:39 INFO - PROCESS | 1775 | Values: 68.0 68.0 71.0 65.0 72.0 69.0 67.0 70.0 67.0 67.0 03:56:39 INFO - PROCESS | 1775 | -------- Summary: end -------- 03:56:39 INFO - PROCESS | 1775 | 03:56:40 INFO - TEST-INFO | 1775: exit 0 03:56:40 INFO - TEST-OK | kraken | took 61025ms 03:56:40 INFO - SUITE-END | took 1175s 03:56:40 INFO - Completed test suite (00:19:35) 03:56:40 INFO - javascript benchmark 03:56:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7367.706339684318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3435.6392578779232, 3453.671901169388, 3470.028392050227, 3483.0, 3493.3013397320533, 5163.690178589278, 5173.249878767577, 5721.370649228582, 5858.824235272943, 5938.257717785277, 5796.5652576056755, 5901.144334071557, 5913.526917846583, 5927.199828023216, 5936.940630593693, 4430.645548356124, 5211.4788521147775, 5312.2828418163435, 5322.2282768998475, 5401.162819762943, 5426.294581704373, 5441.428649991753, 5480.616356855022, 5505.862353441156, 5528.44715528448, 5228.895422091537, 5240.161574148118, 5370.275012873251, 5387.757550910218, 5405.18922161675, 5252.65857719247, 5295.7881684732565, 5310.36275646921, 5338.252644629755, 5376.086065368897, 4292.0, 5192.9936432656295, 5317.46825317469, 5323.813666521692, 5365.0, 5002.974985125051, 5706.457886500776, 5794.82615521535, 5826.951148793216, 5966.343702192756, 6177.135201071854, 6236.158118653969, 6245.406686364788, 6257.906131408033, 6261.123442718023, 6260.0, 6262.0, 6273.843153921189, 6278.968605156945, 6290.21372328459, 5850.12248162779, 5970.582059255898, 5983.431574000463, 6021.277446706424, 6035.034394496947, 6459.741610335534, 6459.806205813739, 6469.353064693493, 6472.708728107246, 6473.967630161819, 6241.625502469776, 6248.812535623939, 6250.218722659668, 6250.968745156336, 6285.685715714196, 6150.7232174552255, 6219.657918814418, 6226.937730622636, 6234.501239900887, 6286.52851036165, 5273.920891186635, 6131.988221943329, 6256.343083976117, 6280.937190628035, 6293.685315734195, 6206.751729930843, 6253.906191407133, 6274.309825919146, 6289.937100628935, 6322.778702745381, 4320.65434765218, 4981.252812078144, 5040.470750571138, 5116.232565115188, 5121.4622464641425, 3653.7990410527677, 3732.9626703732615, 4505.43682039745, 4529.139463501924, 4557.863264102082, 4888.706677599284, 5498.257735205776, 5915.142304365843, 5968.552358573124, 5983.880322393615, 5328.6802791832615, 6159.476444502267, 6179.258488981351, 6194.977828658311, 6205.069239614004, 5930.614510056919, 5946.0, 5953.374895635982, 5973.0, 5992.730327135289, 4703.365045718852, 5583.3858275589655, 5597.328320601554, 5598.3282006159525, 5598.692071936082, 6243.219597550306, 6355.872882542416, 6358.618482891041, 6368.713407896748, 6499.545031847725, 6306.747730090929, 6306.936930630818, 6308.211473565804, 6323.304436511888, 6328.810135695937, 6415.775447859489, 6448.774292899726, 6469.288378278292, 6513.088167656627, 6539.444147247537, 6119.624418755179, 6159.106929495288, 6202.56582039271, 6252.499800015897, 6279.654618995999, 6264.812055638338, 6271.811845644638, 6278.560500764903, 6279.466245369012, 6280.403361680633, 6206.596571222856, 6229.159063526366, 6231.2522497300615, 6239.032949892774, 6250.218722659668, 6089.086637004485, 6096.556923351527, 6159.938400616115, 6181.876362472815, 6212.192414986023, 4483.663725220556, 5971.701414929323, 6022.548308876764, 6121.173641558333, 6121.693915304128, 6188.535859810442, 6201.596896201732, 6215.533834962305, 6216.689165541795, 6243.406876346739, 5948.643081415129, 6027.186329845415, 6097.115918191926, 6101.481374083075, 6109.389061093855], "value": 5740.091333033396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.7642840365615, 491.0596208261178, 492.576384309494, 496.21102447109087, 538.3244028743927, 30641.08076757698, 40983.385249221246, 41019.9745006375, 41086.794566027165, 41094.0, 32006.67993320066, 42299.0, 42453.0, 42681.359779603255, 42887.14225715484, 9645.276604254674, 9856.310058295921, 9859.556319965583, 9863.013698630115, 9863.802723945517, 7495.475316727831, 9715.951420242889, 9823.410595364301, 9837.754056148582, 9851.90148098517, 9807.06832850878, 9827.410355378664, 9869.111779939803, 9900.55447504864, 9928.305018648698, 9796.461194634328, 9814.312998090136, 9846.704598862045, 9851.753706157331, 9867.309288349818, 9641.42151470914, 9728.270379721549, 9728.41629502225, 9729.221662267002, 9760.95119524405, 39199.0, 39371.8031409844, 39508.407373889415, 39829.402558961636, 39875.20249595021, 3387.0, 3444.5866496020385, 3588.372034893883, 3744.475773391727, 4054.9391759123637, 30755.077347679606, 31098.53352199719, 31121.06636800877, 31220.843895780603, 31684.366312673617, 2568.460623269116, 3072.296055809245, 3159.557661927332, 3187.6971687689866, 3203.791753536036, 444837.0, 488686.55656721845, 503670.0, 503888.0, 504395.47802261123, 59711.701441492514, 59965.10052349218, 60345.06031806311, 60488.697556512816, 60521.0, 34452.82773586116, 35309.29381412357, 63391.39303283636, 63697.044544331875, 63741.36258637447, 16500.75248871268, 16944.49166525006, 16945.068021258703, 16969.23638436273, 17034.829651703323, 12731.936340318425, 12924.159929604546, 13024.934875325564, 13048.673783155307, 13049.28228947398, 15419.0, 19294.614107717767, 19315.80684193168, 19355.709664355047, 19366.806331936783, 6619.0, 7892.960535197287, 7923.6830526778285, 8005.359571234288, 8031.036275646959, 800.3157300507982, 874.3529787956993, 989.7970915962211, 1032.3031953431405, 1102.239454776202, 23345.832708364513, 30043.549346759817, 30547.847260764, 31079.84460077685, 31185.844070779956, 932.7621456528542, 996.2129917365345, 1024.262530977695, 1060.347886050089, 1125.8029844777132, 13414.0, 15288.617784555252, 15337.53987380358, 15661.765073523906, 16001.919990400207, 677671.0, 679589.6020519866, 684885.0, 684955.0, 685356.0, 57266.71366643223, 57676.71161644165, 57707.13439298414, 57739.95820292623, 57874.7106264466, 1307.9476820927057, 1336.3652265173964, 1374.223563686514, 1376.2224343246035, 1379.2414172205247, 24221.878890605432, 27227.732672079477, 29506.55740163942, 29563.26091847721, 29638.369889656275, 47100.528994710985, 50378.2443263344, 50777.0, 50788.49211507838, 50906.49093509017, 510591.0, 622441.0, 624195.0, 624654.0, 624759.0, 26565.867170664795, 26641.0, 26945.461090778466, 26974.055908043123, 26981.865090674422, 46192.30711539397, 46766.532334676216, 47417.76291118522, 47845.0, 48370.0, 38717.419238712006, 39291.60708392879, 39791.204175915744, 39798.801005994785, 39968.2006359877, 36742.08144796402, 38134.0, 39007.804960975016, 40545.0, 40723.185536289704, 28102.87588496437, 29270.560941585467, 36327.27345453129, 38014.0, 38707.80646096751, 34696.82651586726, 35091.64908350884, 35707.10732231715, 35979.64020359763, 35981.460278096376, 21137.577248454636, 22584.5483090334, 25304.873475632503, 25563.616545751458, 25691.35771605725], "value": 19821.866990630733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3095065800965, 375.885354966735, 386.1446895127293, 386.30850777108975, 408.6934798900824, 19404.22383104676, 20757.377278681626, 21405.03677334518, 21456.463588410297, 21509.67735483969, 11656.592019279327, 11848.881511184885, 11973.580924667638, 12058.517659293619, 12194.0, 5286.233496143057, 5368.812091576796, 5486.670799752028, 5538.529225015878, 5542.307211598551, 5344.866378340534, 5381.4349493303225, 5427.0, 5446.2375267462585, 5495.2856128703215, 5276.841694749163, 5385.084535628953, 5398.838034858941, 5419.214213938996, 5447.700376479292, 5445.047116754572, 5459.372172200208, 5664.348599911001, 5981.222441082631, 6057.151998720183, 5810.4189581041555, 5819.970900145472, 5852.619579727304, 5858.76564937402, 5901.321348044987, 24835.751642483523, 25006.0, 25584.616230756554, 25604.35989100269, 25623.97504099834, 2105.6841473778904, 2130.648443006902, 2425.333033415807, 2456.3981824452944, 2809.4381123775124, 9870.654527091518, 10003.199744020534, 14233.217173055478, 15159.805497588706, 15582.987105838085, 1309.8493673227606, 1737.391912830512, 1781.153951872863, 1863.8322550970477, 1923.8172373624484, 120835.58328833374, 123785.76214237833, 124458.37770811179, 125422.37288813588, 128184.0, 9485.0, 9558.856617150748, 9832.262580306506, 11215.439228038565, 11791.88208117908, 13619.86380136186, 14391.280435978158, 14429.567112986628, 14432.494862679965, 14484.130952142694, 7314.597697126603, 8266.545340006238, 8320.126386729306, 8527.232549070613, 8622.827543449095, 8510.659573616986, 8544.74365769028, 8548.700795472128, 8623.0, 8716.91283087161, 4451.642249114051, 4458.308962110878, 4469.329600559877, 4498.032922921588, 4561.312314443677, 1864.4313484387121, 1911.694128939363, 1936.4384328544845, 1960.617679552502, 1963.7643482782157, 839.7102999465175, 904.5567671840882, 915.7756349694367, 955.5508910811907, 962.4562122400821, 16737.581560461087, 18214.0, 19171.616567668567, 19347.226110955406, 21156.0, 889.3107841422819, 936.7517607833793, 938.8685584018243, 950.8716323296405, 1008.7578981044496, 9050.502222377832, 10401.5839366426, 11241.381724005094, 11268.774624507463, 11296.943515282372, 586633.0, 591574.0, 598750.0, 608803.9559802173, 609164.8625270536, 110763.0, 125408.37295813645, 127207.0, 131833.0, 140318.0, 969.898160693117, 978.8287049766404, 1013.2198207380424, 1017.1811691588342, 1020.1125021231576, 19057.951812650437, 19843.503912401728, 19874.403767886986, 20035.499112522302, 20143.496412589804, 42878.49925252601, 56222.43777562336, 56378.16058627734, 58072.4192758067, 59229.40770592411, 70007.9498807508, 74594.62702686452, 76079.0, 80363.79454308073, 83756.58121709352, 11758.764824703287, 11795.764084718428, 11889.405529723306, 12060.396980151132, 12196.695082623006, 12936.676583085498, 13164.934175329063, 13452.663683407993, 13487.527936522174, 13487.865121348661, 11396.715082123013, 11561.42192890369, 11667.59163429276, 11685.824712629148, 11833.290002599872, 9376.437413755197, 10832.187585931244, 11203.0, 11486.770264594828, 11588.76822463529, 8824.867626985471, 10159.136473399843, 11460.426978651201, 11804.527818887149, 11961.880381196424, 9699.418034917928, 10839.67480975572, 11334.433278335886, 11735.295882247092, 12088.335141567299, 8757.737267881974, 9204.447733136034, 9555.426674399558, 11352.829707554229, 11751.0], "value": 9578.360205677483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.0774523667944, 1531.5558488038469, 1740.1734176266275, 1830.2404502131617, 1878.5491482044313, 7834.451588388815, 8306.750797476077, 8522.957385213082, 8772.342074344426, 8819.162179592937, 8490.193431624002, 8682.392232543725, 8686.91313086869, 8699.52152631605, 8716.041235464094, 2318.1422873536817, 2343.320437073247, 2366.479374537608, 2370.20598099636, 2374.5963186258377, 1960.255103060842, 2333.0, 2341.730700969385, 2394.904203831845, 2400.1119585753295, 2324.69778928739, 2372.6915500984846, 2383.7497062808416, 2385.844920080198, 2389.51015041916, 2329.196427232602, 2359.304005318435, 2371.5256948610177, 2375.762423757628, 2378.892949817254, 2345.2260753951155, 2345.7067866516686, 2346.307839187427, 2348.2720356689483, 2348.7651234876375, 8774.64901403943, 8841.955790221007, 8848.336374771918, 8853.513056781874, 8889.911100888972, 5106.540411362995, 5175.560077393426, 5209.583233341362, 5238.978399212155, 5243.8164664236565, 3445.13871532117, 3555.839987200582, 3584.982075089608, 3612.6567976042234, 3645.453182022691, 1010.6210171185805, 1050.1388861133873, 1059.2479339668844, 1066.221658189526, 1071.1056268016216, 11341.943290283578, 11495.597654082067, 11575.421228938603, 11582.710432239177, 11606.303621782636, 4327.415798867176, 4467.754273514923, 4659.301104834302, 4737.620990320766, 4764.213904705754, 9869.259805514615, 9877.456739879231, 9888.0, 9892.55483503244, 9953.900460995297, 5193.5585475234275, 5211.114110601206, 5220.9738951305, 5227.973860130675, 5248.107821670249, 4331.112122014979, 4681.859544213679, 4791.952080479151, 4815.085133824562, 4832.106060378841, 3442.915481623281, 3777.112378591029, 3815.37046387343, 3956.911849241424, 3976.264391087658, 1278.5844600504872, 1284.1845428153003, 1285.3252042677668, 1293.1917551530294, 1298.6818229533635, 813.772143799737, 838.6435764800058, 884.9646014159362, 885.274075258282, 899.1143723432414, 5708.942910570841, 5790.276215473066, 5949.434803693643, 6003.429674181033, 6119.296280927661, 426.7866066966517, 434.4807954494412, 439.387055058192, 444.1428043875287, 445.80607435765546, 3972.56301806801, 3989.2221016901426, 4060.7969601520394, 4094.344904815215, 4104.8152833121985, 10336.121429678562, 10520.368777873353, 10656.840147397796, 10668.94665526683, 10677.252592318464, 10169.898301017043, 10612.310199836986, 10631.096356809603, 10653.733656658645, 10731.678049658523, 6482.935170648328, 6887.863502522027, 8099.352051835956, 8152.144024877421, 8229.218224268685, 5002.87492812668, 5377.247185394126, 5887.676177810262, 6106.084087386927, 6165.876682466415, 9782.80434391294, 9909.900900990899, 9969.252306077218, 10003.449810260505, 10006.949965250127, 7969.8406031880195, 9814.509274536102, 9880.654177103766, 10007.699769006942, 10105.141063009727, 6820.31796820314, 7250.347468727839, 7344.70621175147, 7447.329740323397, 7526.962365188139, 8320.12638672955, 8328.791780205544, 8334.958325208578, 8352.665893364197, 8368.037675667376, 6994.475414343843, 7294.416446684359, 7389.741359052622, 7432.442566807619, 7475.401967842451, 7280.781576552712, 7294.197638259893, 7302.634868256672, 7355.411567074728, 7397.186309506058, 6897.7585784497305, 6931.826704332432, 6937.202221744564, 6991.720331186695, 7020.122484689414, 4609.884752881205, 4673.813047478063, 5059.316992206005, 5066.986602679405, 5135.845924622267, 4735.479097299225, 4776.116418462596, 4860.0, 5005.924911126263, 5067.0], "value": 4447.241452655257, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [231.80296747764402, 268.8910991048625, 270.4725784719796, 309.8559169985956, 317.17059888391833, 5072.4166720827025, 5241.816536421226, 5624.212610234566, 5703.686297253655, 5713.885932166969, 5557.110862262039, 5562.221289019531, 5579.38626751057, 5602.7758889644465, 5605.7197140142935, 4000.359942409222, 4087.7751723655188, 4155.833766649331, 4206.074663574024, 4209.0, 3268.18615668304, 3570.6250843661433, 3598.208394153282, 3613.6567026132607, 4126.31915733905, 3303.702666759991, 3434.1071321456475, 3725.590185079639, 4179.955011247188, 4244.87265382039, 4049.088954985134, 4143.1713657268665, 4155.542890282067, 4193.916121677565, 4201.579842015789, 3310.9239497163517, 3432.433648448003, 3584.390653588896, 3597.820108994566, 3605.6574625410544, 4719.622430205575, 5042.0, 5067.949320506785, 5291.682499050069, 5447.45525447456, 4652.255169450041, 4812.37439132914, 4818.180909245437, 4848.345473361122, 4859.975700121512, 4797.968436786073, 5577.832665020056, 5800.7679692812235, 5834.387389324144, 5903.763849446017, 3406.659334066598, 3973.960260397388, 3998.6401223889698, 4004.198110850129, 4011.498562679665, 4784.234522476387, 5893.292804863444, 6193.721282542297, 6240.687965601747, 6253.749850005995, 4043.9890027493125, 4052.756834589934, 4057.2899742544937, 4061.7766022869027, 4082.5509193988637, 4139.730917490354, 4141.3020661529235, 4147.543770185277, 4152.730072545275, 4168.541460439349, 4271.508776490681, 4622.930656040162, 4755.904881902343, 4814.542618451242, 4828.2998965150555, 4780.49804770501, 5609.6353737007785, 5874.412558744091, 5889.087191485327, 5922.911156332659, 1134.4781400555837, 1157.560127151677, 1343.810727506164, 1385.1342910680823, 1412.1244828206577, 742.265157494077, 861.5476874640739, 866.6620018192909, 876.8860048193694, 884.6417201033463, 4261.232978063978, 4407.559244075567, 4890.535399137077, 4991.226359914219, 5296.841094767163, 5304.549113325334, 6132.7546898124465, 6147.385261473817, 6157.322694503601, 6186.267845003406, 5171.340494723603, 5305.920411193835, 5443.230949941285, 5476.123820188751, 5522.92303000919, 2499.7500249974855, 2547.592385218356, 2847.5443928971267, 2974.895878644237, 3092.4433601951864, 5617.129344951539, 5749.597528173072, 5990.221271234712, 6371.299157092716, 6375.74497020114, 5458.553483326921, 5983.401659834069, 6220.626762394271, 6345.555811093179, 6449.290578036413, 5123.820666276662, 5329.147336426231, 5550.944490555043, 6034.668093254825, 6155.907661384993, 5517.282753242052, 5857.853553661193, 5925.851853703692, 6166.784162554289, 6259.405356491126, 6087.66517841523, 6089.056196289582, 6116.418940200674, 6144.863200307957, 6207.503399728102, 6209.503239740719, 6424.164858568356, 6427.967860160857, 6441.871162576628, 6447.614382678439, 3565.9286814264087, 3759.699224062123, 3793.0517370657335, 3879.7866117363815, 3975.8271309964207, 5460.7542660579575, 5533.335999679904, 5599.832005039855, 6224.661697735009, 6376.713047912948, 5172.586193104467, 5216.869578260574, 5227.555657769132, 5699.943000570107, 5983.995361553928, 5877.706114694333, 5937.198478205387, 5962.70186490665, 5982.192404025575, 6057.878842423215, 5796.246487956539, 5825.70871456417, 5832.708364581838, 5854.941450585439, 5869.236999190078, 5544.889102217852, 5561.833145005657, 5681.545476361964, 5894.557908156819, 5949.583529152917, 4991.825286114969, 5094.745262736922, 5359.839204823861, 5824.204381896629, 5867.9413205867395], "value": 4205.484161619819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.196553325576, 692.9052097685657, 693.2859155070277, 696.3906581740977, 753.4624935925829, 16975.745363819537, 17298.221580028898, 17715.37996170133, 17747.73378399322, 17768.91115544422, 16118.83881161188, 16271.0, 16310.184490775473, 16640.334386624552, 16695.74956375655, 551.9641223320491, 713.5932518464477, 831.1356189562847, 860.6901515454431, 890.9376343655947, 729.4055344893922, 769.2000319667567, 807.5760225881401, 877.8727084572733, 880.5157163560049, 788.9053313602376, 873.9912600873973, 897.161154320709, 918.6233644205877, 919.2645883293372, 913.7989642278689, 922.617113897735, 922.861570764384, 923.6997975657904, 924.875141855851, 664.8769977554168, 666.8366250268667, 684.8390628202368, 687.8521117959613, 689.4725534965755, 15189.392424303014, 15319.004264722756, 15436.3825446982, 15450.227488625524, 15459.0, 11513.5970241042, 14787.33456994427, 14830.0, 14833.70332593353, 14964.925175374163, 11927.165098443113, 12027.27836329823, 12115.273083615011, 12116.878831211663, 12133.817992730115, 3849.095462566295, 3864.613538646141, 3890.610938906115, 3909.8240579174008, 4029.9194016119804, 91464.54267728618, 125872.0, 126546.0, 130041.0, 131765.3411732935, 10730.570777168827, 11000.119990400908, 11425.257358271685, 11438.542458301741, 11516.481758320895, 19406.70889936652, 23012.309630711105, 23865.045398183876, 23867.94244978358, 23947.880260598584, 8052.718154864551, 8112.22933821286, 8150.38872084596, 8164.6325915333955, 8423.536705481258, 4360.4767427908855, 4380.846670366585, 4455.353973673799, 4523.25366314561, 4526.88682782933, 3615.1865830188, 3720.4233343831747, 3744.831482583236, 3745.9438108428394, 3783.281176576442, 667.5060455263167, 678.372505432473, 694.198201077756, 697.7557854750796, 699.5732603112098, 517.7385420362692, 526.6445149524056, 592.6384905207819, 626.4362074133226, 655.7409823119841, 8977.685780997634, 9207.125323094295, 9277.721668349961, 9283.39657922233, 9339.626414943326, 524.5803357314134, 588.185363271863, 641.3746597067915, 672.9360710732473, 674.2111729276758, 3418.9487157692656, 4197.433346498245, 4413.44831896013, 4553.385292985405, 4696.624270058387, 107395.46302268439, 150780.0, 152397.0, 152873.0, 155795.0, 100110.0, 107730.46134769276, 132572.33713831563, 133661.33169334286, 134046.0, 80964.59517702374, 113479.0, 114693.0, 114917.0, 116094.8390516084, 9054.637814487347, 9208.539573021188, 9495.28785341116, 9582.472963987047, 9822.214222862296, 56712.0, 60186.49533761691, 60445.0, 61226.387736122066, 64224.67887660532, 88922.55538722264, 90927.0, 91592.0, 91794.0, 92215.0, 12902.61301659196, 12948.09363344557, 13045.478180873039, 13078.149920255153, 13548.932255338661, 14551.41794328215, 14624.634384140481, 14810.536849599415, 14913.478028269392, 15173.0, 13344.866551334362, 13720.245386503439, 14235.288235588387, 14263.928680356532, 14270.0, 11280.605178818701, 13319.0, 13490.055696101179, 13616.523421680193, 13647.181169129486, 11190.440477976232, 13115.868841311465, 13805.585832425044, 14000.159990400609, 14137.36381862798, 10915.052160953801, 11188.440577971232, 11319.490622921823, 11420.200585958903, 11757.941210293893, 8737.781555461164, 10188.745281368025, 10649.733756656145, 11508.82736758966, 11694.0], "value": 7846.701171192933, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1650.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 115.0, 115.0, 131.0, 174.0, 95.0, 169.0, 173.0, 191.0], "value": 138.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 147.0, 147.0, 160.0, 108.0, 129.0, 132.0, 136.0, 194.0, 142.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 256.0, 283.0, 202.0, 192.0, 195.0, 196.0, 196.0, 193.0, 197.0], "value": 210.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 74.0, 143.0, 59.0, 61.0, 61.0, 66.0, 132.0, 66.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 126.0, 81.0, 72.0, 77.0, 108.0, 68.0, 71.0, 108.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 132.0, 126.0, 85.0, 91.0, 85.0, 90.0, 85.0, 99.0, 131.0], "value": 102.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 122.0, 170.0, 107.0, 98.0, 98.0, 164.0, 98.0, 127.0, 176.0], "value": 125.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 89.0, 90.0, 97.0, 89.0, 92.0, 94.0, 92.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 69.0, 91.0, 91.0, 90.0, 90.0, 58.0, 57.0, 59.0, 58.0], "value": 71.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 73.0, 71.0, 72.0, 77.0, 76.0, 70.0, 70.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 92.0, 100.0, 100.0, 86.0, 88.0, 85.0, 104.0, 114.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 158.0, 146.0, 140.0, 142.0, 143.0, 166.0, 204.0, 139.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 249.0, 250.0, 168.0, 252.0, 247.0, 223.0, 176.0, 173.0, 172.0], "value": 208.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 65.0, 72.0, 69.0, 67.0, 70.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 03:56:40 INFO - Return code: 0 03:56:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:40 ERROR - # TBPL SUCCESS # 03:56:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:56:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:56:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:56:40 INFO - 2016-08-28 03:56:40.706 screenresolution[1780:23823] starting screenresolution argv=screenresolution get 03:56:40 INFO - 2016-08-28 03:56:40.708 screenresolution[1780:23823] Display 0: 1600x1200x32@60 03:56:40 INFO - 2016-08-28 03:56:40.714 screenresolution[1781:23827] starting screenresolution argv=screenresolution list 03:56:40 INFO - Available Modes on Display 0 03:56:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:56:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:56:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:56:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:56:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:56:40 INFO - Intel Iris: 03:56:40 INFO - Chipset Model: Intel Iris 03:56:40 INFO - Type: GPU 03:56:40 INFO - Bus: Built-In 03:56:40 INFO - VRAM (Dynamic, Max): 1536 MB 03:56:40 INFO - Vendor: Intel (0x8086) 03:56:40 INFO - Device ID: 0x0a2e 03:56:40 INFO - Revision ID: 0x0009 03:56:40 INFO - Displays: 03:56:40 INFO - Display: 03:56:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:56:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:56:40 INFO - Display Serial Number: 1600x1200 60 03:56:40 INFO - Main Display: Yes 03:56:40 INFO - Mirror: Off 03:56:40 INFO - Online: Yes 03:56:40 INFO - Rotation: Supported 03:56:40 INFO - Return code: 0 03:56:40 INFO - Running post-action listener: _resource_record_post_action 03:56:40 INFO - [mozharness: 2016-08-28 10:56:40.948683Z] Finished run-tests step (success) 03:56:40 INFO - Running post-run listener: _resource_record_post_run 03:56:41 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32902144; Write bytes: 708479488; Read time: 363; Write time: 1858 03:56:41 INFO - TinderboxPrint: CPU usage
54.2% 03:56:41 INFO - TinderboxPrint: I/O read bytes / time
32,902,144 / 363 03:56:41 INFO - TinderboxPrint: I/O write bytes / time
708,479,488 / 1,858 03:56:41 INFO - TinderboxPrint: CPU idle
2,218.1 (45.8%) 03:56:41 INFO - TinderboxPrint: CPU system
980.0 (20.2%) 03:56:41 INFO - TinderboxPrint: CPU user
1,643.6 (33.9%) 03:56:41 INFO - TinderboxPrint: Swap in / out
434,831,360 / 0 03:56:41 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396685824; Write bytes: 390608384; Read time: 29440; Write time: 680 03:56:41 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31017984; Write bytes: 299205632; Read time: 342; Write time: 1141 03:56:41 INFO - Running post-run listener: _upload_blobber_files 03:56:41 INFO - Blob upload gear active. 03:56:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:41 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 03:56:41 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'] 03:56:41 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 03:56:41 INFO - Traceback (most recent call last): 03:56:41 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 03:56:41 INFO - main() 03:56:41 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 03:56:41 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 03:56:41 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 03:56:41 INFO - return set(response.json().get('whitelist', [])) 03:56:41 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 03:56:41 INFO - return json.loads(self.text or self.content, **kwargs) 03:56:41 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 03:56:41 INFO - return _default_decoder.decode(s) 03:56:41 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 03:56:41 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 03:56:41 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 03:56:41 INFO - raise ValueError("No JSON object could be decoded") 03:56:41 INFO - ValueError: No JSON object could be decoded 03:56:41 ERROR - Return code: 1 03:56:41 INFO - Setting buildbot property blobber_files to {} 03:56:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:41 INFO - Contents: 03:56:41 INFO - blobber_files:{} 03:56:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:41 INFO - Copying logs to upload dir... 03:56:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.436081 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-28 03:56:41.916381) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-08-28 03:56:41.920357) ========= 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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/fPR4ZYQcRaG19UpRQWLg1g/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 4.98 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-08-28 03:56:46.909541) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-08-28 03:56:46.909858) ========= 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.WW6JvGIDpo/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.tG8sMCe7Hc/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005185 ========= master_lag: 13.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 13 secs) (at 2016-08-28 03:57:00.061680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 03:57:00.064673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 03:57:00.123843) ========= ========= Total master_lag: 18.24 =========