builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1471880090.37 results: success (0) buildid: 20160822064115 builduid: 2c3858c2ad4a4d32bfc521ec00bd8e20 revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.375456) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.376179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.376552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.404100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.404557) ========= 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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-22 08:34:50-- 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% 18.6M=0.001s 2016-08-22 08:34:50 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.519457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.519786) ========= 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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.029317 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.569941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:50.570300) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --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 194fe275b4e60ded2af6b25173eec421f0dba8ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-22 08:34:50,644 truncating revision to first 12 chars 2016-08-22 08:34:50,644 Setting DEBUG logging. 2016-08-22 08:34:50,645 attempt 1/10 2016-08-22 08:34:50,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:34:51,357 unpacking tar archive at: mozilla-central-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974752 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:51.569507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:51.570085) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:51.570883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:51.571408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:34:51.592645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-22 08:34:51.593254) ========= /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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:34:51 INFO - MultiFileLogger online at 20160822 08:34:51 in /builds/slave/test 08:34:51 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 08:34:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:51 INFO - {'append_to_log': False, 08:34:51 INFO - 'base_work_dir': '/builds/slave/test', 08:34:51 INFO - 'blob_upload_branch': 'Firefox', 08:34:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:51 INFO - 'branch': 'Firefox', 08:34:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:51 INFO - 'config_files': ('talos/mac_config.py',), 08:34:51 INFO - 'default_actions': ('clobber', 08:34:51 INFO - 'read-buildbot-config', 08:34:51 INFO - 'download-and-extract', 08:34:51 INFO - 'populate-webroot', 08:34:51 INFO - 'create-virtualenv', 08:34:51 INFO - 'install', 08:34:51 INFO - 'run-tests'), 08:34:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:51 INFO - 'download_minidump_stackwalk': True, 08:34:51 INFO - 'download_symbols': 'ondemand', 08:34:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:51 INFO - 'installer_path': 'installer.exe', 08:34:51 INFO - 'log_level': 'info', 08:34:51 INFO - 'log_name': 'talos', 08:34:51 INFO - 'log_to_console': True, 08:34:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:34:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:34:51 INFO - 'opt_config_files': (), 08:34:51 INFO - 'pip_index': False, 08:34:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:51 INFO - 'cmd': ('bash', 08:34:51 INFO - '-c', 08:34:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:51 INFO - 'enabled': True, 08:34:51 INFO - 'halt_on_failure': False, 08:34:51 INFO - 'name': 'check_screen_resolution'},), 08:34:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:51 INFO - 'cmd': ('bash', 08:34:51 INFO - '-c', 08:34:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:51 INFO - 'enabled': True, 08:34:51 INFO - 'halt_on_failure': False, 08:34:51 INFO - 'name': 'check_screen_resolution'},), 08:34:51 INFO - 'run_cmd_checks_enabled': True, 08:34:51 INFO - 'sps_profile': False, 08:34:51 INFO - 'sps_profile_interval': 0, 08:34:51 INFO - 'suite': 'dromaeojs-e10s', 08:34:51 INFO - 'system_bits': '32', 08:34:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:51 INFO - 'title': 't-yosemite-r7-0037', 08:34:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:51 INFO - 'use_talos_json': True, 08:34:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:51 INFO - 'work_dir': 'build'} 08:34:51 INFO - [mozharness: 2016-08-22 15:34:51.808232Z] Running clobber step. 08:34:51 INFO - Running pre-action listener: _resource_record_pre_action 08:34:51 INFO - Running main action method: clobber 08:34:51 INFO - rmtree: /builds/slave/test/build 08:34:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:54 INFO - Running post-action listener: _resource_record_post_action 08:34:54 INFO - [mozharness: 2016-08-22 15:34:54.139668Z] Finished clobber step (success) 08:34:54 INFO - [mozharness: 2016-08-22 15:34:54.139861Z] Running read-buildbot-config step. 08:34:54 INFO - Running pre-action listener: _resource_record_pre_action 08:34:54 INFO - Running main action method: read_buildbot_config 08:34:54 INFO - Using buildbot properties: 08:34:54 INFO - { 08:34:54 INFO - "project": "", 08:34:54 INFO - "product": "firefox", 08:34:54 INFO - "script_repo_revision": "production", 08:34:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:34:54 INFO - "repository": "", 08:34:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:34:54 INFO - "buildid": "20160822064115", 08:34:54 INFO - "pgo_build": "False", 08:34:54 INFO - "basedir": "/builds/slave/test", 08:34:54 INFO - "buildnumber": 36, 08:34:54 INFO - "slavename": "t-yosemite-r7-0037", 08:34:54 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:34:54 INFO - "platform": "yosemite_r7", 08:34:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:34:54 INFO - "branch": "mozilla-central", 08:34:54 INFO - "repo_path": "mozilla-central", 08:34:54 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 08:34:54 INFO - "stage_platform": "macosx64", 08:34:54 INFO - "builduid": "2c3858c2ad4a4d32bfc521ec00bd8e20", 08:34:54 INFO - "slavebuilddir": "test" 08:34:54 INFO - } 08:34:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:34:54 INFO - Running post-action listener: _resource_record_post_action 08:34:54 INFO - [mozharness: 2016-08-22 15:34:54.143349Z] Finished read-buildbot-config step (success) 08:34:54 INFO - [mozharness: 2016-08-22 15:34:54.143442Z] Running download-and-extract step. 08:34:54 INFO - Running pre-action listener: _resource_record_pre_action 08:34:54 INFO - Running main action method: download_and_extract 08:34:54 INFO - mkdir: /builds/slave/test/build/tests 08:34: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')]} 08:34:54 INFO - trying https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:34:55 INFO - Downloaded 1199 bytes. 08:34:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:34:55 INFO - Using the following test package requirements: 08:34:55 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:34:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:34:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:34:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'jsshell-mac.zip'], 08:34:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:34:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:34:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:34:55 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:34:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:34:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:34:55 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:34:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:55 INFO - trying https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:34:56 INFO - Downloaded 16352318 bytes. 08:34:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:35:03 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 08:35:03 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')]} 08:35:03 INFO - trying https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:35:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:35:04 INFO - Downloaded 16352318 bytes. 08:35:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:11 INFO - trying https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:35:12 INFO - Downloaded 14413981 bytes. 08:35:12 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:35:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:13 INFO - trying https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:35:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/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 08:35:16 INFO - Downloaded 111516666 bytes. 08:35:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:35:16 INFO - mkdir: /builds/slave/test/properties 08:35:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:16 INFO - Contents: 08:35:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:35:17 INFO - Running post-action listener: _resource_record_post_action 08:35:17 INFO - Running post-action listener: set_extra_try_arguments 08:35:17 INFO - [mozharness: 2016-08-22 15:35:17.644523Z] Finished download-and-extract step (success) 08:35:17 INFO - [mozharness: 2016-08-22 15:35:17.644659Z] Running populate-webroot step. 08:35:17 INFO - Running pre-action listener: _resource_record_pre_action 08:35:17 INFO - Running main action method: populate_webroot 08:35:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:17 INFO - '--tppagecycles', 08:35:17 INFO - '7'], 08:35:17 INFO - 'tests': ['tsvgm']}}, 08:35:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['damp', 'tps']}, 08:35:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'tests': ['damp', 'tps']}, 08:35:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['dromaeo_dom']}, 08:35:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['basic_compositor_video']}, 08:35:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:35:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['a11yr', 08:35:17 INFO - 'ts_paint', 08:35:17 INFO - 'tpaint', 08:35:17 INFO - 'sessionrestore', 08:35:17 INFO - 'sessionrestore_no_auto_restore', 08:35:17 INFO - 'tabpaint']}, 08:35:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['tsvgx', 08:35:17 INFO - 'tsvgr_opacity', 08:35:17 INFO - 'tart', 08:35:17 INFO - 'tscrollx', 08:35:17 INFO - 'cart']}, 08:35:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:17 INFO - 'tsvgr_opacity', 08:35:17 INFO - 'tart', 08:35:17 INFO - 'tscrollx', 08:35:17 INFO - 'cart']}, 08:35:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'talos_options': ['--disable-e10s'], 08:35:17 INFO - 'tests': ['tp5o']}, 08:35:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'tests': ['tp5o']}, 08:35:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'talos_options': ['--disable-e10s', 08:35:17 INFO - '--xperf_path', 08:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:17 INFO - 'tests': ['tp5n']}, 08:35:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:35:17 INFO - 'talos_options': ['--xperf_path', 08:35:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:17 INFO - 'tests': ['tp5n']}}, 08:35:17 INFO - 'talos.zip': {'path': '', 08:35:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:17 INFO - Running post-action listener: _resource_record_post_action 08:35:17 INFO - [mozharness: 2016-08-22 15:35:17.663174Z] Finished populate-webroot step (success) 08:35:17 INFO - [mozharness: 2016-08-22 15:35:17.663284Z] Running create-virtualenv step. 08:35:17 INFO - Running pre-action listener: _resource_record_pre_action 08:35:17 INFO - Running main action method: create_virtualenv 08:35:17 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:17 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 08:35:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:17 INFO - Using real prefix '/tools/python27' 08:35:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:18 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:21 INFO - Installing pip.................done. 08:35:21 INFO - Return code: 0 08:35:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:21 INFO - 'HOME': '/Users/cltbld', 08:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:21 INFO - 'LOGNAME': 'cltbld', 08:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:21 INFO - 'MOZ_NO_REMOTE': '1', 08:35:21 INFO - 'NO_EM_RESTART': '1', 08:35:21 INFO - 'PAGER': '/bin/cat', 08:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:21 INFO - 'PWD': '/builds/slave/test', 08:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:21 INFO - 'SHELL': '/bin/bash', 08:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:21 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:21 INFO - 'USER': 'cltbld', 08:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:21 INFO - 'XPC_FLAGS': '0x0', 08:35:21 INFO - 'XPC_SERVICE_NAME': '0', 08:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:21 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 08:35:21 INFO - Cleaning up... 08:35:21 INFO - Return code: 0 08:35:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:35:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:21 INFO - 'HOME': '/Users/cltbld', 08:35:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:21 INFO - 'LOGNAME': 'cltbld', 08:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:21 INFO - 'MOZ_NO_REMOTE': '1', 08:35:21 INFO - 'NO_EM_RESTART': '1', 08:35:21 INFO - 'PAGER': '/bin/cat', 08:35:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:21 INFO - 'PWD': '/builds/slave/test', 08:35:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:21 INFO - 'SHELL': '/bin/bash', 08:35:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:21 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:21 INFO - 'USER': 'cltbld', 08:35:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:21 INFO - 'XPC_FLAGS': '0x0', 08:35:21 INFO - 'XPC_SERVICE_NAME': '0', 08:35:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:22 INFO - Downloading/unpacking psutil>=3.1.1 08:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:25 INFO - Installing collected packages: psutil 08:35:25 INFO - Running setup.py install for psutil 08:35:25 INFO - building 'psutil._psutil_osx' extension 08:35:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:35:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:35:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:35:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:35:26 INFO - building 'psutil._psutil_posix' extension 08:35:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:35:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:35:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:35:26 INFO - ^ 08:35:26 INFO - 1 warning generated. 08:35:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:35:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:26 INFO - Successfully installed psutil 08:35:26 INFO - Cleaning up... 08:35:26 INFO - Return code: 0 08:35:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:26 INFO - 'HOME': '/Users/cltbld', 08:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:26 INFO - 'LOGNAME': 'cltbld', 08:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:26 INFO - 'MOZ_NO_REMOTE': '1', 08:35:26 INFO - 'NO_EM_RESTART': '1', 08:35:26 INFO - 'PAGER': '/bin/cat', 08:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:26 INFO - 'PWD': '/builds/slave/test', 08:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:26 INFO - 'SHELL': '/bin/bash', 08:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:26 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:26 INFO - 'USER': 'cltbld', 08:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:26 INFO - 'XPC_FLAGS': '0x0', 08:35:26 INFO - 'XPC_SERVICE_NAME': '0', 08:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:35:29 INFO - Installing collected packages: mozsystemmonitor 08:35:29 INFO - Running setup.py install for mozsystemmonitor 08:35:29 INFO - Successfully installed mozsystemmonitor 08:35:29 INFO - Cleaning up... 08:35:29 INFO - Return code: 0 08:35:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:29 INFO - 'HOME': '/Users/cltbld', 08:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:29 INFO - 'LOGNAME': 'cltbld', 08:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:29 INFO - 'MOZ_NO_REMOTE': '1', 08:35:29 INFO - 'NO_EM_RESTART': '1', 08:35:29 INFO - 'PAGER': '/bin/cat', 08:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:29 INFO - 'PWD': '/builds/slave/test', 08:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:29 INFO - 'SHELL': '/bin/bash', 08:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:29 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:29 INFO - 'USER': 'cltbld', 08:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:29 INFO - 'XPC_FLAGS': '0x0', 08:35:29 INFO - 'XPC_SERVICE_NAME': '0', 08:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:35:29 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 08:35:29 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 08:35:29 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 08:35:29 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 08:35:29 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 08:35:29 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 08:35:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:32 INFO - warning: no files found matching '*.txt' 08:35:32 INFO - no previously-included directories found matching 'build' 08:35:32 INFO - no previously-included directories found matching 'dist' 08:35:32 INFO - no previously-included directories found matching '.git*' 08:35:32 INFO - Installing collected packages: jsonschema, functools32 08:35:32 INFO - Running setup.py install for functools32 08:35:33 INFO - warning: no files found matching '*.txt' 08:35:33 INFO - no previously-included directories found matching 'build' 08:35:33 INFO - no previously-included directories found matching 'dist' 08:35:33 INFO - no previously-included directories found matching '.git*' 08:35:33 INFO - Successfully installed jsonschema functools32 08:35:33 INFO - Cleaning up... 08:35:33 INFO - Return code: 0 08:35:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:33 INFO - 'HOME': '/Users/cltbld', 08:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:33 INFO - 'LOGNAME': 'cltbld', 08:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:33 INFO - 'MOZ_NO_REMOTE': '1', 08:35:33 INFO - 'NO_EM_RESTART': '1', 08:35:33 INFO - 'PAGER': '/bin/cat', 08:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:33 INFO - 'PWD': '/builds/slave/test', 08:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:33 INFO - 'SHELL': '/bin/bash', 08:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:33 INFO - 'USER': 'cltbld', 08:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:33 INFO - 'XPC_FLAGS': '0x0', 08:35:33 INFO - 'XPC_SERVICE_NAME': '0', 08:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:35:33 INFO - Cleaning up... 08:35:33 INFO - Return code: 0 08:35:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:33 INFO - 'HOME': '/Users/cltbld', 08:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:33 INFO - 'LOGNAME': 'cltbld', 08:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:33 INFO - 'MOZ_NO_REMOTE': '1', 08:35:33 INFO - 'NO_EM_RESTART': '1', 08:35:33 INFO - 'PAGER': '/bin/cat', 08:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:33 INFO - 'PWD': '/builds/slave/test', 08:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:33 INFO - 'SHELL': '/bin/bash', 08:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:33 INFO - 'USER': 'cltbld', 08:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:33 INFO - 'XPC_FLAGS': '0x0', 08:35:33 INFO - 'XPC_SERVICE_NAME': '0', 08:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:37 INFO - Downloading docopt-0.6.1.tar.gz 08:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:37 INFO - Running setup.py install for blobuploader 08:35:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:37 INFO - Running setup.py install for requests 08:35:38 INFO - Running setup.py install for docopt 08:35:38 INFO - Successfully installed blobuploader requests docopt 08:35:38 INFO - Cleaning up... 08:35:38 INFO - Return code: 0 08:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:38 INFO - 'HOME': '/Users/cltbld', 08:35:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:38 INFO - 'LOGNAME': 'cltbld', 08:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:38 INFO - 'MOZ_NO_REMOTE': '1', 08:35:38 INFO - 'NO_EM_RESTART': '1', 08:35:38 INFO - 'PAGER': '/bin/cat', 08:35:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:38 INFO - 'PWD': '/builds/slave/test', 08:35:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:38 INFO - 'SHELL': '/bin/bash', 08:35:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:38 INFO - 'USER': 'cltbld', 08:35:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:38 INFO - 'XPC_FLAGS': '0x0', 08:35:38 INFO - 'XPC_SERVICE_NAME': '0', 08:35:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Khr8Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-C9Zbz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-eEtGDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-exMaL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jlOmKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-c6Vvae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-x0_Hx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-nKchPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-VaqLGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-KnihnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-I6bBy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Vv_r1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RqqkIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-v7YVdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-uwIOiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-a8eYsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:40 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-2To9F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:40 INFO - Running setup.py install for manifestparser 08:35:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Running setup.py install for mozcrash 08:35:40 INFO - Running setup.py install for mozdebug 08:35:40 INFO - Running setup.py install for mozdevice 08:35:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozfile 08:35:41 INFO - Running setup.py install for mozhttpd 08:35:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozinfo 08:35:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozInstall 08:35:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozleak 08:35:41 INFO - Running setup.py install for mozlog 08:35:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for moznetwork 08:35:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Running setup.py install for mozprocess 08:35:42 INFO - Running setup.py install for mozprofile 08:35:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Running setup.py install for mozrunner 08:35:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Running setup.py install for mozscreenshot 08:35:42 INFO - Running setup.py install for moztest 08:35:42 INFO - Running setup.py install for mozversion 08:35:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:43 INFO - Cleaning up... 08:35:43 INFO - Return code: 0 08:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:43 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 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:43 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 08:35:43 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 08:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:43 INFO - 'HOME': '/Users/cltbld', 08:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:43 INFO - 'LOGNAME': 'cltbld', 08:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:43 INFO - 'MOZ_NO_REMOTE': '1', 08:35:43 INFO - 'NO_EM_RESTART': '1', 08:35:43 INFO - 'PAGER': '/bin/cat', 08:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:43 INFO - 'PWD': '/builds/slave/test', 08:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:43 INFO - 'SHELL': '/bin/bash', 08:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:43 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:43 INFO - 'USER': 'cltbld', 08:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:43 INFO - 'XPC_FLAGS': '0x0', 08:35:43 INFO - 'XPC_SERVICE_NAME': '0', 08:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qFz5gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-YdiuSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dxnoby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tPahXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jRJLKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-H9YnRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:43 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-3r1nhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:44 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)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-eMyePn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-QBuCuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-zbj0Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-o0LJ6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-vsZUJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-I9kUsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rFCtbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZH6GzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:44 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-SeT9Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:45 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)) 08:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:45 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-biafad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:47 INFO - Downloading blessings-1.6.tar.gz 08:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:47 INFO - Installing collected packages: blessings 08:35:47 INFO - Running setup.py install for blessings 08:35:47 INFO - Successfully installed blessings 08:35:47 INFO - Cleaning up... 08:35:47 INFO - Return code: 0 08:35:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:48 INFO - Reading from file tmpfile_stdout 08:35:48 INFO - Current package versions: 08:35:48 INFO - blessings == 1.6 08:35:48 INFO - blobuploader == 1.2.4 08:35:48 INFO - docopt == 0.6.1 08:35:48 INFO - functools32 == 3.2.3-2 08:35:48 INFO - jsonschema == 2.5.1 08:35:48 INFO - manifestparser == 1.1 08:35:48 INFO - mozInstall == 1.12 08:35:48 INFO - mozcrash == 0.17 08:35:48 INFO - mozdebug == 0.1 08:35:48 INFO - mozdevice == 0.48 08:35:48 INFO - mozfile == 1.2 08:35:48 INFO - mozhttpd == 0.7 08:35:48 INFO - mozinfo == 0.9 08:35:48 INFO - mozleak == 0.1 08:35:48 INFO - mozlog == 3.3 08:35:48 INFO - moznetwork == 0.27 08:35:48 INFO - mozprocess == 0.23 08:35:48 INFO - mozprofile == 0.28 08:35:48 INFO - mozrunner == 6.12 08:35:48 INFO - mozscreenshot == 0.1 08:35:48 INFO - mozsystemmonitor == 0.3 08:35:48 INFO - moztest == 0.7 08:35:48 INFO - mozversion == 1.4 08:35:48 INFO - psutil == 3.1.1 08:35:48 INFO - requests == 1.2.3 08:35:48 INFO - wsgiref == 0.1.2 08:35:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:48 INFO - 'HOME': '/Users/cltbld', 08:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:48 INFO - 'LOGNAME': 'cltbld', 08:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:48 INFO - 'MOZ_NO_REMOTE': '1', 08:35:48 INFO - 'NO_EM_RESTART': '1', 08:35:48 INFO - 'PAGER': '/bin/cat', 08:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:48 INFO - 'PWD': '/builds/slave/test', 08:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:48 INFO - 'SHELL': '/bin/bash', 08:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:48 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:48 INFO - 'USER': 'cltbld', 08:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:48 INFO - 'XPC_FLAGS': '0x0', 08:35:48 INFO - 'XPC_SERVICE_NAME': '0', 08:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:48 INFO - Cleaning up... 08:35:48 INFO - Return code: 0 08:35:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:48 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 0x107ef9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f8e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3bbda0980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, '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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 08:35:48 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 08:35:48 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 08:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:48 INFO - 'HOME': '/Users/cltbld', 08:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:48 INFO - 'LOGNAME': 'cltbld', 08:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:48 INFO - 'MOZ_NO_REMOTE': '1', 08:35:48 INFO - 'NO_EM_RESTART': '1', 08:35:48 INFO - 'PAGER': '/bin/cat', 08:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:48 INFO - 'PWD': '/builds/slave/test', 08:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:48 INFO - 'SHELL': '/bin/bash', 08:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:35:48 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:48 INFO - 'USER': 'cltbld', 08:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:48 INFO - 'XPC_FLAGS': '0x0', 08:35:48 INFO - 'XPC_SERVICE_NAME': '0', 08:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:48 INFO - Cleaning up... 08:35:48 INFO - Return code: 0 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - Running post-action listener: _start_resource_monitoring 08:35:48 INFO - Starting resource monitoring. 08:35:48 INFO - [mozharness: 2016-08-22 15:35:48.704232Z] Finished create-virtualenv step (success) 08:35:48 INFO - [mozharness: 2016-08-22 15:35:48.705194Z] Running install step. 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: install 08:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:48 INFO - Reading from file tmpfile_stdout 08:35:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:49 INFO - Reading from file tmpfile_stdout 08:35:49 INFO - Output received: 08:35:49 INFO - Usage: mozinstall [options] installer 08:35:49 INFO - Options: 08:35:49 INFO - -h, --help show this help message and exit 08:35:49 INFO - -d DEST, --destination=DEST 08:35:49 INFO - Directory to install application into. [default: 08:35:49 INFO - "/builds/slave/test"] 08:35:49 INFO - --app=APP Application being installed. [default: firefox] 08:35:49 INFO - mkdir: /builds/slave/test/build/application 08:35:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:36:23 INFO - Reading from file tmpfile_stdout 08:36:23 INFO - Output received: 08:36:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:36:23 INFO - Running post-action listener: _resource_record_post_action 08:36:23 INFO - [mozharness: 2016-08-22 15:36:23.356053Z] Finished install step (success) 08:36:23 INFO - [mozharness: 2016-08-22 15:36:23.356154Z] Running run-tests step. 08:36:23 INFO - Running pre-action listener: _resource_record_pre_action 08:36:23 INFO - Running main action method: run_tests 08:36:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:23 INFO - 2016-08-22 08:36:23.369 screenresolution[1636:7357] starting screenresolution argv=screenresolution get 08:36:23 INFO - 2016-08-22 08:36:23.372 screenresolution[1636:7357] Display 0: 1600x1200x32@60 08:36:23 INFO - 2016-08-22 08:36:23.377 screenresolution[1637:7359] starting screenresolution argv=screenresolution list 08:36:23 INFO - Available Modes on Display 0 08:36:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:23 INFO - Intel Iris: 08:36:23 INFO - Chipset Model: Intel Iris 08:36:23 INFO - Type: GPU 08:36:23 INFO - Bus: Built-In 08:36:23 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:23 INFO - Vendor: Intel (0x8086) 08:36:23 INFO - Device ID: 0x0a2e 08:36:23 INFO - Revision ID: 0x0009 08:36:23 INFO - Displays: 08:36:23 INFO - Display: 08:36:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:23 INFO - Display Serial Number: 1600x1200 60 08:36:23 INFO - Main Display: Yes 08:36:23 INFO - Mirror: Off 08:36:23 INFO - Online: Yes 08:36:23 INFO - Rotation: Supported 08:36:23 INFO - Return code: 0 08:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:23 INFO - Python 2.7.3 08:36:23 INFO - Return code: 0 08:36:23 INFO - grabbing minidump binary from tooltool 08:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:23 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 0x107e5dd30>, '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 0x107bc2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e55b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:23 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 08:36:23 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 08:36:23 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 08:36:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:23 INFO - Return code: 0 08:36:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:36:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:36:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:23 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/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 08:36:23 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/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 08:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.n6wNc7HTPp/Render', 08:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:23 INFO - 'HOME': '/Users/cltbld', 08:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:23 INFO - 'LOGNAME': 'cltbld', 08:36:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:23 INFO - 'MOZ_NO_REMOTE': '1', 08:36:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:23 INFO - 'NO_EM_RESTART': '1', 08:36:23 INFO - 'PAGER': '/bin/cat', 08:36:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:23 INFO - 'PWD': '/builds/slave/test', 08:36:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:23 INFO - 'SHELL': '/bin/bash', 08:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PUXDZkQeVr/Listeners', 08:36:23 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 08:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:23 INFO - 'USER': 'cltbld', 08:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:23 INFO - 'XPC_FLAGS': '0x0', 08:36:23 INFO - 'XPC_SERVICE_NAME': '0', 08:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:23 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/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 08:36:23 INFO - mozversion application_buildid: 20160822064115 08:36:23 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 08:36:23 INFO - mozversion application_display_name: Nightly 08:36:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:23 INFO - mozversion application_name: Firefox 08:36:23 INFO - mozversion application_remotingname: firefox 08:36:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:36:23 INFO - mozversion application_vendor: Mozilla 08:36:23 INFO - mozversion application_version: 51.0a1 08:36:23 INFO - mozversion platform_buildid: 20160822064115 08:36:23 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 08:36:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:36:23 INFO - mozversion platform_version: 51.0a1 08:36:23 INFO - using testdate: 1471880183 08:36:23 INFO - actual date: 1471880183 08:36:23 INFO - starting webserver on 'localhost:49262' 08:36:23 INFO - SUITE-START | Running 2 tests 08:36:23 INFO - TEST-START | dromaeo_css 08:36:23 INFO - operating with platform_type : mac_ 08:36:23 INFO - Initialising browser for dromaeo_css test... 08:36:23 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpQGWnLk/profile http://localhost:49262/getInfo.html) 08:36:26 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:36:26 INFO - PROCESS | 1647 | colorDepth:24 08:36:26 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:36:26 INFO - PROCESS | 1647 | __metrics 08:36:26 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 08:36:27 INFO - TEST-INFO | 1647: exit 0 08:36:27 INFO - Browser initialized. 08:36:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:27 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpQGWnLk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:39 INFO - PROCESS | 1650 | RSS: Main: 239759360 08:36:39 INFO - PROCESS | 1650 | 08:37:29 INFO - PROCESS | 1650 | 1471880249224 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] 08:39:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 08:39:43 INFO - PROCESS | 1650 | RSS: Main: 254709760 08:39:43 INFO - PROCESS | 1650 | 08:42:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 08:42:46 INFO - PROCESS | 1650 | RSS: Main: 267923456 08:42:46 INFO - PROCESS | 1650 | 08:45:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 08:45:48 INFO - PROCESS | 1650 | RSS: Main: 272609280 08:45:48 INFO - PROCESS | 1650 | 08:48:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 08:48:51 INFO - PROCESS | 1650 | RSS: Main: 271880192 08:48:51 INFO - PROCESS | 1650 | 08:51:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 08:51:55 INFO - PROCESS | 1650 | RSS: Main: 277409792 08:51:55 INFO - PROCESS | 1650 | 08:54:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 08:54:58 INFO - PROCESS | 1650 | RSS: Main: 280358912 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | __start_tp_report 08:54:58 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:54:58 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:54:58 INFO - PROCESS | 1650 | |i|pagename|runs| 08:54:58 INFO - PROCESS | 1650 | |0;dojo.html;3415.5047518109877;3420.7434442416825;3423.452247640375;3437.553118094649;3456.3951308521005;5754.597178197528;5761.683107429089;5844.678542680156;5849.4150584941535;5859.853503662411;5566.471185237396;5754.482096611304;5822.272215973004;5907.881842363161;5920.970395148018;5241.816536421226;5322.467753224685;5330.093884039703;5401.594880383967;5423.159410291391;5424.240606315119;5443.755031023594;5446.91829622556;5459.890802183973;5462.617616766828;5113.565346945514;5199.4800519948085;5243.711595862226;5293.126634105368;5299.735013249322;5252.343457067866;5295.735213239361;5304.6286759926825;5317.654352467077;5349.973250133725;5294.205869119624;5324.627276090675;5328.360596728378;5376.623636345457;5382.1926710993275;4625.676202665781;5756.891278709491;5785.855353616151;5803.88392232153;5824.097264923944;6222.62664240147;6236.844078898019;6284.7486100555925;6303.086052522404;6306.558540902139;6268.310485846599;6281.685915704242;6286.151369565096;6293.433590976788;6305.5901366411035;5814.563907706896;5919.112133180058;5968.343482216953;5973.731182096816;6033.0347144457555;6389.744410223632;6402.071699603532;6406.615603063831;6411.647359395278;6415.550911436248;5183.97408012965;5609.523190528851;6250.281217659936;6258.937410625836;6267.4045965633195;5029.974850125799;5881.764829385791;6233.0338797486465;6234.2830574483605;6246.312905580383;5633.436656334334;6171.475424588871;6245.500359971283;6290.24517057956;6295.244570651551;5559.555235581225;5775.787084712258;6229.1590635264565;6237.812865614039;6298.559100862895;4993.875153121201;5017.448080711192;5017.8243761468175;5080.314157588678;5124.948750512522;3649.0147660131615;4461.776911154429;4551.590356867831;4563.0873825235085;4574.268117101248;4904.239842824368;5786.276715410574;5959.821205363846;5984.162217289496;5994.280686317583;6206.348333425016;6215.378462153749;6229.5327850410495;6259.843503912439;6282;5972.25346831646;6020.849478763066;6028.186194863725;6050.42520960508;6066;5623.662580245198;5624.29696287964;5625.887482250414;5649.0396632572565;5663.065594176997;6281.780137695158;6347.682615869096;6418.358164183544;6530.314316996647;6551.082848401227;6275.403836635513;6277.937220627735;6279.403456671609;6293.716782744696;6295.811125666238;5131.897362052663;6227.785581811503;6421.357864213542;6431.260405053479;6488.740450381932;6155.322914479493;6157.384261573986;6159.106929495288;6193.256809182747;6236;5204.531592156724;6251.6874156292915;6267.874642507033;6269.435750782452;6281.434670879643;6060.2424696912885;6239.937600624117;6251.156093927443;6261.5616906816085;6277.995520716663;6076.696165191811;6087.756489740361;6100.511959043177;6217.253929528486;6275.090111933835;5112.590992720648;5540.252065971043;6037.15479832815;6077.878442431038;6120.17377654011;6166.876662466636;6206.596571222856;6219.471344935731;6238.407351301619;6260.217472815898;5957.910631340446;6005.429484198994;6079.452849243589;6093.421124993119;6100.0849872519475 08:54:58 INFO - PROCESS | 1650 | |1;ext.html;464.62365483957984;492.41894564413997;513.2173435510847;538.768329618264;558.888222355529;38839.61160388399;40911;40925;41072.383914241276;41119;41682.166356672846;42399.57600423995;42565.78717106418;42601.36097958525;42716.14567708644;8933.55332233389;9657.95171024144;11994.40027998601;12322;12329.136960412774;9534.904650953471;12163.39183040849;12211.572594959178;12273.877261227408;12277.324747138948;10095.798084038315;11869.109816763734;12079.577214797484;12181.086418518602;12238.38808059598;11912;11952.223105498115;12081.879181208207;12179.512819487298;12219.694507637292;9698.321117521777;10133;11994.400279986054;12061.396930153458;12089.818652720216;32454.837725811456;33152.6684733152;39931.20137597261;39970;40218.79890600558;3056.9847150764326;3350.145712843234;3354.3962086824363;3417.2311229973056;3431.6396778338167;25821.3544661385;30713.69286307131;31325;31578.73685052595;32508.83745581257;3285.162283617686;3292.884749033772;3305.3554556861422;3375.9831200843837;3388.2376465295356;475409;475973;476668;480035;480549;61191.69404152951;61641.691791540754;61798;61859.07211391833;61979.38020619736;64062;64892.675536622955;65028.34971650223;65135;65168;14944.775828362583;16225.51323460298;16390.590235243977;16825.41111061107;16825.579360516083;12547;12941.352932353533;12941.935290323489;12950.870491295154;12992.220466771834;16603.252853621616;17194;18433.354832580797;18497.90751046263;18526.351577694717;7736.922630773733;7868.213178682086;7885.408594355332;7894.684212631545;8001.279884810395;772.5017363800317;861.6553378648465;900.9549522523847;946.7112530678072;1002.3033991375924;24143.275701728977;30380.392392152033;30470.69529304723;30691.925782597504;30733.846330768203;1056.804491169136;1062.8671416072991;1094.3324572011068;1128.4639796096953;1170.4381896689467;15842.68314633724;15894.443694470638;15916.363345466283;16053.795117963406;16113.355465781471;679810;684559;684788;688468;690512;54323;57548;57795;57906.131408028916;58265;1354.8306461692289;1375.2092546785639;1383.6955869708647;1387.9028468007143;1394.17743531317;28684.569731453626;29311.26721831886;30061.098167054148;30649.54025689661;30869.382612348076;50930;51066.744666276434;51182;51197.48802511927;51387.48612513827;563658;563701;566117;566565;570337;26511.60232596474;26951;27622.723772762016;27720.722792771816;28346;36105.097372564844;38306.425403618414;46482;46568;48014;32725.836370818946;35710.285794284486;39592.812215633574;40129.598704013755;40229;38912;38997.805010974764;40205;40270.79864600658;40577.594224058565;37644.62355376411;37742.43386349262;38339.424908625835;38852.41721374125;38947.610523895535;28075.017374392617;28757.137285881458;32219.03342899717;32856.01431957045;35086.64913350834;21174;23797.643035354136;25184.992600295784;25315.113971010927;25630.359241019123 08:54:58 INFO - PROCESS | 1650 | |2;jquery.html;335.1871711100581;369.1472698067463;378.35679345113294;391.4226515889062;402.2116651363328;20195.39413817584;20522;22188.445288867766;22240.777592224073;22273.44316392091;11889.346085965268;11921.880781192207;12019.639410817668;12290.07824413168;12320.260784352946;5279.630425870181;5544.86137846553;5548.72256387179;5561.77752889884;5564.777408903639;5257.579393648518;5430.402655707869;5445.50990410863;5523.143912693539;5534.03154447972;4731.195696731546;5393.4336894626085;5475.863103422426;5492.588055895804;5510.531604813596;5508.6970216638065;5515.117581187011;5767.653940763546;6070.817875463743;6130.17242672238;5971.98476259037;5972.984592619265;5999.580029397944;6033.155358249848;6033.5173186145;11573.942130289379;13231.933840330834;13323.66690832737;13462.192268463923;13579.796303055364;2288.2677543186187;2298.4139044543704;2401.4836810085917;2477.3311205974464;3059.6940305969447;9847.753806154904;9863.60545578176;10021.44882031488;10270.691879243635;10557.260991730582;1857.535616095976;1898.7151927210891;1918.098493707969;1933.622943526013;1999.7600287965538;105024.4748776259;121984.78015219823;126281;127279.3636031814;132428.99999999904;10877.347359158475;11054.613088541862;11643.88356116445;11667.299962002136;11816.940915295369;14660;14697.97114202017;14721;14722;14726.779098313535;8430.536320502308;8690.565471726388;8742.344324175712;8822.117788221254;8841.734747957571;8550.315974722007;8657.783555411039;8730.738077857675;8740.300775937909;8854.734357969272;4502.347159661831;4582.198115329804;4582.381378513925;4643.257078867365;4662.7668616569035;1722.2249987505422;1907.7996810334992;1934.1006432009183;1943.3101249056665;1955.882647041182;851.4167795060404;883.2933653077512;897.4032268541347;920.9355345125911;922.7139586728135;21090.683639745417;22458.55082898333;22638.434039149153;22729.88635056814;22794.65808012881;895.3883010580928;921.0191146429032;926.4256161180111;951.7335146159087;957.7318350861769;11642.88357116435;11707.726679761825;11823.822642660367;11909.761804763857;11992.640220793215;532086;536226;539372;623663;648669;111476.32785508224;129067.35466322796;145862;147340;150568;441.6510956344452;459.11161901720277;461.91223667503067;462.24653814282505;464.6724059538018;9269.536523173949;10451.58193672275;11242.606508772154;11473.36896470702;11847.052235821286;40317;48967.75516122397;57288.85422291614;59330.406695932485;59868.70065649644;67034;85248.57375713081;85911.14088859031;86545;87127;8021.2379823916635;8047.476914000571;8187.877181842397;8261.421700480909;8268.503889766633;9444.386114902509;11937.4031298433;13016.023798215361;13547.051706380458;13725.176489410667;9694.854577181206;11275.887241127812;11290.435478225892;11511.539538418705;11680.240784348991;11252.043576295779;11273.379964101725;11647.941760291144;11672.299662020307;12016.459259333526;11312.717182070513;11348.375839328915;11711.590094346657;11759.412029398325;11898.226615270327;8051.557164356017;8133.4713243641345;8317.708880189164;8345.207205315486;8512;8094.231048050426;10932.398718070583;11060.612878549535;11076.335419874833;11413.771724565297 08:54:58 INFO - PROCESS | 1650 | |3;mootools.html;1500.639846436855;1539.4457995121759;1703.412322748652;1776.1652023548927;1815.9364422245224;7859.135495095549;8348.874766878502;8418.410711250215;8865.999999999993;8871.024187339395;8482.745517634481;8649.135086491347;8656.047834738174;8665.436746611465;8726.345524085704;2310.7689231076843;2328.266596022256;2351.623740201568;2355.7644235576477;2357.045396614374;2305.7694230576976;2345.3550273674705;2351.6472529120597;2354.75275096115;2355.0462062864567;2335.9416014599688;2347.436615212354;2359.681443005198;2372.9169479068237;2373.632087026505;1796.8949096305807;2226.9199438272426;2338.3920180752957;2346.5306938612175;2356.1386504661295;1941.4758015335922;1943.2712732725229;2223.8665680059084;2328.0455013444407;2329.557384097016;8729.60716767747;8790.42862213954;8795.560221988939;8804.16360445763;8809.471431714117;5148.433672296044;5214.243934629495;5273.393559740641;5300.814471493518;5320.414754377015;3479.982600087009;3550.0769799851964;3632.8546858125906;3650.8357123929222;3664.8167591620577;952.7999120184769;956.7082039977804;1066.914646828252;1119.1774046076127;1120.1878637987395;11333.603323883624;11383.03244224242;11460.369679667698;11474.139439542068;11489.310641361462;4546.272596384562;4625.468071171791;4778.187708089633;4800.231962885991;4808.783604737795;9692.75768105803;9783.11951924316;9785.217182625373;9819.950900245596;9820;5233.110371236899;5277.313949186581;5278.683279003272;5284.7886084556185;5285.524302812765;4389.231884420214;4690.273007683814;4824.228123500293;4833.564979151823;4850.854474365775;3382.8477718502727;3695.0577602711674;3756.73702840804;3941.349677303213;3950.229705207457;1265.3230521671046;1274.8278982337451;1279.33474593211;1287.1762072273752;1290.619267316144;845.5687599324389;899.4648184330313;914.7027216154643;924.2698268367914;950.8668786369914;5728.283964504437;5804.709764511757;5954.166416701665;5983.760649574056;6175.907361389583;429.4996329276358;434.1707338982528;437.9912401752011;448.83617479619704;461.82681494439584;3877.65101140893;3959.1685745993086;4063.2686116499312;4081.163361510883;4083.8774836754947;10146.847797283046;10486.63296784624;10582;10631.46842657864;10660.946695266473;10406.739831504274;10474.685759427077;10498.055175034284;10563.207759418074;10610.522526486327;8021.759347219593;8085.757427277191;8155.877661835078;8157.959210203911;8163.183681631789;5921.17103605487;5944.762209511744;5985;6022.066579680157;6202.28673702512;9533.237341012564;9640.75898102553;9744.415335079917;9814.165795907142;9942.254330925354;9725.173360264174;10033.14718248957;10060.647877324258;10136.543855526372;10137;6847.589144651337;7159.031266401781;7238.565686058853;7380.409567234716;7481.925180748341;8202.671893124209;8264.049634292134;8371.41400101987;8375.581220938806;8381.455205411628;7418.777436676908;7496.325330720261;7498.175200728025;7573.507721998052;7668.463207575416;7238.0952380952385;7296.562206267641;7358.190599033995;7436.962815186106;7449.8882516761205;6936.965315173392;6967.1291088613925;7018.33325834045;7022.262662420372;7028.964855175692;4898.583620392306;4898.681585696918;5087.313212716236;5111.258867464123;5114.71869047206;5021.096202683552;5043.697378157322;5108.208227724708;5145.331106956221;5203.11547036997 08:54:58 INFO - PROCESS | 1650 | |4;prototype.html;246.54635470733857;282.45627167702173;305.8088694565896;311.0605969970688;311.0885106637554;5279.577633789298;5361.624686271963;5521.944780552203;5656.123300888358;5692.516136128429;5567.3040869891265;5590.552755779538;5597.916031259534;5605.383407825136;5632.3804381518;3392.6268110507826;4282.721623094497;4295.441592592959;4301.505127026333;4303.397524346578;4049.2913740095364;4187.769672668002;4288.421063156481;4290.6138447539715;4291.249031419489;4081.4898137732785;4178.934371735203;4208.221479026374;4221.7889105544755;4223.725457845246;4204.936925946114;4227.196832601827;4245.1934132514725;4245.915081698348;4261.955820823918;3492.528508651325;3631.927361452756;3676.981615091934;3680.9447858282147;3682.650148235913;4462.928897064714;5366.758495867695;5376.542993845528;5420.376656684492;5423.647462914937;4766.285057241407;4784.923392236754;4862.708237505725;4877.804887804519;4905.705657660552;4650.023495066041;5331.481222393202;5410.404855465896;5900.604049982748;5955.761769529214;3272;3881.825317860703;3895.6299151580556;3917.6092487167216;3925.391564307537;5077.339945807022;6083.878322433571;6110.358412366682;6117.9082313765775;6120.571559990803;3973.5033120859894;3980.920381592352;3985.5217373915316;3999.480067591253;4023.7786921719585;3796.905077373088;3865.304245235828;3971.205758848242;4015.13674559971;4019.91960160801;4673.836415725434;4688.765561721901;4721.173794585934;4733;4761.262004389325;5130.538251557303;5852.502537284294;5891.587588868823;5908.615939963888;5910.852228694317;1154.370867877009;1157.3518829455531;1232.3037483821613;1376.4356613788298;1397.82527184102;757.4130049211905;777.9961100194575;784.3137254901961;797.8803179523002;874.580201503282;4186.413902053715;4730.905381892343;5372.952274306473;5404.081306177959;5465.617406781566;5066.6453348266;5320.466714616832;5746.683932383676;5917.852053698692;6021.397860213943;5217.860677122361;5424.589606702286;5444.597126795753;5474.562035037187;5503.367112782002;2230.8884555772147;2324.9770101155436;2390.5338459000327;2581.767640912327;2623.6720409948757;4774.21225497789;5245.557471695238;5257;5264.842054738364;5278.9208161877605;4679.064187162581;4757.809687612456;4848;5010.824621138243;6284.622922624657;5342.439043900412;5607.710226647894;5873.854598353366;6319.33646967071;6419.743210271537;5501.3948465667945;5724.856878578069;6005.669688167192;6080.8783824324155;6164.815055548341;5316.856875771728;5405;5649.734450489854;5988.970055149871;6025.548083893813;5252.789888404421;6287.862126876884;6356.044439335731;6397.232332120176;6400.447751497777;3545.9290814183055;3645.5807582127336;3758.605346438694;3923.05846596809;3960.5049368828895;5662.801801936913;5963.403659634002;5973.850653733692;6019.307779605401;6022.247219097613;5764.654120752768;5827.358990511125;5839.824805255849;5839.963219126115;5842.38654941242;4753.952460475351;5128.564072053917;5739.8852022960145;5796;5854.209681692917;5186.818461353834;5281.84154475351;5611.354694210218;5653.971730141323;5697.663957777291;5820.679862607597;5854;5857.824265271878;5867.9413205867395;5897.439743224387;5401.621886468067;5530.529904957963;5650.039493286234;5735.426457354231;5737.110747834093 08:54:58 INFO - PROCESS | 1650 | |5;yui.html;714.1608609883385;727.785303335516;742.7697413801718;755.165542076006;778.2606523802385;15332.54002379929;15997.040177589353;16441.177941102957;16557.08936008522;16707.832921670793;14798.186099764509;14801.481948131817;14842.851571484282;14970.401183952628;14974;835.8161204535007;850.1668365002301;860.3590325207729;863;864.2092485375905;681.0839420978775;786.8662327404355;860.9009963854143;871.2289623683023;872.2280781508348;917.4953775423523;920.5719340506663;921.9400738951947;922.9630814767402;924.4638109896244;899.5142622983581;903.290916630442;910.8588168833842;911.1435250864199;918.5223683684513;663.515633587479;663.6913835066717;671.7212356871893;677.420805211542;679.9830004249884;14457.493987710379;14637.560873173821;14649.047811892193;14692.48576299835;14733.189674567895;14715.63210919725;14730.55808325752;14781.33483993223;15056.096634201984;15066.472673456487;11960.880391196064;12133.029357651367;12362.01103911685;12369.567065152767;12454.688632784162;3861.3049651062797;3870.2259548090497;4038.2932986727205;4096.037431203665;4098.446709694183;115271.42364288209;117646.11777410026;118249;119095.4045229777;119262.21106683406;11140.944295278634;11170;11301.49143288554;11452.94273528627;11791.705207369885;23238.53522929532;23285;23307.883460582587;23316.417089572897;23325.88337058304;8074.152214017561;8230.42387032914;8240.876386854203;8242.958785206036;8313.244066034724;4468.687191896601;4484.394606728115;4520.186366454004;4535.307483108156;4652.069586082797;3002.4745669507747;3611.115276757211;3684.6868016218386;3688.170161713593;3688.8155592220282;572.3446653581626;601.6149664214906;602.4908951935607;636.3286732497168;639.8144538083997;581.2617975171509;586.8796896636179;634.2452481546944;663.8572706868047;679.7654809090856;9169.266458683289;9660.806783864424;9692;9713.417194968324;9866.260030497742;541.9647722898;554.9411682657386;571.5227784799739;672.4586707700348;674.8886433738378;3912.9608703912595;3948.4198329937135;4071.491063617048;4152.211079894811;4493.932591011137;125241;127404.36297818452;127878.36060819637;132842;153027;74541;77191.61404192942;77716.2228377709;89470.65794013096;104199.47900260451;88488.67266990872;91900.54049729843;111250.44374778237;111457;111921.44039279752;9830.181416437981;9965.40207587547;10068.345557538736;10076.445795481319;10216.693499195037;52478;53172.73413632907;61815;62255.06617400652;65217.2391555388;74078.62960685378;90010;93226;94566.05433945573;97036.51481742546;13232.272225027717;13267.336633168496;13428.93285533566;13534.729305414034;13720.725585488433;15175.089494630358;15313.157776322409;15322.846771532588;15434.536963891102;15672.76490852661;13955.162690238618;13959.860401395856;14176.858231417555;14467.782983255049;14624.561263162122;13770.173789572658;14002.229877356436;14051.859481405463;14360.712785744436;14511.056781309604;13474.326283685972;13516.5269215577;13591.660208494472;13756.793648095087;14076.240469941258;11070.889291106985;11303.491342889754;11345.546178152781;11354.205205635526;12071.456784444545;9258.861117083385;9847.753806154904;10393.58425662965;11018.686075924146;11567.479463423997 08:54:58 INFO - PROCESS | 1650 | __end_tp_report 08:54:58 INFO - PROCESS | 1650 | __start_cc_report 08:54:58 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,425 08:54:58 INFO - PROCESS | 1650 | __end_cc_report 08:54:58 INFO - PROCESS | 1650 | __startTimestamp1471881298012__endTimestamp 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:54:58 INFO - PROCESS | 1650 | Number of tests: 6 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5778.50 Median:6005.43 stddev:652.35 (10.9%) stddev-sans-first:627.46 08:54:58 INFO - PROCESS | 1650 | Values: 3415.5 3420.7 3423.5 3437.6 3456.4 5754.6 5761.7 5844.7 5849.4 5859.9 5566.5 5754.5 5822.3 5907.9 5921.0 5241.8 5322.5 5330.1 5401.6 5423.2 5424.2 5443.8 5446.9 5459.9 5462.6 5113.6 5199.5 5243.7 5293.1 5299.7 5252.3 5295.7 5304.6 5317.7 5350.0 5294.2 5324.6 5328.4 5376.6 5382.2 4625.7 5756.9 5785.9 5803.9 5824.1 6222.6 6236.8 6284.7 6303.1 6306.6 6268.3 6281.7 6286.2 6293.4 6305.6 5814.6 5919.1 5968.3 5973.7 6033.0 6389.7 6402.1 6406.6 6411.6 6415.6 5184.0 5609.5 6250.3 6258.9 6267.4 5030.0 5881.8 6233.0 6234.3 6246.3 5633.4 6171.5 6245.5 6290.2 6295.2 5559.6 5775.8 6229.2 6237.8 6298.6 4993.9 5017.4 5017.8 5080.3 5124.9 3649.0 4461.8 4551.6 4563.1 4574.3 4904.2 5786.3 5959.8 5984.2 5994.3 6206.3 6215.4 6229.5 6259.8 6282.0 5972.3 6020.8 6028.2 6050.4 6066.0 5623.7 5624.3 5625.9 5649.0 5663.1 6281.8 6347.7 6418.4 6530.3 6551.1 6275.4 6277.9 6279.4 6293.7 6295.8 5131.9 6227.8 6421.4 6431.3 6488.7 6155.3 6157.4 6159.1 6193.3 6236.0 5204.5 6251.7 6267.9 6269.4 6281.4 6060.2 6239.9 6251.2 6261.6 6278.0 6076.7 6087.8 6100.5 6217.3 6275.1 5112.6 5540.3 6037.2 6077.9 6120.2 6166.9 6206.6 6219.5 6238.4 6260.2 5957.9 6005.4 6079.5 6093.4 6100.1 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:70971.44 Median:3382.11 stddev:155829.81 (4607.5%) stddev-sans-first:156177.03 08:54:58 INFO - PROCESS | 1650 | Values: 464.6 492.4 513.2 538.8 558.9 38839.6 40911.0 40925.0 41072.4 41119.0 41682.2 42399.6 42565.8 42601.4 42716.1 8933.6 9658.0 11994.4 12322.0 12329.1 9534.9 12163.4 12211.6 12273.9 12277.3 10095.8 11869.1 12079.6 12181.1 12238.4 11912.0 11952.2 12081.9 12179.5 12219.7 9698.3 10133.0 11994.4 12061.4 12089.8 32454.8 33152.7 39931.2 39970.0 40218.8 3057.0 3350.1 3354.4 3417.2 3431.6 25821.4 30713.7 31325.0 31578.7 32508.8 3285.2 3292.9 3305.4 3376.0 3388.2 475409.0 475973.0 476668.0 480035.0 480549.0 61191.7 61641.7 61798.0 61859.1 61979.4 64062.0 64892.7 65028.3 65135.0 65168.0 14944.8 16225.5 16390.6 16825.4 16825.6 12547.0 12941.4 12941.9 12950.9 12992.2 16603.3 17194.0 18433.4 18497.9 18526.4 7736.9 7868.2 7885.4 7894.7 8001.3 772.5 861.7 901.0 946.7 1002.3 24143.3 30380.4 30470.7 30691.9 30733.8 1056.8 1062.9 1094.3 1128.5 1170.4 15842.7 15894.4 15916.4 16053.8 16113.4 679810.0 684559.0 684788.0 688468.0 690512.0 54323.0 57548.0 57795.0 57906.1 58265.0 1354.8 1375.2 1383.7 1387.9 1394.2 28684.6 29311.3 30061.1 30649.5 30869.4 50930.0 51066.7 51182.0 51197.5 51387.5 563658.0 563701.0 566117.0 566565.0 570337.0 26511.6 26951.0 27622.7 27720.7 28346.0 36105.1 38306.4 46482.0 46568.0 48014.0 32725.8 35710.3 39592.8 40129.6 40229.0 38912.0 38997.8 40205.0 40270.8 40577.6 37644.6 37742.4 38339.4 38852.4 38947.6 28075.0 28757.1 32219.0 32856.0 35086.6 21174.0 23797.6 25185.0 25315.1 25630.4 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34206.57 Median:373.75 stddev:97318.40 (26038.2%) stddev-sans-first:97558.17 08:54:58 INFO - PROCESS | 1650 | Values: 335.2 369.1 378.4 391.4 402.2 20195.4 20522.0 22188.4 22240.8 22273.4 11889.3 11921.9 12019.6 12290.1 12320.3 5279.6 5544.9 5548.7 5561.8 5564.8 5257.6 5430.4 5445.5 5523.1 5534.0 4731.2 5393.4 5475.9 5492.6 5510.5 5508.7 5515.1 5767.7 6070.8 6130.2 5972.0 5973.0 5999.6 6033.2 6033.5 11573.9 13231.9 13323.7 13462.2 13579.8 2288.3 2298.4 2401.5 2477.3 3059.7 9847.8 9863.6 10021.4 10270.7 10557.3 1857.5 1898.7 1918.1 1933.6 1999.8 105024.5 121984.8 126281.0 127279.4 132429.0 10877.3 11054.6 11643.9 11667.3 11816.9 14660.0 14698.0 14721.0 14722.0 14726.8 8430.5 8690.6 8742.3 8822.1 8841.7 8550.3 8657.8 8730.7 8740.3 8854.7 4502.3 4582.2 4582.4 4643.3 4662.8 1722.2 1907.8 1934.1 1943.3 1955.9 851.4 883.3 897.4 920.9 922.7 21090.7 22458.6 22638.4 22729.9 22794.7 895.4 921.0 926.4 951.7 957.7 11642.9 11707.7 11823.8 11909.8 11992.6 532086.0 536226.0 539372.0 623663.0 648669.0 111476.3 129067.4 145862.0 147340.0 150568.0 441.7 459.1 461.9 462.2 464.7 9269.5 10451.6 11242.6 11473.4 11847.1 40317.0 48967.8 57288.9 59330.4 59868.7 67034.0 85248.6 85911.1 86545.0 87127.0 8021.2 8047.5 8187.9 8261.4 8268.5 9444.4 11937.4 13016.0 13547.1 13725.2 9694.9 11275.9 11290.4 11511.5 11680.2 11252.0 11273.4 11647.9 11672.3 12016.5 11312.7 11348.4 11711.6 11759.4 11898.2 8051.6 8133.5 8317.7 8345.2 8512.0 8094.2 10932.4 11060.6 11076.3 11413.8 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5653.66 Median:5065.51 stddev:3173.93 (62.7%) stddev-sans-first:3167.49 08:54:58 INFO - PROCESS | 1650 | Values: 1500.6 1539.4 1703.4 1776.2 1815.9 7859.1 8348.9 8418.4 8866.0 8871.0 8482.7 8649.1 8656.0 8665.4 8726.3 2310.8 2328.3 2351.6 2355.8 2357.0 2305.8 2345.4 2351.6 2354.8 2355.0 2335.9 2347.4 2359.7 2372.9 2373.6 1796.9 2226.9 2338.4 2346.5 2356.1 1941.5 1943.3 2223.9 2328.0 2329.6 8729.6 8790.4 8795.6 8804.2 8809.5 5148.4 5214.2 5273.4 5300.8 5320.4 3480.0 3550.1 3632.9 3650.8 3664.8 952.8 956.7 1066.9 1119.2 1120.2 11333.6 11383.0 11460.4 11474.1 11489.3 4546.3 4625.5 4778.2 4800.2 4808.8 9692.8 9783.1 9785.2 9820.0 9820.0 5233.1 5277.3 5278.7 5284.8 5285.5 4389.2 4690.3 4824.2 4833.6 4850.9 3382.8 3695.1 3756.7 3941.3 3950.2 1265.3 1274.8 1279.3 1287.2 1290.6 845.6 899.5 914.7 924.3 950.9 5728.3 5804.7 5954.2 5983.8 6175.9 429.5 434.2 438.0 448.8 461.8 3877.7 3959.2 4063.3 4081.2 4083.9 10146.8 10486.6 10582.0 10631.5 10660.9 10406.7 10474.7 10498.1 10563.2 10610.5 8021.8 8085.8 8155.9 8158.0 8163.2 5921.2 5944.8 5985.0 6022.1 6202.3 9533.2 9640.8 9744.4 9814.2 9942.3 9725.2 10033.1 10060.6 10136.5 10137.0 6847.6 7159.0 7238.6 7380.4 7481.9 8202.7 8264.0 8371.4 8375.6 8381.5 7418.8 7496.3 7498.2 7573.5 7668.5 7238.1 7296.6 7358.2 7437.0 7449.9 6937.0 6967.1 7018.3 7022.3 7029.0 4898.6 4898.7 5087.3 5111.3 5114.7 5021.1 5043.7 5108.2 5145.3 5203.1 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4659.11 Median:5279.25 stddev:1473.97 (27.9%) stddev-sans-first:1440.42 08:54:58 INFO - PROCESS | 1650 | Values: 246.5 282.5 305.8 311.1 311.1 5279.6 5361.6 5521.9 5656.1 5692.5 5567.3 5590.6 5597.9 5605.4 5632.4 3392.6 4282.7 4295.4 4301.5 4303.4 4049.3 4187.8 4288.4 4290.6 4291.2 4081.5 4178.9 4208.2 4221.8 4223.7 4204.9 4227.2 4245.2 4245.9 4262.0 3492.5 3631.9 3677.0 3680.9 3682.7 4462.9 5366.8 5376.5 5420.4 5423.6 4766.3 4784.9 4862.7 4877.8 4905.7 4650.0 5331.5 5410.4 5900.6 5955.8 3272.0 3881.8 3895.6 3917.6 3925.4 5077.3 6083.9 6110.4 6117.9 6120.6 3973.5 3980.9 3985.5 3999.5 4023.8 3796.9 3865.3 3971.2 4015.1 4019.9 4673.8 4688.8 4721.2 4733.0 4761.3 5130.5 5852.5 5891.6 5908.6 5910.9 1154.4 1157.4 1232.3 1376.4 1397.8 757.4 778.0 784.3 797.9 874.6 4186.4 4730.9 5373.0 5404.1 5465.6 5066.6 5320.5 5746.7 5917.9 6021.4 5217.9 5424.6 5444.6 5474.6 5503.4 2230.9 2325.0 2390.5 2581.8 2623.7 4774.2 5245.6 5257.0 5264.8 5278.9 4679.1 4757.8 4848.0 5010.8 6284.6 5342.4 5607.7 5873.9 6319.3 6419.7 5501.4 5724.9 6005.7 6080.9 6164.8 5316.9 5405.0 5649.7 5989.0 6025.5 5252.8 6287.9 6356.0 6397.2 6400.4 3545.9 3645.6 3758.6 3923.1 3960.5 5662.8 5963.4 5973.9 6019.3 6022.2 5764.7 5827.4 5839.8 5840.0 5842.4 4754.0 5128.6 5739.9 5796.0 5854.2 5186.8 5281.8 5611.4 5654.0 5697.7 5820.7 5854.0 5857.8 5867.9 5897.4 5401.6 5530.5 5650.0 5735.4 5737.1 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:23295.10 Median:3865.77 stddev:35530.20 (919.1%) stddev-sans-first:35589.41 08:54:58 INFO - PROCESS | 1650 | Values: 714.2 727.8 742.8 755.2 778.3 15332.5 15997.0 16441.2 16557.1 16707.8 14798.2 14801.5 14842.9 14970.4 14974.0 835.8 850.2 860.4 863.0 864.2 681.1 786.9 860.9 871.2 872.2 917.5 920.6 921.9 923.0 924.5 899.5 903.3 910.9 911.1 918.5 663.5 663.7 671.7 677.4 680.0 14457.5 14637.6 14649.0 14692.5 14733.2 14715.6 14730.6 14781.3 15056.1 15066.5 11960.9 12133.0 12362.0 12369.6 12454.7 3861.3 3870.2 4038.3 4096.0 4098.4 115271.4 117646.1 118249.0 119095.4 119262.2 11140.9 11170.0 11301.5 11452.9 11791.7 23238.5 23285.0 23307.9 23316.4 23325.9 8074.2 8230.4 8240.9 8243.0 8313.2 4468.7 4484.4 4520.2 4535.3 4652.1 3002.5 3611.1 3684.7 3688.2 3688.8 572.3 601.6 602.5 636.3 639.8 581.3 586.9 634.2 663.9 679.8 9169.3 9660.8 9692.0 9713.4 9866.3 542.0 554.9 571.5 672.5 674.9 3913.0 3948.4 4071.5 4152.2 4493.9 125241.0 127404.4 127878.4 132842.0 153027.0 74541.0 77191.6 77716.2 89470.7 104199.5 88488.7 91900.5 111250.4 111457.0 111921.4 9830.2 9965.4 10068.3 10076.4 10216.7 52478.0 53172.7 61815.0 62255.1 65217.2 74078.6 90010.0 93226.0 94566.1 97036.5 13232.3 13267.3 13428.9 13534.7 13720.7 15175.1 15313.2 15322.8 15434.5 15672.8 13955.2 13959.9 14176.9 14467.8 14624.6 13770.2 14002.2 14051.9 14360.7 14511.1 13474.3 13516.5 13591.7 13756.8 14076.2 11070.9 11303.5 11345.5 11354.2 12071.5 9258.9 9847.8 10393.6 11018.7 11567.5 08:54:58 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:54:58 INFO - PROCESS | 1650 | 08:54:58 INFO - TEST-INFO | 1650: exit 0 08:54:58 INFO - TEST-OK | dromaeo_css | took 1114667ms 08:54:58 INFO - TEST-START | kraken 08:54:58 INFO - operating with platform_type : mac_ 08:54:58 INFO - Initialising browser for kraken test... 08:54:58 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpACDOjP/profile http://localhost:49262/getInfo.html) 08:55:01 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 08:55:01 INFO - PROCESS | 1661 | colorDepth:24 08:55:01 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 08:55:01 INFO - PROCESS | 1661 | __metrics 08:55:01 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 08:55:02 INFO - TEST-INFO | 1661: exit 0 08:55:02 INFO - Browser initialized. 08:55:02 INFO - Running cycle 1/1 for kraken test... 08:55:02 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpACDOjP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:14 INFO - PROCESS | 1663 | RSS: Main: 239779840 08:55:14 INFO - PROCESS | 1663 | 08:55:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:17 INFO - PROCESS | 1663 | RSS: Main: 252637184 08:55:17 INFO - PROCESS | 1663 | 08:55:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 08:55:21 INFO - PROCESS | 1663 | RSS: Main: 261373952 08:55:21 INFO - PROCESS | 1663 | 08:55:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 08:55:25 INFO - PROCESS | 1663 | RSS: Main: 263979008 08:55:25 INFO - PROCESS | 1663 | 08:55:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 08:55:28 INFO - PROCESS | 1663 | RSS: Main: 266420224 08:55:28 INFO - PROCESS | 1663 | 08:55:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:30 INFO - PROCESS | 1663 | RSS: Main: 266772480 08:55:30 INFO - PROCESS | 1663 | 08:55:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:34 INFO - PROCESS | 1663 | RSS: Main: 267444224 08:55:34 INFO - PROCESS | 1663 | 08:55:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:38 INFO - PROCESS | 1663 | RSS: Main: 267120640 08:55:38 INFO - PROCESS | 1663 | 08:55:41 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 08:55:41 INFO - PROCESS | 1663 | RSS: Main: 267444224 08:55:41 INFO - PROCESS | 1663 | 08:55:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:44 INFO - PROCESS | 1663 | RSS: Main: 267014144 08:55:44 INFO - PROCESS | 1663 | 08:55:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:46 INFO - PROCESS | 1663 | RSS: Main: 267296768 08:55:46 INFO - PROCESS | 1663 | 08:55:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:49 INFO - PROCESS | 1663 | RSS: Main: 267509760 08:55:49 INFO - PROCESS | 1663 | 08:55:52 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:53 INFO - PROCESS | 1663 | RSS: Main: 267620352 08:55:53 INFO - PROCESS | 1663 | 08:55:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:56 INFO - PROCESS | 1663 | RSS: Main: 267751424 08:55:56 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 08:55:58 INFO - PROCESS | 1663 | RSS: Main: 269688832 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | __start_tp_report 08:55:58 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 08:55:58 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 08:55:58 INFO - PROCESS | 1663 | |i|pagename|runs| 08:55:58 INFO - PROCESS | 1663 | |0;ai-astar;106;120;110;118;118;129;169;163;118;117 08:55:58 INFO - PROCESS | 1663 | |1;audio-beat-detection;145;136;123;182;136;159;130;112;162;111 08:55:58 INFO - PROCESS | 1663 | |2;audio-dft;269;205;253;275;205;268;283;199;202;196 08:55:58 INFO - PROCESS | 1663 | |3;audio-fft;70;83;77;139;74;87;83;65;130;52 08:55:58 INFO - PROCESS | 1663 | |4;audio-oscillator;71;86;146;71;72;86;126;96;99;150 08:55:58 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;91;88;90;90;91;120;110;88;103;128 08:55:58 INFO - PROCESS | 1663 | |6;imaging-darkroom;95;150;146;111;149;124;96;96;99;94 08:55:58 INFO - PROCESS | 1663 | |7;imaging-desaturate;91;93;92;91;105;146;148;91;92;114 08:55:58 INFO - PROCESS | 1663 | |8;json-parse-financial;56;60;58;58;58;58;61;57;56;56 08:55:58 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;66;71;68;70;77;80;74;69;69;71 08:55:58 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;87;86;87;76;105;106;108;106;96 08:55:58 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;141;140;138;138;138;138;138;161;160;137 08:55:58 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;167;173;225;186;171;168;165;170;154;169 08:55:58 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;68;69;68;65;81;93;90;88;68;72 08:55:58 INFO - PROCESS | 1663 | __end_tp_report 08:55:58 INFO - PROCESS | 1663 | __start_cc_report 08:55:58 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1078 08:55:58 INFO - PROCESS | 1663 | __end_cc_report 08:55:58 INFO - PROCESS | 1663 | __startTimestamp1471881358685__endTimestamp 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | ------- Summary: start ------- 08:55:58 INFO - PROCESS | 1663 | Number of tests: 14 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:126.80 Median:119.00 stddev:21.57 (18.1%) stddev-sans-first:21.52 08:55:58 INFO - PROCESS | 1663 | Values: 106.0 120.0 110.0 118.0 118.0 129.0 169.0 163.0 118.0 117.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:140.50 stddev:22.80 (16.2%) stddev-sans-first:24.10 08:55:58 INFO - PROCESS | 1663 | Values: 145.0 136.0 123.0 182.0 136.0 159.0 130.0 112.0 162.0 111.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:235.50 Median:260.50 stddev:36.78 (14.1%) stddev-sans-first:36.96 08:55:58 INFO - PROCESS | 1663 | Values: 269.0 205.0 253.0 275.0 205.0 268.0 283.0 199.0 202.0 196.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:86.00 Median:75.50 stddev:27.57 (36.5%) stddev-sans-first:28.63 08:55:58 INFO - PROCESS | 1663 | Values: 70.0 83.0 77.0 139.0 74.0 87.0 83.0 65.0 130.0 52.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:79.00 stddev:30.12 (38.1%) stddev-sans-first:30.03 08:55:58 INFO - PROCESS | 1663 | Values: 71.0 86.0 146.0 71.0 72.0 86.0 126.0 96.0 99.0 150.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:89.00 stddev:14.69 (16.5%) stddev-sans-first:15.23 08:55:58 INFO - PROCESS | 1663 | Values: 91.0 88.0 90.0 90.0 91.0 120.0 110.0 88.0 103.0 128.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:94.50 stddev:24.15 (25.6%) stddev-sans-first:24.39 08:55:58 INFO - PROCESS | 1663 | Values: 95.0 150.0 146.0 111.0 149.0 124.0 96.0 96.0 99.0 94.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:91.00 stddev:22.76 (25.0%) stddev-sans-first:23.46 08:55:58 INFO - PROCESS | 1663 | Values: 91.0 93.0 92.0 91.0 105.0 146.0 148.0 91.0 92.0 114.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.69 (2.9%) stddev-sans-first:1.66 08:55:58 INFO - PROCESS | 1663 | Values: 56.0 60.0 58.0 58.0 58.0 58.0 61.0 57.0 56.0 56.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:4.30 (6.1%) stddev-sans-first:4.08 08:55:58 INFO - PROCESS | 1663 | Values: 66.0 71.0 68.0 70.0 77.0 80.0 74.0 69.0 69.0 71.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:86.50 stddev:11.27 (13.0%) stddev-sans-first:11.63 08:55:58 INFO - PROCESS | 1663 | Values: 87.0 87.0 86.0 87.0 76.0 105.0 106.0 108.0 106.0 96.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:139.00 stddev:9.35 (6.7%) stddev-sans-first:9.89 08:55:58 INFO - PROCESS | 1663 | Values: 141.0 140.0 138.0 138.0 138.0 138.0 138.0 161.0 160.0 137.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:170.50 stddev:19.31 (11.3%) stddev-sans-first:20.27 08:55:58 INFO - PROCESS | 1663 | Values: 167.0 173.0 225.0 186.0 171.0 168.0 165.0 170.0 154.0 169.0 08:55:58 INFO - PROCESS | 1663 | 08:55:58 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.50 stddev:10.71 (14.0%) stddev-sans-first:10.94 08:55:58 INFO - PROCESS | 1663 | Values: 68.0 69.0 68.0 65.0 81.0 93.0 90.0 88.0 68.0 72.0 08:55:58 INFO - PROCESS | 1663 | -------- Summary: end -------- 08:55:58 INFO - PROCESS | 1663 | 08:55:59 INFO - TEST-INFO | 1663: exit 0 08:55:59 INFO - TEST-OK | kraken | took 60864ms 08:55:59 INFO - SUITE-END | took 1175s 08:55:59 INFO - Completed test suite (00:19:35) 08:55:59 INFO - javascript benchmark 08:55:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7310.183923596485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3415.5047518109877, 3420.7434442416825, 3423.452247640375, 3437.553118094649, 3456.3951308521005, 5754.597178197528, 5761.683107429089, 5844.678542680156, 5849.4150584941535, 5859.853503662411, 5566.471185237396, 5754.482096611304, 5822.272215973004, 5907.881842363161, 5920.970395148018, 5241.816536421226, 5322.467753224685, 5330.093884039703, 5401.594880383967, 5423.159410291391, 5424.240606315119, 5443.755031023594, 5446.91829622556, 5459.890802183973, 5462.617616766828, 5113.565346945514, 5199.4800519948085, 5243.711595862226, 5293.126634105368, 5299.735013249322, 5252.343457067866, 5295.735213239361, 5304.6286759926825, 5317.654352467077, 5349.973250133725, 5294.205869119624, 5324.627276090675, 5328.360596728378, 5376.623636345457, 5382.1926710993275, 4625.676202665781, 5756.891278709491, 5785.855353616151, 5803.88392232153, 5824.097264923944, 6222.62664240147, 6236.844078898019, 6284.7486100555925, 6303.086052522404, 6306.558540902139, 6268.310485846599, 6281.685915704242, 6286.151369565096, 6293.433590976788, 6305.5901366411035, 5814.563907706896, 5919.112133180058, 5968.343482216953, 5973.731182096816, 6033.0347144457555, 6389.744410223632, 6402.071699603532, 6406.615603063831, 6411.647359395278, 6415.550911436248, 5183.97408012965, 5609.523190528851, 6250.281217659936, 6258.937410625836, 6267.4045965633195, 5029.974850125799, 5881.764829385791, 6233.0338797486465, 6234.2830574483605, 6246.312905580383, 5633.436656334334, 6171.475424588871, 6245.500359971283, 6290.24517057956, 6295.244570651551, 5559.555235581225, 5775.787084712258, 6229.1590635264565, 6237.812865614039, 6298.559100862895, 4993.875153121201, 5017.448080711192, 5017.8243761468175, 5080.314157588678, 5124.948750512522, 3649.0147660131615, 4461.776911154429, 4551.590356867831, 4563.0873825235085, 4574.268117101248, 4904.239842824368, 5786.276715410574, 5959.821205363846, 5984.162217289496, 5994.280686317583, 6206.348333425016, 6215.378462153749, 6229.5327850410495, 6259.843503912439, 6282.0, 5972.25346831646, 6020.849478763066, 6028.186194863725, 6050.42520960508, 6066.0, 5623.662580245198, 5624.29696287964, 5625.887482250414, 5649.0396632572565, 5663.065594176997, 6281.780137695158, 6347.682615869096, 6418.358164183544, 6530.314316996647, 6551.082848401227, 6275.403836635513, 6277.937220627735, 6279.403456671609, 6293.716782744696, 6295.811125666238, 5131.897362052663, 6227.785581811503, 6421.357864213542, 6431.260405053479, 6488.740450381932, 6155.322914479493, 6157.384261573986, 6159.106929495288, 6193.256809182747, 6236.0, 5204.531592156724, 6251.6874156292915, 6267.874642507033, 6269.435750782452, 6281.434670879643, 6060.2424696912885, 6239.937600624117, 6251.156093927443, 6261.5616906816085, 6277.995520716663, 6076.696165191811, 6087.756489740361, 6100.511959043177, 6217.253929528486, 6275.090111933835, 5112.590992720648, 5540.252065971043, 6037.15479832815, 6077.878442431038, 6120.17377654011, 6166.876662466636, 6206.596571222856, 6219.471344935731, 6238.407351301619, 6260.217472815898, 5957.910631340446, 6005.429484198994, 6079.452849243589, 6093.421124993119, 6100.0849872519475], "value": 5740.006831213576, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [464.62365483957984, 492.41894564413997, 513.2173435510847, 538.768329618264, 558.888222355529, 38839.61160388399, 40911.0, 40925.0, 41072.383914241276, 41119.0, 41682.166356672846, 42399.57600423995, 42565.78717106418, 42601.36097958525, 42716.14567708644, 8933.55332233389, 9657.95171024144, 11994.40027998601, 12322.0, 12329.136960412774, 9534.904650953471, 12163.39183040849, 12211.572594959178, 12273.877261227408, 12277.324747138948, 10095.798084038315, 11869.109816763734, 12079.577214797484, 12181.086418518602, 12238.38808059598, 11912.0, 11952.223105498115, 12081.879181208207, 12179.512819487298, 12219.694507637292, 9698.321117521777, 10133.0, 11994.400279986054, 12061.396930153458, 12089.818652720216, 32454.837725811456, 33152.6684733152, 39931.20137597261, 39970.0, 40218.79890600558, 3056.9847150764326, 3350.145712843234, 3354.3962086824363, 3417.2311229973056, 3431.6396778338167, 25821.3544661385, 30713.69286307131, 31325.0, 31578.73685052595, 32508.83745581257, 3285.162283617686, 3292.884749033772, 3305.3554556861422, 3375.9831200843837, 3388.2376465295356, 475409.0, 475973.0, 476668.0, 480035.0, 480549.0, 61191.69404152951, 61641.691791540754, 61798.0, 61859.07211391833, 61979.38020619736, 64062.0, 64892.675536622955, 65028.34971650223, 65135.0, 65168.0, 14944.775828362583, 16225.51323460298, 16390.590235243977, 16825.41111061107, 16825.579360516083, 12547.0, 12941.352932353533, 12941.935290323489, 12950.870491295154, 12992.220466771834, 16603.252853621616, 17194.0, 18433.354832580797, 18497.90751046263, 18526.351577694717, 7736.922630773733, 7868.213178682086, 7885.408594355332, 7894.684212631545, 8001.279884810395, 772.5017363800317, 861.6553378648465, 900.9549522523847, 946.7112530678072, 1002.3033991375924, 24143.275701728977, 30380.392392152033, 30470.69529304723, 30691.925782597504, 30733.846330768203, 1056.804491169136, 1062.8671416072991, 1094.3324572011068, 1128.4639796096953, 1170.4381896689467, 15842.68314633724, 15894.443694470638, 15916.363345466283, 16053.795117963406, 16113.355465781471, 679810.0, 684559.0, 684788.0, 688468.0, 690512.0, 54323.0, 57548.0, 57795.0, 57906.131408028916, 58265.0, 1354.8306461692289, 1375.2092546785639, 1383.6955869708647, 1387.9028468007143, 1394.17743531317, 28684.569731453626, 29311.26721831886, 30061.098167054148, 30649.54025689661, 30869.382612348076, 50930.0, 51066.744666276434, 51182.0, 51197.48802511927, 51387.48612513827, 563658.0, 563701.0, 566117.0, 566565.0, 570337.0, 26511.60232596474, 26951.0, 27622.723772762016, 27720.722792771816, 28346.0, 36105.097372564844, 38306.425403618414, 46482.0, 46568.0, 48014.0, 32725.836370818946, 35710.285794284486, 39592.812215633574, 40129.598704013755, 40229.0, 38912.0, 38997.805010974764, 40205.0, 40270.79864600658, 40577.594224058565, 37644.62355376411, 37742.43386349262, 38339.424908625835, 38852.41721374125, 38947.610523895535, 28075.017374392617, 28757.137285881458, 32219.03342899717, 32856.01431957045, 35086.64913350834, 21174.0, 23797.643035354136, 25184.992600295784, 25315.113971010927, 25630.359241019123], "value": 20407.627260096568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.1871711100581, 369.1472698067463, 378.35679345113294, 391.4226515889062, 402.2116651363328, 20195.39413817584, 20522.0, 22188.445288867766, 22240.777592224073, 22273.44316392091, 11889.346085965268, 11921.880781192207, 12019.639410817668, 12290.07824413168, 12320.260784352946, 5279.630425870181, 5544.86137846553, 5548.72256387179, 5561.77752889884, 5564.777408903639, 5257.579393648518, 5430.402655707869, 5445.50990410863, 5523.143912693539, 5534.03154447972, 4731.195696731546, 5393.4336894626085, 5475.863103422426, 5492.588055895804, 5510.531604813596, 5508.6970216638065, 5515.117581187011, 5767.653940763546, 6070.817875463743, 6130.17242672238, 5971.98476259037, 5972.984592619265, 5999.580029397944, 6033.155358249848, 6033.5173186145, 11573.942130289379, 13231.933840330834, 13323.66690832737, 13462.192268463923, 13579.796303055364, 2288.2677543186187, 2298.4139044543704, 2401.4836810085917, 2477.3311205974464, 3059.6940305969447, 9847.753806154904, 9863.60545578176, 10021.44882031488, 10270.691879243635, 10557.260991730582, 1857.535616095976, 1898.7151927210891, 1918.098493707969, 1933.622943526013, 1999.7600287965538, 105024.4748776259, 121984.78015219823, 126281.0, 127279.3636031814, 132428.99999999904, 10877.347359158475, 11054.613088541862, 11643.88356116445, 11667.299962002136, 11816.940915295369, 14660.0, 14697.97114202017, 14721.0, 14722.0, 14726.779098313535, 8430.536320502308, 8690.565471726388, 8742.344324175712, 8822.117788221254, 8841.734747957571, 8550.315974722007, 8657.783555411039, 8730.738077857675, 8740.300775937909, 8854.734357969272, 4502.347159661831, 4582.198115329804, 4582.381378513925, 4643.257078867365, 4662.7668616569035, 1722.2249987505422, 1907.7996810334992, 1934.1006432009183, 1943.3101249056665, 1955.882647041182, 851.4167795060404, 883.2933653077512, 897.4032268541347, 920.9355345125911, 922.7139586728135, 21090.683639745417, 22458.55082898333, 22638.434039149153, 22729.88635056814, 22794.65808012881, 895.3883010580928, 921.0191146429032, 926.4256161180111, 951.7335146159087, 957.7318350861769, 11642.88357116435, 11707.726679761825, 11823.822642660367, 11909.761804763857, 11992.640220793215, 532086.0, 536226.0, 539372.0, 623663.0, 648669.0, 111476.32785508224, 129067.35466322796, 145862.0, 147340.0, 150568.0, 441.6510956344452, 459.11161901720277, 461.91223667503067, 462.24653814282505, 464.6724059538018, 9269.536523173949, 10451.58193672275, 11242.606508772154, 11473.36896470702, 11847.052235821286, 40317.0, 48967.75516122397, 57288.85422291614, 59330.406695932485, 59868.70065649644, 67034.0, 85248.57375713081, 85911.14088859031, 86545.0, 87127.0, 8021.2379823916635, 8047.476914000571, 8187.877181842397, 8261.421700480909, 8268.503889766633, 9444.386114902509, 11937.4031298433, 13016.023798215361, 13547.051706380458, 13725.176489410667, 9694.854577181206, 11275.887241127812, 11290.435478225892, 11511.539538418705, 11680.240784348991, 11252.043576295779, 11273.379964101725, 11647.941760291144, 11672.299662020307, 12016.459259333526, 11312.717182070513, 11348.375839328915, 11711.590094346657, 11759.412029398325, 11898.226615270327, 8051.557164356017, 8133.4713243641345, 8317.708880189164, 8345.207205315486, 8512.0, 8094.231048050426, 10932.398718070583, 11060.612878549535, 11076.335419874833, 11413.771724565297], "value": 9005.291680807111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.639846436855, 1539.4457995121759, 1703.412322748652, 1776.1652023548927, 1815.9364422245224, 7859.135495095549, 8348.874766878502, 8418.410711250215, 8865.999999999993, 8871.024187339395, 8482.745517634481, 8649.135086491347, 8656.047834738174, 8665.436746611465, 8726.345524085704, 2310.7689231076843, 2328.266596022256, 2351.623740201568, 2355.7644235576477, 2357.045396614374, 2305.7694230576976, 2345.3550273674705, 2351.6472529120597, 2354.75275096115, 2355.0462062864567, 2335.9416014599688, 2347.436615212354, 2359.681443005198, 2372.9169479068237, 2373.632087026505, 1796.8949096305807, 2226.9199438272426, 2338.3920180752957, 2346.5306938612175, 2356.1386504661295, 1941.4758015335922, 1943.2712732725229, 2223.8665680059084, 2328.0455013444407, 2329.557384097016, 8729.60716767747, 8790.42862213954, 8795.560221988939, 8804.16360445763, 8809.471431714117, 5148.433672296044, 5214.243934629495, 5273.393559740641, 5300.814471493518, 5320.414754377015, 3479.982600087009, 3550.0769799851964, 3632.8546858125906, 3650.8357123929222, 3664.8167591620577, 952.7999120184769, 956.7082039977804, 1066.914646828252, 1119.1774046076127, 1120.1878637987395, 11333.603323883624, 11383.03244224242, 11460.369679667698, 11474.139439542068, 11489.310641361462, 4546.272596384562, 4625.468071171791, 4778.187708089633, 4800.231962885991, 4808.783604737795, 9692.75768105803, 9783.11951924316, 9785.217182625373, 9819.950900245596, 9820.0, 5233.110371236899, 5277.313949186581, 5278.683279003272, 5284.7886084556185, 5285.524302812765, 4389.231884420214, 4690.273007683814, 4824.228123500293, 4833.564979151823, 4850.854474365775, 3382.8477718502727, 3695.0577602711674, 3756.73702840804, 3941.349677303213, 3950.229705207457, 1265.3230521671046, 1274.8278982337451, 1279.33474593211, 1287.1762072273752, 1290.619267316144, 845.5687599324389, 899.4648184330313, 914.7027216154643, 924.2698268367914, 950.8668786369914, 5728.283964504437, 5804.709764511757, 5954.166416701665, 5983.760649574056, 6175.907361389583, 429.4996329276358, 434.1707338982528, 437.9912401752011, 448.83617479619704, 461.82681494439584, 3877.65101140893, 3959.1685745993086, 4063.2686116499312, 4081.163361510883, 4083.8774836754947, 10146.847797283046, 10486.63296784624, 10582.0, 10631.46842657864, 10660.946695266473, 10406.739831504274, 10474.685759427077, 10498.055175034284, 10563.207759418074, 10610.522526486327, 8021.759347219593, 8085.757427277191, 8155.877661835078, 8157.959210203911, 8163.183681631789, 5921.17103605487, 5944.762209511744, 5985.0, 6022.066579680157, 6202.28673702512, 9533.237341012564, 9640.75898102553, 9744.415335079917, 9814.165795907142, 9942.254330925354, 9725.173360264174, 10033.14718248957, 10060.647877324258, 10136.543855526372, 10137.0, 6847.589144651337, 7159.031266401781, 7238.565686058853, 7380.409567234716, 7481.925180748341, 8202.671893124209, 8264.049634292134, 8371.41400101987, 8375.581220938806, 8381.455205411628, 7418.777436676908, 7496.325330720261, 7498.175200728025, 7573.507721998052, 7668.463207575416, 7238.0952380952385, 7296.562206267641, 7358.190599033995, 7436.962815186106, 7449.8882516761205, 6936.965315173392, 6967.1291088613925, 7018.33325834045, 7022.262662420372, 7028.964855175692, 4898.583620392306, 4898.681585696918, 5087.313212716236, 5111.258867464123, 5114.71869047206, 5021.096202683552, 5043.697378157322, 5108.208227724708, 5145.331106956221, 5203.11547036997], "value": 4463.95224729344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [246.54635470733857, 282.45627167702173, 305.8088694565896, 311.0605969970688, 311.0885106637554, 5279.577633789298, 5361.624686271963, 5521.944780552203, 5656.123300888358, 5692.516136128429, 5567.3040869891265, 5590.552755779538, 5597.916031259534, 5605.383407825136, 5632.3804381518, 3392.6268110507826, 4282.721623094497, 4295.441592592959, 4301.505127026333, 4303.397524346578, 4049.2913740095364, 4187.769672668002, 4288.421063156481, 4290.6138447539715, 4291.249031419489, 4081.4898137732785, 4178.934371735203, 4208.221479026374, 4221.7889105544755, 4223.725457845246, 4204.936925946114, 4227.196832601827, 4245.1934132514725, 4245.915081698348, 4261.955820823918, 3492.528508651325, 3631.927361452756, 3676.981615091934, 3680.9447858282147, 3682.650148235913, 4462.928897064714, 5366.758495867695, 5376.542993845528, 5420.376656684492, 5423.647462914937, 4766.285057241407, 4784.923392236754, 4862.708237505725, 4877.804887804519, 4905.705657660552, 4650.023495066041, 5331.481222393202, 5410.404855465896, 5900.604049982748, 5955.761769529214, 3272.0, 3881.825317860703, 3895.6299151580556, 3917.6092487167216, 3925.391564307537, 5077.339945807022, 6083.878322433571, 6110.358412366682, 6117.9082313765775, 6120.571559990803, 3973.5033120859894, 3980.920381592352, 3985.5217373915316, 3999.480067591253, 4023.7786921719585, 3796.905077373088, 3865.304245235828, 3971.205758848242, 4015.13674559971, 4019.91960160801, 4673.836415725434, 4688.765561721901, 4721.173794585934, 4733.0, 4761.262004389325, 5130.538251557303, 5852.502537284294, 5891.587588868823, 5908.615939963888, 5910.852228694317, 1154.370867877009, 1157.3518829455531, 1232.3037483821613, 1376.4356613788298, 1397.82527184102, 757.4130049211905, 777.9961100194575, 784.3137254901961, 797.8803179523002, 874.580201503282, 4186.413902053715, 4730.905381892343, 5372.952274306473, 5404.081306177959, 5465.617406781566, 5066.6453348266, 5320.466714616832, 5746.683932383676, 5917.852053698692, 6021.397860213943, 5217.860677122361, 5424.589606702286, 5444.597126795753, 5474.562035037187, 5503.367112782002, 2230.8884555772147, 2324.9770101155436, 2390.5338459000327, 2581.767640912327, 2623.6720409948757, 4774.21225497789, 5245.557471695238, 5257.0, 5264.842054738364, 5278.9208161877605, 4679.064187162581, 4757.809687612456, 4848.0, 5010.824621138243, 6284.622922624657, 5342.439043900412, 5607.710226647894, 5873.854598353366, 6319.33646967071, 6419.743210271537, 5501.3948465667945, 5724.856878578069, 6005.669688167192, 6080.8783824324155, 6164.815055548341, 5316.856875771728, 5405.0, 5649.734450489854, 5988.970055149871, 6025.548083893813, 5252.789888404421, 6287.862126876884, 6356.044439335731, 6397.232332120176, 6400.447751497777, 3545.9290814183055, 3645.5807582127336, 3758.605346438694, 3923.05846596809, 3960.5049368828895, 5662.801801936913, 5963.403659634002, 5973.850653733692, 6019.307779605401, 6022.247219097613, 5764.654120752768, 5827.358990511125, 5839.824805255849, 5839.963219126115, 5842.38654941242, 4753.952460475351, 5128.564072053917, 5739.8852022960145, 5796.0, 5854.209681692917, 5186.818461353834, 5281.84154475351, 5611.354694210218, 5653.971730141323, 5697.663957777291, 5820.679862607597, 5854.0, 5857.824265271878, 5867.9413205867395, 5897.439743224387, 5401.621886468067, 5530.529904957963, 5650.039493286234, 5735.426457354231, 5737.110747834093], "value": 4164.850901331135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.1608609883385, 727.785303335516, 742.7697413801718, 755.165542076006, 778.2606523802385, 15332.54002379929, 15997.040177589353, 16441.177941102957, 16557.08936008522, 16707.832921670793, 14798.186099764509, 14801.481948131817, 14842.851571484282, 14970.401183952628, 14974.0, 835.8161204535007, 850.1668365002301, 860.3590325207729, 863.0, 864.2092485375905, 681.0839420978775, 786.8662327404355, 860.9009963854143, 871.2289623683023, 872.2280781508348, 917.4953775423523, 920.5719340506663, 921.9400738951947, 922.9630814767402, 924.4638109896244, 899.5142622983581, 903.290916630442, 910.8588168833842, 911.1435250864199, 918.5223683684513, 663.515633587479, 663.6913835066717, 671.7212356871893, 677.420805211542, 679.9830004249884, 14457.493987710379, 14637.560873173821, 14649.047811892193, 14692.48576299835, 14733.189674567895, 14715.63210919725, 14730.55808325752, 14781.33483993223, 15056.096634201984, 15066.472673456487, 11960.880391196064, 12133.029357651367, 12362.01103911685, 12369.567065152767, 12454.688632784162, 3861.3049651062797, 3870.2259548090497, 4038.2932986727205, 4096.037431203665, 4098.446709694183, 115271.42364288209, 117646.11777410026, 118249.0, 119095.4045229777, 119262.21106683406, 11140.944295278634, 11170.0, 11301.49143288554, 11452.94273528627, 11791.705207369885, 23238.53522929532, 23285.0, 23307.883460582587, 23316.417089572897, 23325.88337058304, 8074.152214017561, 8230.42387032914, 8240.876386854203, 8242.958785206036, 8313.244066034724, 4468.687191896601, 4484.394606728115, 4520.186366454004, 4535.307483108156, 4652.069586082797, 3002.4745669507747, 3611.115276757211, 3684.6868016218386, 3688.170161713593, 3688.8155592220282, 572.3446653581626, 601.6149664214906, 602.4908951935607, 636.3286732497168, 639.8144538083997, 581.2617975171509, 586.8796896636179, 634.2452481546944, 663.8572706868047, 679.7654809090856, 9169.266458683289, 9660.806783864424, 9692.0, 9713.417194968324, 9866.260030497742, 541.9647722898, 554.9411682657386, 571.5227784799739, 672.4586707700348, 674.8886433738378, 3912.9608703912595, 3948.4198329937135, 4071.491063617048, 4152.211079894811, 4493.932591011137, 125241.0, 127404.36297818452, 127878.36060819637, 132842.0, 153027.0, 74541.0, 77191.61404192942, 77716.2228377709, 89470.65794013096, 104199.47900260451, 88488.67266990872, 91900.54049729843, 111250.44374778237, 111457.0, 111921.44039279752, 9830.181416437981, 9965.40207587547, 10068.345557538736, 10076.445795481319, 10216.693499195037, 52478.0, 53172.73413632907, 61815.0, 62255.06617400652, 65217.2391555388, 74078.62960685378, 90010.0, 93226.0, 94566.05433945573, 97036.51481742546, 13232.272225027717, 13267.336633168496, 13428.93285533566, 13534.729305414034, 13720.725585488433, 15175.089494630358, 15313.157776322409, 15322.846771532588, 15434.536963891102, 15672.76490852661, 13955.162690238618, 13959.860401395856, 14176.858231417555, 14467.782983255049, 14624.561263162122, 13770.173789572658, 14002.229877356436, 14051.859481405463, 14360.712785744436, 14511.056781309604, 13474.326283685972, 13516.5269215577, 13591.660208494472, 13756.793648095087, 14076.240469941258, 11070.889291106985, 11303.491342889754, 11345.546178152781, 11354.205205635526, 12071.456784444545, 9258.861117083385, 9847.753806154904, 10393.58425662965, 11018.686075924146, 11567.479463423997], "value": 7780.401958272057, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 110.0, 118.0, 118.0, 129.0, 169.0, 163.0, 118.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 136.0, 123.0, 182.0, 136.0, 159.0, 130.0, 112.0, 162.0, 111.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [269.0, 205.0, 253.0, 275.0, 205.0, 268.0, 283.0, 199.0, 202.0, 196.0], "value": 235.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 77.0, 139.0, 74.0, 87.0, 83.0, 65.0, 130.0, 52.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 86.0, 146.0, 71.0, 72.0, 86.0, 126.0, 96.0, 99.0, 150.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 90.0, 91.0, 120.0, 110.0, 88.0, 103.0, 128.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 150.0, 146.0, 111.0, 149.0, 124.0, 96.0, 96.0, 99.0, 94.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 92.0, 91.0, 105.0, 146.0, 148.0, 91.0, 92.0, 114.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 58.0, 58.0, 58.0, 58.0, 61.0, 57.0, 56.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 68.0, 70.0, 77.0, 80.0, 74.0, 69.0, 69.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 87.0, 76.0, 105.0, 106.0, 108.0, 106.0, 96.0], "value": 94.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 138.0, 138.0, 138.0, 138.0, 138.0, 161.0, 160.0, 137.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 173.0, 225.0, 186.0, 171.0, 168.0, 165.0, 170.0, 154.0, 169.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 65.0, 81.0, 93.0, 90.0, 88.0, 68.0, 72.0], "value": 76.2, "unit": "score"}]}]} 08:55:59 INFO - Return code: 0 08:55:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:00 ERROR - # TBPL SUCCESS # 08:56:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:00 INFO - 2016-08-22 08:56:00.023 screenresolution[1668:10228] starting screenresolution argv=screenresolution get 08:56:00 INFO - 2016-08-22 08:56:00.025 screenresolution[1668:10228] Display 0: 1600x1200x32@60 08:56:00 INFO - 2016-08-22 08:56:00.031 screenresolution[1669:10231] starting screenresolution argv=screenresolution list 08:56:00 INFO - Available Modes on Display 0 08:56:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:00 INFO - Intel Iris: 08:56:00 INFO - Chipset Model: Intel Iris 08:56:00 INFO - Type: GPU 08:56:00 INFO - Bus: Built-In 08:56:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:00 INFO - Vendor: Intel (0x8086) 08:56:00 INFO - Device ID: 0x0a2e 08:56:00 INFO - Revision ID: 0x0009 08:56:00 INFO - Displays: 08:56:00 INFO - Display: 08:56:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:00 INFO - Display Serial Number: 1600x1200 60 08:56:00 INFO - Main Display: Yes 08:56:00 INFO - Mirror: Off 08:56:00 INFO - Online: Yes 08:56:00 INFO - Rotation: Supported 08:56:00 INFO - Return code: 0 08:56:00 INFO - Running post-action listener: _resource_record_post_action 08:56:00 INFO - [mozharness: 2016-08-22 15:56:00.266230Z] Finished run-tests step (success) 08:56:00 INFO - Running post-run listener: _resource_record_post_run 08:56:00 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 38228992; Write bytes: 708308992; Read time: 371; Write time: 2092 08:56:00 INFO - TinderboxPrint: CPU usage
54.5% 08:56:00 INFO - TinderboxPrint: I/O read bytes / time
38,228,992 / 371 08:56:00 INFO - TinderboxPrint: I/O write bytes / time
708,308,992 / 2,092 08:56:00 INFO - TinderboxPrint: CPU idle
2,203.9 (45.5%) 08:56:00 INFO - TinderboxPrint: CPU system
986.8 (20.4%) 08:56:00 INFO - TinderboxPrint: CPU user
1,655.0 (34.2%) 08:56:00 INFO - TinderboxPrint: Swap in / out
444,416,000 / 0 08:56:00 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393679360; Write bytes: 388184064; Read time: 29415; Write time: 691 08:56:00 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36418560; Write bytes: 298002432; Read time: 352; Write time: 1352 08:56:00 INFO - Running post-run listener: _upload_blobber_files 08:56:00 INFO - Blob upload gear active. 08:56:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:56:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:02 INFO - (blobuploader) - INFO - Done attempting. 08:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:03 INFO - (blobuploader) - INFO - Done attempting. 08:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:05 INFO - (blobuploader) - INFO - Done attempting. 08:56:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:56:05 INFO - Return code: 0 08:56:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:56:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:56:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcfe5d80e457e4eb377a54288e713112a0e455543fc0bd248a2d982b43e9c797320633126d254210f8ad9fc520d055c0582c2c81e4b2daad8a54387b8cb90768", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/935e0550b31ade7bae8bac304a2bfab0f171fc574e9e84ee35148bdbcaa953c5a715e382464e57db2a6d6416ed05120d8a9207ece20742823c88b3f5f3a87860", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eb35c6a162258c5da40cf22c1fc89a2bfe43e1aeab25a61fb1335f57fa9d3a11a2436c65f696deb4651661238c495cb59a1415a93d27d77e21be1ff8a5f5723"} 08:56:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:56:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:56:05 INFO - Contents: 08:56:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcfe5d80e457e4eb377a54288e713112a0e455543fc0bd248a2d982b43e9c797320633126d254210f8ad9fc520d055c0582c2c81e4b2daad8a54387b8cb90768", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/935e0550b31ade7bae8bac304a2bfab0f171fc574e9e84ee35148bdbcaa953c5a715e382464e57db2a6d6416ed05120d8a9207ece20742823c88b3f5f3a87860", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eb35c6a162258c5da40cf22c1fc89a2bfe43e1aeab25a61fb1335f57fa9d3a11a2436c65f696deb4651661238c495cb59a1415a93d27d77e21be1ff8a5f5723"} 08:56:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:56:05 INFO - Copying logs to upload dir... 08:56:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:56:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.147279 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-22 08:56:05.780745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:56:05.784029) ========= 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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcfe5d80e457e4eb377a54288e713112a0e455543fc0bd248a2d982b43e9c797320633126d254210f8ad9fc520d055c0582c2c81e4b2daad8a54387b8cb90768", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/935e0550b31ade7bae8bac304a2bfab0f171fc574e9e84ee35148bdbcaa953c5a715e382464e57db2a6d6416ed05120d8a9207ece20742823c88b3f5f3a87860", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eb35c6a162258c5da40cf22c1fc89a2bfe43e1aeab25a61fb1335f57fa9d3a11a2436c65f696deb4651661238c495cb59a1415a93d27d77e21be1ff8a5f5723"} build_url:https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/Q-IY8UkdQq6n5d1y93ltQw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcfe5d80e457e4eb377a54288e713112a0e455543fc0bd248a2d982b43e9c797320633126d254210f8ad9fc520d055c0582c2c81e4b2daad8a54387b8cb90768", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/935e0550b31ade7bae8bac304a2bfab0f171fc574e9e84ee35148bdbcaa953c5a715e382464e57db2a6d6416ed05120d8a9207ece20742823c88b3f5f3a87860", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8eb35c6a162258c5da40cf22c1fc89a2bfe43e1aeab25a61fb1335f57fa9d3a11a2436c65f696deb4651661238c495cb59a1415a93d27d77e21be1ff8a5f5723"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:56:05.819282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:56:05.819793) ========= 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.n6wNc7HTPp/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.PUXDZkQeVr/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005092 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:56:05.870504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:56:05.871129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:56:05.871853) ========= ========= Total master_lag: 0.18 =========