builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0144 starttime: 1492117971.55 results: success (0) buildid: 20170413130423 builduid: 6c528a56e9c64691b7267f2e9699d3fc revision: 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.547128) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.547557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.547829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.574097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.574423) ========= 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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 --2017-04-13 14:12:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.5M=0s 2017-04-13 14:12:51 (27.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.696057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.696391) ========= 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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.029394 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:51.747208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 14:12:51.747579) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 --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 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 2017-04-13 14:12:51,851 truncating revision to first 12 chars 2017-04-13 14:12:51,851 Setting DEBUG logging. 2017-04-13 14:12:51,851 attempt 1/10 2017-04-13 14:12:51,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3243c8fc3ce7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-13 14:12:52,591 unpacking tar archive at: mozilla-central-3243c8fc3ce7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008857 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-13 14:12:52.785145) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:52.785688) ========= script_repo_revision: 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:52.786172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:52.786511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-13 14:12:52.807235) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-13 14:12:52.807907) ========= /tools/buildbot/bin/python -u 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', '-u', '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:12:53 INFO - MultiFileLogger online at 20170413 14:12:53 in /builds/slave/test 14:12:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:12:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:53 INFO - {'append_to_log': False, 14:12:53 INFO - 'base_work_dir': '/builds/slave/test', 14:12:53 INFO - 'blob_upload_branch': 'Firefox', 14:12:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:53 INFO - 'branch': 'Firefox', 14:12:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:53 INFO - 'config_files': ('talos/mac_config.py',), 14:12:53 INFO - 'default_actions': ('clobber', 14:12:53 INFO - 'read-buildbot-config', 14:12:53 INFO - 'download-and-extract', 14:12:53 INFO - 'populate-webroot', 14:12:53 INFO - 'create-virtualenv', 14:12:53 INFO - 'install', 14:12:53 INFO - 'run-tests'), 14:12:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:53 INFO - 'download_minidump_stackwalk': True, 14:12:53 INFO - 'download_symbols': 'ondemand', 14:12:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:53 INFO - 'gecko_profile': False, 14:12:53 INFO - 'gecko_profile_interval': 0, 14:12:53 INFO - 'installer_path': 'installer.exe', 14:12:53 INFO - 'log_level': 'info', 14:12:53 INFO - 'log_name': 'talos', 14:12:53 INFO - 'log_to_console': True, 14:12:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:12:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:12:53 INFO - 'opt_config_files': (), 14:12:53 INFO - 'pip_index': False, 14:12:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:12:53 INFO - 'cmd': ('bash', 14:12:53 INFO - '-c', 14:12:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:12:53 INFO - 'enabled': True, 14:12:53 INFO - 'halt_on_failure': False, 14:12:53 INFO - 'name': 'check_screen_resolution'},), 14:12:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:12:53 INFO - 'cmd': ('bash', 14:12:53 INFO - '-c', 14:12:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:12:53 INFO - 'enabled': True, 14:12:53 INFO - 'halt_on_failure': False, 14:12:53 INFO - 'name': 'check_screen_resolution'},), 14:12:53 INFO - 'run_cmd_checks_enabled': True, 14:12:53 INFO - 'suite': 'dromaeojs-e10s', 14:12:53 INFO - 'system_bits': '32', 14:12:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:53 INFO - 'title': 't-yosemite-r7-0144', 14:12:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:53 INFO - 'use_talos_json': True, 14:12:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:53 INFO - 'work_dir': 'build'} 14:12:53 INFO - [mozharness: 2017-04-13 21:12:53.021914Z] Running clobber step. 14:12:53 INFO - Running pre-action listener: _resource_record_pre_action 14:12:53 INFO - Running main action method: clobber 14:12:53 INFO - rmtree: /builds/slave/test/build 14:12:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:55 INFO - Running post-action listener: _resource_record_post_action 14:12:55 INFO - [mozharness: 2017-04-13 21:12:55.628122Z] Finished clobber step (success) 14:12:55 INFO - [mozharness: 2017-04-13 21:12:55.628251Z] Running read-buildbot-config step. 14:12:55 INFO - Running pre-action listener: _resource_record_pre_action 14:12:55 INFO - Running main action method: read_buildbot_config 14:12:55 INFO - Using buildbot properties: 14:12:55 INFO - { 14:12:55 INFO - "project": "", 14:12:55 INFO - "product": "firefox", 14:12:55 INFO - "script_repo_revision": "production", 14:12:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:12:55 INFO - "repository": "", 14:12:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:12:55 INFO - "buildid": "20170413130423", 14:12:55 INFO - "pgo_build": "False", 14:12:55 INFO - "basedir": "/builds/slave/test", 14:12:55 INFO - "buildnumber": 21, 14:12:55 INFO - "slavename": "t-yosemite-r7-0144", 14:12:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:12:55 INFO - "platform": "yosemite_r7", 14:12:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:12:55 INFO - "branch": "mozilla-central", 14:12:55 INFO - "repo_path": "mozilla-central", 14:12:55 INFO - "revision": "3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4", 14:12:55 INFO - "stage_platform": "macosx64", 14:12:55 INFO - "builduid": "6c528a56e9c64691b7267f2e9699d3fc", 14:12:55 INFO - "slavebuilddir": "test" 14:12:55 INFO - } 14:12:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:12:55 INFO - Running post-action listener: _resource_record_post_action 14:12:55 INFO - [mozharness: 2017-04-13 21:12:55.631823Z] Finished read-buildbot-config step (success) 14:12:55 INFO - [mozharness: 2017-04-13 21:12:55.631957Z] Running download-and-extract step. 14:12:55 INFO - Running pre-action listener: _resource_record_pre_action 14:12:55 INFO - Running main action method: download_and_extract 14:12:55 INFO - mkdir: /builds/slave/test/build/tests 14:12: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')]} 14:12:55 INFO - trying https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:12:55 INFO - Downloading https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:12:56 INFO - Downloaded 1325 bytes. 14:12:56 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:12:56 INFO - Using the following test package requirements: 14:12:56 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:12:56 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:12:56 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:12:56 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:12:56 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'jsshell-mac.zip'], 14:12:56 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:12:56 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:12:56 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:12:56 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:12:56 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:12:56 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:12:56 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:12:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:12:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:12:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:12:56 INFO - Fetch https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:12:58 INFO - Expected file size: 52595525 14:12:58 INFO - Obtained file size: 52595525 14:13:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:13:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:13:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:13:14 INFO - Fetch https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:13:16 INFO - Expected file size: 52595525 14:13:16 INFO - Obtained file size: 52595525 14:13:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:13:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:13:31 INFO - Fetch https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:13:32 INFO - Expected file size: 14408853 14:13:32 INFO - Obtained file size: 14408853 14:13: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')]} 14:13:33 INFO - trying https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:13:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:13:35 INFO - Downloaded 71087177 bytes. 14:13:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:13:35 INFO - mkdir: /builds/slave/test/properties 14:13:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:13:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:13:35 INFO - Contents: 14:13:35 INFO - build_url:https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:13:35 INFO - Running post-action listener: _resource_record_post_action 14:13:35 INFO - Running post-action listener: set_extra_try_arguments 14:13:35 INFO - [mozharness: 2017-04-13 21:13:35.978302Z] Finished download-and-extract step (success) 14:13:35 INFO - [mozharness: 2017-04-13 21:13:35.978416Z] Running populate-webroot step. 14:13:35 INFO - Running pre-action listener: _resource_record_pre_action 14:13:35 INFO - Running main action method: populate_webroot 14:13:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:13:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:13:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:13:35 INFO - '--tppagecycles', 14:13:35 INFO - '7'], 14:13:35 INFO - 'tests': ['tsvgm']}}, 14:13:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:13:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:13:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:13:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:13:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:13:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['damp', 'tps']}, 14:13:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'tests': ['damp', 'tps']}, 14:13:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['dromaeo_dom']}, 14:13:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:13:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:13:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:13:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'other-e10s': {'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['a11yr', 14:13:35 INFO - 'ts_paint', 14:13:35 INFO - 'tpaint', 14:13:35 INFO - 'sessionrestore', 14:13:35 INFO - 'sessionrestore_no_auto_restore', 14:13:35 INFO - 'tabpaint']}, 14:13:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:13:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:13:35 INFO - 'bloom_basic_ref']}, 14:13:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['tsvgx', 14:13:35 INFO - 'tsvgr_opacity', 14:13:35 INFO - 'tart', 14:13:35 INFO - 'tscrollx', 14:13:35 INFO - 'cart', 14:13:35 INFO - 'tsvg_static']}, 14:13:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:13:35 INFO - 'tsvgr_opacity', 14:13:35 INFO - 'tart', 14:13:35 INFO - 'tscrollx', 14:13:35 INFO - 'cart', 14:13:35 INFO - 'tsvg_static']}, 14:13:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'talos_options': ['--disable-e10s'], 14:13:35 INFO - 'tests': ['tp5o']}, 14:13:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:13:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'talos_options': ['--disable-e10s', 14:13:35 INFO - '--xperf_path', 14:13:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:35 INFO - 'tests': ['tp5n']}, 14:13:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:13:35 INFO - 'talos_options': ['--xperf_path', 14:13:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:13:35 INFO - 'tests': ['tp5n']}}, 14:13:35 INFO - 'talos.zip': {'path': '', 14:13:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:13:35 INFO - Running post-action listener: _resource_record_post_action 14:13:35 INFO - [mozharness: 2017-04-13 21:13:35.996995Z] Finished populate-webroot step (success) 14:13:35 INFO - [mozharness: 2017-04-13 21:13:35.997106Z] Running create-virtualenv step. 14:13:35 INFO - Running pre-action listener: _resource_record_pre_action 14:13:35 INFO - Running main action method: create_virtualenv 14:13:35 INFO - Creating virtualenv /builds/slave/test/build/venv 14:13:35 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 14:13:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:13:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:13:36 INFO - Using real prefix '/tools/python27' 14:13:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:13:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:13:39 INFO - Installing pip.................done. 14:13:39 INFO - Return code: 0 14:13:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:13:39 INFO - Reading from file tmpfile_stdout 14:13:39 INFO - Output received: 14:13:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:13:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:13:39 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')]} 14:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:39 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')]} 14:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:39 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:39 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 14:13:39 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 14:13:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:39 INFO - 'HOME': '/Users/cltbld', 14:13:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:39 INFO - 'LOGNAME': 'cltbld', 14:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:39 INFO - 'MOZ_NO_REMOTE': '1', 14:13:39 INFO - 'NO_EM_RESTART': '1', 14:13:39 INFO - 'PAGER': '/bin/cat', 14:13:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:39 INFO - 'PWD': '/builds/slave/test', 14:13:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:39 INFO - 'SHELL': '/bin/bash', 14:13:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:39 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:39 INFO - 'USER': 'cltbld', 14:13:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:39 INFO - 'XPC_FLAGS': '0x0', 14:13:39 INFO - 'XPC_SERVICE_NAME': '0', 14:13:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:40 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 14:13:40 INFO - Cleaning up... 14:13:40 INFO - Return code: 0 14:13:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:40 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:40 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 14:13:40 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 14:13:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:40 INFO - 'HOME': '/Users/cltbld', 14:13:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:40 INFO - 'LOGNAME': 'cltbld', 14:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:40 INFO - 'MOZ_NO_REMOTE': '1', 14:13:40 INFO - 'NO_EM_RESTART': '1', 14:13:40 INFO - 'PAGER': '/bin/cat', 14:13:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:40 INFO - 'PWD': '/builds/slave/test', 14:13:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:40 INFO - 'SHELL': '/bin/bash', 14:13:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:40 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:40 INFO - 'USER': 'cltbld', 14:13:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:40 INFO - 'XPC_FLAGS': '0x0', 14:13:40 INFO - 'XPC_SERVICE_NAME': '0', 14:13:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:40 INFO - Downloading/unpacking psutil>=3.1.1 14:13:40 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 14:13:40 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 14:13:40 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 14:13:40 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 14:13:40 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 14:13:40 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 14:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:44 INFO - Installing collected packages: psutil 14:13:44 INFO - Running setup.py install for psutil 14:13:44 INFO - building 'psutil._psutil_osx' extension 14:13:44 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 14:13:44 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 14:13:44 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 14:13:44 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 14:13:44 INFO - building 'psutil._psutil_posix' extension 14:13:44 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 14:13:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:13:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:13:45 INFO - ^ 14:13:45 INFO - 1 warning generated. 14:13:45 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 14:13:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:13:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:13:45 INFO - Successfully installed psutil 14:13:45 INFO - Cleaning up... 14:13:45 INFO - Return code: 0 14:13:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:45 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:45 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 14:13:45 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 14:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:45 INFO - 'HOME': '/Users/cltbld', 14:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:45 INFO - 'LOGNAME': 'cltbld', 14:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:45 INFO - 'MOZ_NO_REMOTE': '1', 14:13:45 INFO - 'NO_EM_RESTART': '1', 14:13:45 INFO - 'PAGER': '/bin/cat', 14:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:45 INFO - 'PWD': '/builds/slave/test', 14:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:45 INFO - 'SHELL': '/bin/bash', 14:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:45 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:45 INFO - 'USER': 'cltbld', 14:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:45 INFO - 'XPC_FLAGS': '0x0', 14:13:45 INFO - 'XPC_SERVICE_NAME': '0', 14:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:13:48 INFO - Installing collected packages: mozsystemmonitor 14:13:48 INFO - Running setup.py install for mozsystemmonitor 14:13:48 INFO - Successfully installed mozsystemmonitor 14:13:48 INFO - Cleaning up... 14:13:48 INFO - Return code: 0 14:13:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:13: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')]} 14:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13: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')]} 14:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:49 INFO - 'HOME': '/Users/cltbld', 14:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:49 INFO - 'LOGNAME': 'cltbld', 14:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:49 INFO - 'MOZ_NO_REMOTE': '1', 14:13:49 INFO - 'NO_EM_RESTART': '1', 14:13:49 INFO - 'PAGER': '/bin/cat', 14:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:49 INFO - 'PWD': '/builds/slave/test', 14:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:49 INFO - 'SHELL': '/bin/bash', 14:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:49 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:49 INFO - 'USER': 'cltbld', 14:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:49 INFO - 'XPC_FLAGS': '0x0', 14:13:49 INFO - 'XPC_SERVICE_NAME': '0', 14:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:49 INFO - Downloading/unpacking jsonschema==2.5.1 14:13:49 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 14:13:49 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 14:13:49 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 14:13:49 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 14:13:49 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 14:13:49 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 14:13:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:13:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:13:52 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 14:13:52 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 14:13:52 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 14:13:52 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 14:13:52 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 14:13:52 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 14:13:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:13:52 INFO - warning: no files found matching '*.txt' 14:13:52 INFO - no previously-included directories found matching 'build' 14:13:52 INFO - no previously-included directories found matching 'dist' 14:13:52 INFO - no previously-included directories found matching '.git*' 14:13:52 INFO - Installing collected packages: jsonschema, functools32 14:13:52 INFO - Running setup.py install for functools32 14:13:52 INFO - warning: no files found matching '*.txt' 14:13:52 INFO - no previously-included directories found matching 'build' 14:13:52 INFO - no previously-included directories found matching 'dist' 14:13:52 INFO - no previously-included directories found matching '.git*' 14:13:52 INFO - Successfully installed jsonschema functools32 14:13:52 INFO - Cleaning up... 14:13:53 INFO - Return code: 0 14:13:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:53 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:53 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 14:13:53 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 14:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:53 INFO - 'HOME': '/Users/cltbld', 14:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:53 INFO - 'LOGNAME': 'cltbld', 14:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:53 INFO - 'MOZ_NO_REMOTE': '1', 14:13:53 INFO - 'NO_EM_RESTART': '1', 14:13:53 INFO - 'PAGER': '/bin/cat', 14:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:53 INFO - 'PWD': '/builds/slave/test', 14:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:53 INFO - 'SHELL': '/bin/bash', 14:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:53 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:53 INFO - 'USER': 'cltbld', 14:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:53 INFO - 'XPC_FLAGS': '0x0', 14:13:53 INFO - 'XPC_SERVICE_NAME': '0', 14:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:13:53 INFO - Cleaning up... 14:13:53 INFO - Return code: 0 14:13:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:53 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:53 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 14:13:53 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 14:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:53 INFO - 'HOME': '/Users/cltbld', 14:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:53 INFO - 'LOGNAME': 'cltbld', 14:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:53 INFO - 'MOZ_NO_REMOTE': '1', 14:13:53 INFO - 'NO_EM_RESTART': '1', 14:13:53 INFO - 'PAGER': '/bin/cat', 14:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:53 INFO - 'PWD': '/builds/slave/test', 14:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:53 INFO - 'SHELL': '/bin/bash', 14:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:53 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:53 INFO - 'USER': 'cltbld', 14:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:53 INFO - 'XPC_FLAGS': '0x0', 14:13:53 INFO - 'XPC_SERVICE_NAME': '0', 14:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:13:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:13:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:56 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 14:13:57 INFO - Downloading docopt-0.6.1.tar.gz 14:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:13:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:13:57 INFO - Running setup.py install for blobuploader 14:13:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:13:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:13:57 INFO - Running setup.py install for requests 14:13:58 INFO - Running setup.py install for docopt 14:13:58 INFO - Successfully installed blobuploader requests docopt 14:13:58 INFO - Cleaning up... 14:13:58 INFO - Return code: 0 14:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:58 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:13:58 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 14:13:58 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 14:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:13:58 INFO - 'HOME': '/Users/cltbld', 14:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:13:58 INFO - 'LOGNAME': 'cltbld', 14:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:58 INFO - 'MOZ_NO_REMOTE': '1', 14:13:58 INFO - 'NO_EM_RESTART': '1', 14:13:58 INFO - 'PAGER': '/bin/cat', 14:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:58 INFO - 'PWD': '/builds/slave/test', 14:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:13:58 INFO - 'SHELL': '/bin/bash', 14:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:13:58 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:13:58 INFO - 'USER': 'cltbld', 14:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:58 INFO - 'XPC_FLAGS': '0x0', 14:13:58 INFO - 'XPC_SERVICE_NAME': '0', 14:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:13:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-6oduQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:13:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-fxeE00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:13:58 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zZC0z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-bC4IcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cQTw4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-YzAf9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-b7ijgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-5L0XsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-S_xyJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-i6Lyfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-ZCpQw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-oiVfLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:13:59 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-29H4c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:00 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-yY_Msh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:00 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-2_RZXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:00 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-q4SiP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:00 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-WRwW0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:14:00 INFO - Running setup.py install for manifestparser 14:14:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:14:00 INFO - Running setup.py install for mozcrash 14:14:00 INFO - Running setup.py install for mozdebug 14:14:00 INFO - Running setup.py install for mozdevice 14:14:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Running setup.py install for mozfile 14:14:01 INFO - Running setup.py install for mozhttpd 14:14:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Running setup.py install for mozinfo 14:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Running setup.py install for mozInstall 14:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Running setup.py install for mozleak 14:14:01 INFO - Running setup.py install for mozlog 14:14:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:14:01 INFO - Running setup.py install for moznetwork 14:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Running setup.py install for mozprocess 14:14:02 INFO - Running setup.py install for mozprofile 14:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Running setup.py install for mozrunner 14:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Running setup.py install for mozscreenshot 14:14:02 INFO - Running setup.py install for moztest 14:14:02 INFO - Running setup.py install for mozversion 14:14:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:14:02 INFO - Cleaning up... 14:14:02 INFO - Return code: 0 14:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:02 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:14:02 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 14:14:02 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 14:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:02 INFO - 'HOME': '/Users/cltbld', 14:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:02 INFO - 'LOGNAME': 'cltbld', 14:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:02 INFO - 'MOZ_NO_REMOTE': '1', 14:14:02 INFO - 'NO_EM_RESTART': '1', 14:14:02 INFO - 'PAGER': '/bin/cat', 14:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:02 INFO - 'PWD': '/builds/slave/test', 14:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:02 INFO - 'SHELL': '/bin/bash', 14:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:14:02 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:02 INFO - 'USER': 'cltbld', 14:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:02 INFO - 'XPC_FLAGS': '0x0', 14:14:02 INFO - 'XPC_SERVICE_NAME': '0', 14:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-atxQJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:14:03 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-zKeOV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-5yV8rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:14:03 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cWJuUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-yUJZSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:14:03 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-Fw5sHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:14:03 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)) 14:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:14:03 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-oR5L8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-U_EAbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-6_epI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-vh4lST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-988mqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-VSMYfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-3cilIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-cExFsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-thra_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:14:04 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-b_aCdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:14:04 INFO - Running setup.py (path:/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/pip-h49Umh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:14:05 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)) 14:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:14:05 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)) 14:14:05 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:05 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:14:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:14:05 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 14:14:05 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 14:14:05 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 14:14:05 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 14:14:05 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 14:14:05 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 14:14:07 INFO - Downloading blessings-1.6.tar.gz 14:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:14:07 INFO - Installing collected packages: blessings 14:14:07 INFO - Running setup.py install for blessings 14:14:07 INFO - Successfully installed blessings 14:14:07 INFO - Cleaning up... 14:14:08 INFO - Return code: 0 14:14:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:08 INFO - Reading from file tmpfile_stdout 14:14:08 INFO - Current package versions: 14:14:08 INFO - blessings == 1.6 14:14:08 INFO - blobuploader == 1.2.4 14:14:08 INFO - docopt == 0.6.1 14:14:08 INFO - functools32 == 3.2.3-2 14:14:08 INFO - jsonschema == 2.5.1 14:14:08 INFO - manifestparser == 1.1 14:14:08 INFO - mozInstall == 1.12 14:14:08 INFO - mozcrash == 1.0 14:14:08 INFO - mozdebug == 0.1 14:14:08 INFO - mozdevice == 0.50 14:14:08 INFO - mozfile == 1.2 14:14:08 INFO - mozhttpd == 0.7 14:14:08 INFO - mozinfo == 0.9 14:14:08 INFO - mozleak == 0.1 14:14:08 INFO - mozlog == 3.4 14:14:08 INFO - moznetwork == 0.27 14:14:08 INFO - mozprocess == 0.25 14:14:08 INFO - mozprofile == 0.28 14:14:08 INFO - mozrunner == 6.13 14:14:08 INFO - mozscreenshot == 0.1 14:14:08 INFO - mozsystemmonitor == 0.3 14:14:08 INFO - moztest == 0.8 14:14:08 INFO - mozversion == 1.4 14:14:08 INFO - psutil == 3.1.1 14:14:08 INFO - requests == 1.2.3 14:14:08 INFO - wsgiref == 0.1.2 14:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:08 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 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:14:08 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 14:14:08 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 14:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:08 INFO - 'HOME': '/Users/cltbld', 14:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:08 INFO - 'LOGNAME': 'cltbld', 14:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:08 INFO - 'MOZ_NO_REMOTE': '1', 14:14:08 INFO - 'NO_EM_RESTART': '1', 14:14:08 INFO - 'PAGER': '/bin/cat', 14:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:08 INFO - 'PWD': '/builds/slave/test', 14:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:08 INFO - 'SHELL': '/bin/bash', 14:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:14:08 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:08 INFO - 'USER': 'cltbld', 14:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:08 INFO - 'XPC_FLAGS': '0x0', 14:14:08 INFO - 'XPC_SERVICE_NAME': '0', 14:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 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)) 14:14:08 INFO - Cleaning up... 14:14:08 INFO - Return code: 0 14:14:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d1fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d22768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8763c9a880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, '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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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 14:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:08 INFO - 'HOME': '/Users/cltbld', 14:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:08 INFO - 'LOGNAME': 'cltbld', 14:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:08 INFO - 'MOZ_NO_REMOTE': '1', 14:14:08 INFO - 'NO_EM_RESTART': '1', 14:14:08 INFO - 'PAGER': '/bin/cat', 14:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:08 INFO - 'PWD': '/builds/slave/test', 14:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:08 INFO - 'SHELL': '/bin/bash', 14:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:14:08 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:08 INFO - 'USER': 'cltbld', 14:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:08 INFO - 'XPC_FLAGS': '0x0', 14:14:08 INFO - 'XPC_SERVICE_NAME': '0', 14:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:14:08 INFO - Cleaning up... 14:14:08 INFO - Return code: 0 14:14:08 INFO - Running post-action listener: _resource_record_post_action 14:14:08 INFO - Running post-action listener: _start_resource_monitoring 14:14:08 INFO - Starting resource monitoring. 14:14:08 INFO - [mozharness: 2017-04-13 21:14:08.975828Z] Finished create-virtualenv step (success) 14:14:08 INFO - [mozharness: 2017-04-13 21:14:08.976841Z] Running install step. 14:14:08 INFO - Running pre-action listener: _resource_record_pre_action 14:14:08 INFO - Running main action method: install 14:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:14:09 INFO - Reading from file tmpfile_stdout 14:14:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:14:09 INFO - Reading from file tmpfile_stdout 14:14:09 INFO - Output received: 14:14:09 INFO - Usage: mozinstall [options] installer 14:14:09 INFO - Options: 14:14:09 INFO - -h, --help show this help message and exit 14:14:09 INFO - -d DEST, --destination=DEST 14:14:09 INFO - Directory to install application into. [default: 14:14:09 INFO - "/builds/slave/test"] 14:14:09 INFO - --app=APP Application being installed. [default: firefox] 14:14:09 INFO - mkdir: /builds/slave/test/build/application 14:14:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:14:28 INFO - Reading from file tmpfile_stdout 14:14:28 INFO - Output received: 14:14:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:14:28 INFO - Running post-action listener: _resource_record_post_action 14:14:28 INFO - [mozharness: 2017-04-13 21:14:28.782878Z] Finished install step (success) 14:14:28 INFO - [mozharness: 2017-04-13 21:14:28.783030Z] Running run-tests step. 14:14:28 INFO - Running pre-action listener: _resource_record_pre_action 14:14:28 INFO - Running main action method: run_tests 14:14:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:14:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:14:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:14:28 INFO - 2017-04-13 14:14:28.797 screenresolution[1627:7431] starting screenresolution argv=screenresolution get 14:14:28 INFO - 2017-04-13 14:14:28.800 screenresolution[1627:7431] Display 0: 1600x1200x32@60 14:14:28 INFO - 2017-04-13 14:14:28.805 screenresolution[1628:7434] starting screenresolution argv=screenresolution list 14:14:28 INFO - Available Modes on Display 0 14:14:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:14:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:14:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:14:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:14:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:14:29 INFO - Intel Iris: 14:14:29 INFO - Chipset Model: Intel Iris 14:14:29 INFO - Type: GPU 14:14:29 INFO - Bus: Built-In 14:14:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:14:29 INFO - Vendor: Intel (0x8086) 14:14:29 INFO - Device ID: 0x0a2e 14:14:29 INFO - Revision ID: 0x0009 14:14:29 INFO - Displays: 14:14:29 INFO - Display: 14:14:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:14:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:14:29 INFO - Display Serial Number: 1600x1200 60 14:14:29 INFO - Main Display: Yes 14:14:29 INFO - Mirror: Off 14:14:29 INFO - Online: Yes 14:14:29 INFO - Rotation: Supported 14:14:29 INFO - Return code: 0 14:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:14:29 INFO - Python 2.7.3 14:14:29 INFO - Return code: 0 14:14:29 INFO - grabbing minidump binary from tooltool 14:14: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')]} 14:14:29 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 0x104afdd30>, '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 0x104a24db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104af2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:14:29 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 14:14:29 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 14:14:29 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 14:14:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:14:29 INFO - Return code: 0 14:14:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:14:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:14:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:14:29 INFO - ENV: RUST_BACKTRACE is now 1 14:14:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:14:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:14:29 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/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 14:14:29 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/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0144 --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 14:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hpb40iD91Z/Render', 14:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:14:29 INFO - 'HOME': '/Users/cltbld', 14:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:14:29 INFO - 'LOGNAME': 'cltbld', 14:14:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:14:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:14:29 INFO - 'MOZ_NO_REMOTE': '1', 14:14:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:14:29 INFO - 'NO_EM_RESTART': '1', 14:14:29 INFO - 'PAGER': '/bin/cat', 14:14:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:14:29 INFO - 'PWD': '/builds/slave/test', 14:14:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:14:29 INFO - 'RUST_BACKTRACE': '1', 14:14:29 INFO - 'SHELL': '/bin/bash', 14:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jDshwcS9Wl/Listeners', 14:14:29 INFO - 'TMPDIR': '/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/', 14:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:14:29 INFO - 'USER': 'cltbld', 14:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:14:29 INFO - 'XPC_FLAGS': '0x0', 14:14:29 INFO - 'XPC_SERVICE_NAME': '0', 14:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:14:29 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/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0144', '--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 14:14:29 INFO - mozversion application_buildid: 20170413130423 14:14:29 INFO - mozversion application_changeset: 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 14:14:29 INFO - mozversion application_display_name: Nightly 14:14:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:14:29 INFO - mozversion application_name: Firefox 14:14:29 INFO - mozversion application_remotingname: firefox 14:14:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:14:29 INFO - mozversion application_vendor: Mozilla 14:14:29 INFO - mozversion application_version: 55.0a1 14:14:29 INFO - mozversion platform_buildid: 20170413130423 14:14:29 INFO - mozversion platform_changeset: 3243c8fc3ce7831dda843b60d6bb2d7e4acf1fd4 14:14:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:14:29 INFO - mozversion platform_version: 55.0a1 14:14:29 INFO - using testdate: 1492118069 14:14:29 INFO - actual date: 1492118069 14:14:29 INFO - starting webserver on 'localhost:49241' 14:14:29 INFO - SUITE-START | Running 2 tests 14:14:29 INFO - TEST-START | dromaeo_css 14:14:29 INFO - operating with platform_type : mac_ 14:14:29 INFO - Initialising browser for dromaeo_css test... 14:14:29 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp0fIDBX/profile http://localhost:49241/getInfo.html) 14:14:32 INFO - PID 1638 | 2017-04-13 14:14:32.095 plugin-container[1640:7617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 14:14:32 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:14:32 INFO - PID 1638 | 2017-04-13 14:14:32.098 plugin-container[1640:7617] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 14:14:32 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:14:32 INFO - PID 1638 | 2017-04-13 14:14:32.098 plugin-container[1640:7617] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:14:32 INFO - PID 1638 | __metrics Screen width/height:1600/1200 14:14:32 INFO - PID 1638 | colorDepth:24 14:14:32 INFO - PID 1638 | Browser inner width/height: 1024/689 14:14:32 INFO - PID 1638 | __metrics 14:14:32 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 14:14:33 INFO - TEST-INFO | 1638: exit 0 14:14:33 INFO - Browser initialized. 14:14:33 INFO - Running cycle 1/1 for dromaeo_css test... 14:14:33 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmp0fIDBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:35 INFO - PID 1641 | 2017-04-13 14:14:35.648 plugin-container[1642:7747] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 14:14:35 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:14:35 INFO - PID 1641 | 2017-04-13 14:14:35.649 plugin-container[1642:7747] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:14:35 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:14:35 INFO - PID 1641 | 2017-04-13 14:14:35.649 plugin-container[1642:7747] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:14:45 INFO - PID 1641 | RSS: Main: 249954304 14:14:45 INFO - PID 1641 | 14:17:49 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:17:51 INFO - PID 1641 | RSS: Main: 254988288 14:17:51 INFO - PID 1641 | 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:19:33 INFO - PID 1641 | 14:19:33 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:19:33 INFO - PID 1641 | Full stack: 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:19:33 INFO - PID 1641 | 14:19:33 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:19:33 INFO - PID 1641 | Full stack: 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:19:33 INFO - PID 1641 | 14:19:33 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:19:33 INFO - PID 1641 | Full stack: 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | ************************* 14:19:33 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:19:33 INFO - PID 1641 | 14:19:33 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:19:33 INFO - PID 1641 | Full stack: 14:19:33 INFO - PID 1641 | ************************* 14:20:53 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:20:53 INFO - PID 1641 | RSS: Main: 264359936 14:20:53 INFO - PID 1641 | 14:23:55 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 14:23:56 INFO - PID 1641 | RSS: Main: 276410368 14:23:56 INFO - PID 1641 | 14:26:58 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 14:26:58 INFO - PID 1641 | RSS: Main: 268697600 14:26:58 INFO - PID 1641 | 14:30:01 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 14:30:02 INFO - PID 1641 | RSS: Main: 279011328 14:30:02 INFO - PID 1641 | 14:33:03 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 14:33:04 INFO - PID 1641 | RSS: Main: 272629760 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | __start_tp_report 14:33:04 INFO - PID 1641 | _x_x_mozilla_page_load 14:33:04 INFO - PID 1641 | _x_x_mozilla_page_load_details 14:33:04 INFO - PID 1641 | |i|pagename|runs| 14:33:04 INFO - PID 1641 | |0;dojo.html;3029.545568164775;3474.548308719866;3586.55168103987;3650.3794354959646;3652.0322114639607;6129.754809807602;6144.477719393852;6168.105624684424;6191.28800187978;6215.689215539228;5308;6087.4825639820665;6098.359672234418;6145.969270153654;6148.770245950816;5415.864603384907;5420.430854760252;5437.102878025121;5505.064139096363;5560.638558493685;4526.569975852289;5346.705931173784;5491.2312276281355;5499.1476321170285;5500.697461639608;5406.486383793534;5457.345118585756;5465.836024919259;5470.261514695525;5536.806211782588;5303.602229832778;5365.7853685852515;5378.731063446812;5389.9191512127345;5402.486763757476;5370.409254981949;5397.919031214535;5399.595030372738;5447.346318441812;5475.123980163195;5931.525477961796;6102.908456373158;6197.690115494207;6217.533684973645;6247.531435142337;6380.808575742735;6453.741850325981;6561.770338038145;6658.234303055114;6675.132232809752;6667.19993600771;6676.198856137246;6680.699368528428;6684.565503242274;6692.665366731692;6268.937310626881;6288.245410550763;6290.43386095249;6296.5592408530965;6299.307076221658;6575.901361479581;6665.500087493458;6776.11910451648;6827.112475378169;6829.93170068293;6283.874322513524;6317.715702793385;6380.649064301508;6451.29035806061;6484.805455836333;6469.77355792545;6588.8023359299295;6672.132622759011;6690.063391125246;6695.096162018162;6501.057346684799;6602.60384376939;6620.933790662032;6633.6019838809825;6645.302243264484;6297.842553936188;6323.620582765049;6654.101696271038;6674.733010679615;6679.131712877295;5324.935012997416;5343.225232341289;5407.486288802557;5423.29497165366;5424.7016414096815;4740.265258884879;4763.476017638057;4771.880702982384;4783.378160839069;4806.5557486963;5090.9236361454605;5583.246261754611;6171.7531298748445;6292.465140463112;6300.495960323163;6104.969475152596;6330;6729.629870357177;6730.865382692319;6780.423663988616;6241.843953901098;6289.182406287154;6293.496520278367;6302.401271879165;6307.684615769193;5934.703264836741;5989.101634754822;5991;5995.999999999913;6002.129691194752;6671.866562668816;6822.965885170741;6832.760853370109;6876.518643694893;6882.174139103339;5641.351244606923;6687.699053542505;6694.866102678016;6703.564268322543;6705.497087718343;6829.078074459884;6866.416354609914;6872.484563657846;6879.724811007503;6882.7591034313555;6354.491640668828;6425.518086143465;6500.349965003462;6562.770303039561;6568;5636.520895723909;6599.901001485077;6686.231083425469;6702.865942681216;6707.195136583446;6407.199100112486;6467.708953097028;6486.124373209556;6500;6503.154589903283;6219.346968568416;6306.243250809932;6469.611823290429;6539.346065393423;6540.934590654033;4819.963707802839;6090.512758979183;6263.592866463665;6337.65142917144;6356.841078973062;6449.4517965971545;6479.028145778171;6479.8056058318325;6490.48076153916;6492.123563319081;6113.202667687734;6229.065640154013;6234.9688251558455;6272.529560282906;6312.684365781784 14:33:04 INFO - PID 1641 | |1;ext.html;696.453284171925;741.2291217134181;829.4940086547207;1074.350018238966;1286.8520120186176;36740;37792;37839.43240851386;37914.8104259479;38044.80977595115;37274.44088338677;37529.81235093828;37535.81232093843;37763.811180944125;37821.62178378215;8036.276735093826;8194.262516373525;8502.27730642893;8750.03749587545;8750.299976001905;8685.261752751023;8761.912380876174;8826.823463530725;8829.470231786081;8834.690785822497;8784;8789.121087891224;8789.165029322205;8854.955725221365;8869.201771840533;8805.119488051176;8811.118888111201;8819.911800881973;8826.602802873886;8827.602757875879;8544.231019208239;8582.485050896967;8591.957040214822;8596.914030859674;8613.956930215309;36868.81565592182;37023.81488092569;37029;37112.44331335032;37156.62843371559;3711.1464363196615;3733.9813300933592;3737.3272810894027;3741.4574886641285;3742.850285988557;30447.086587402413;30553.083407497812;30639.234019149477;30682.693173068208;30706.23234419135;2843.5023870822524;3130.1861516006;3235.5793746813;3246.6753324667343;3253;182710.08644956822;185800.07099964548;191984.12023819654;249607;251753;45508.544914551094;46011.76994115075;46076.76961615238;46164.53835461669;46806.82982925386;35381.82309088438;47975.76012119987;48132;48204.03591928212;48483.515164848606;14274.571762847132;14286.571402857722;14352.49766258176;14357.353919073666;14409.639759005899;11615.76768464643;11691.941540292244;11751.941240293743;11798.823017654742;11825.645230643095;13177.868221317856;13208.669783255304;13229.470821167239;13329;13338.73322533544;5523.530499907552;5569.192467092249;5895.528357731371;5922.615030023035;5956.123820996372;998.1864780204111;1020.7907378987289;1024.3904876598413;1042.7966546523355;1043.76515284062;19315.130819113172;22772.4306892329;23502.529949400916;23573.88213058958;23986.640200397007;1120.4845770945456;1120.7254222715487;1156.306216270248;1156.3582211872324;1163.941802909851;10254.28220024606;11192.496337664825;11616.489856318625;12126.393680315949;12141.939290303668;312003;313363;313659.43170284;314301;316286;49859;49974.750126249135;50165.24752128721;50186;50385.496145038815;1295.3199570225706;1509.4264179611678;1552.906825590468;1555.7588573771084;1573.1504987306955;20042.39872803818;23020.539589208456;23171.07315707353;23509.294721158392;23547.822608869832;28117.43765124727;36186.638133618326;36365.27269454649;36384.818075909454;37027;201006;278509.60745196143;278722;278757.60621196765;278942;27902.02342917988;28509.714902850705;31615.051548453583;32284;32345.35309293848;34290;38420.80789596146;40889.911008898875;40959.38560921648;41215;28513;28827.855860720563;29496.410071798873;29522.55716164302;29773.255668608457;28387.290317741397;29323.70676293295;29575.260618483848;29580.556291656074;29606.555901661923;33644.83177584194;34696.959091227305;34877.128071798405;34918.825405872805;34922.77770278028;29396.85301573564;30817.537736933515;31564.842175788974;31593.684063159075;31644.05067847968;21599.892000539898;24228.515429690953;24236.030558777453;24449.633255501536;24820.00719971181 14:33:04 INFO - PID 1641 | |2;jquery.html;425.93823895535127;429.5970810938052;431.3249764119154;439.7559354558221;455.00027379666346;19686.606267874635;21214.469638259052;21920.89039554804;22004.33986980393;22160.335189944308;21354.57290854182;22356.776432235674;23020.19429319974;23098.88450557749;23251.418714532145;6176.444120029197;6205.317415084349;6392.776252831151;6410.487161027107;6420.711068001951;6124.540659450559;6290.905636415435;6355.745770169211;6361.4274715275615;6372.968135159341;5182.792688292464;6192.195014648089;6272.153259310003;6274.278457977345;6301.527385446087;6175.814725558241;6236.563440559163;6242.157308763327;6246.094316324107;6257.18656574647;5368.677879327214;5529.585281103893;5543.002259593271;5556.111022236423;5616.073347897633;27221.04726334569;27341.179764607095;27497.86251068732;27574.310642233904;27870.860645696845;2204.5921504521716;2252.583272094668;2269.4780200553964;2270.9886450567806;2292.7592602776804;14240.359183836752;15390.15354155521;17995.570597969367;18083.367082152192;18400.907995459937;1930.7200455933812;2019.4951262184454;2192;2228.2980861028723;2234.754177040524;108217.0961194268;113269;130922;132735;133917.3304133473;9449.952750236205;12586.18189817659;12589;12751.744965100646;12758.61724148277;16086.597835054217;16223.26995285215;16229;16229;16233.107179105262;8839.646414143492;9074.45553266806;9078.954605227063;9130.26957843371;9217.032211617683;8724.694635687847;8737.563121843883;8747.475151490804;8918.375713700108;8922.420042697204;7728.497647652997;7812.57030863308;7848.489848159966;7883.921160788434;7897.921020789719;2068.214078650103;2104;2177.1182671017946;2196.5832038335184;2250.3586477853733;995.8854731705947;1004.9748756281151;1005.7737009172878;1035.2804800663466;1044.1177205261542;20444.693329600068;21274.893625531775;21294.574108517743;21403.250886218906;21538.56922861534;1037.4086770540719;1039.7660526381655;1063.3619828103076;1077.2674581284646;1080.5623722392443;8472.788180295542;9549.379290346105;10810.51352689115;11059.668209953714;11060.834087488694;624726;629701.8514907488;640802;642870.3569446462;652827;125811;129816;132699;151467.24266378817;154317.2284138572;1210.7094297368744;1211.4003568233782;1257.735875466144;1264.2288204195434;1264.4057293072242;22042;22112.889435553363;22138.77861221367;22220.333389998326;22364.664530032387;61431;62252.75494489994;62437.375626243156;62546.68726656338;62762.686186568775;64822;73806.15484612927;87950.56024720092;88584;89219.55390223008;8716.041235464221;8744.825103497767;8780.912190878265;8982.955085224532;9172.266218702622;13703.45186192581;13769.655758606115;13771.655708607364;14037.298135093;14117.505887293895;10179.694609161737;11750;11798.705032374259;11961.64115076549;12112.75774484523;9769.364991275545;10652.467376630982;10708.30396024256;11368.886311137114;11612.94193529027;11154.721131971766;11895.345755983504;12098.576549821066;12161.574344897886;12306.13857030035;6467.773627923;8732.301415886841;8893.822123557364;8933.776655583662;8977.371583989057;11887.643370698894;11903.761924761284;12001.63995080149;12142.453589588666;12148 14:33:04 INFO - PID 1641 | |3;mootools.html;1156.8611766588008;1287.9162854414465;1338.53820431951;1447.0449503327807;1447.8696917277443;11223.831642525369;11729;11800.468978895939;11816.704582385444;12113.939430302837;10022.749431264223;11776.234544754585;11935.403229838495;11988.460519276632;12006.699832504191;2519.2316343515267;2559.34736642156;2562.5771747661615;2564.7178810330847;2565.307367010906;2462.7906627936645;2487.9378015549664;2529.7217306096313;2530.114459939016;2538.225841118458;2464.544059349026;2517.496500699858;2531.5443220220354;2542.898284068635;2567.82025258232;2095.3609149209483;2428.623563347675;2484.888180031894;2493.0651005872796;2516.9119080832265;2392.3181893160368;2488.278399264211;2498.350428888502;2506.373406648338;2514.7736703696573;11839.112066594953;11951.701207469796;11957.581484648083;11964.70088247792;11968;6552.967235163841;6791.456683465311;6796.66016699168;6809.659517024179;6819.624920629363;4118.855840045614;4383.9342409863875;4454.955450445519;4472.865814025585;4478.328250762412;1260.4496469342669;1264.64589914824;1281.8782215689494;1306.915050521713;1316.2431601828987;14874.330655120546;15337.23313834315;16257.430989915414;16488.67022659552;16574.585635359093;5567.109262518059;5716.114002329646;5874.353821079678;5945.881082378328;5975.103734439869;12257.938710306391;12328.32194229308;12383.318917459626;12412.317322547166;12431.813522797165;6612.140421745143;6624.337566243337;6632.535722499379;6642.402183803384;6649.202095748541;6060.969695151584;6115.84710382244;6137;6175.814725558241;6200.627962322275;3712.958593109594;4484;4548.749818759934;4582.450105987303;4591.678582499193;1177.6996865799167;1292.3990344489857;1292.9741405171844;1321.1016508774126;1335.6527302901316;734.5005396330547;788.66087582339;789.135896193667;816.3387655998661;820.4912953968578;6338.462150127216;6820.488463365267;6948.478864085214;7029.578225306498;7042.718291268395;866.7139843851639;940.149165005671;973.529969745675;974.0794948773482;982.2731178927543;4128.174365126986;4285.142971405731;4372.191144638252;4444.1333939881415;4445.355423463579;14777.039492432958;15261.771073433907;15341.232938353261;15410.768838467431;15566.299516521784;14951.626209344853;15072.849271507364;15196.240187990556;15218.619534511727;15348.999999999776;9607.807843843224;10871.45642717861;11059.059979901798;11198.160137989684;11214.439278036065;6188.4739797117745;7058.752943646948;7235.204127546071;7286.417086633162;7317.085364329459;10482.161427085968;10738.946305268424;12539.310337931502;12674.239545627292;12678.936605316914;13812.309384530934;13890.236037018061;14038.227897465737;14206.644833879236;14247;9646.710598682052;9652.083052110038;9687.225021998082;9692.9030709692;9729.610815567581;10783.784324313312;10882.61910833117;10895.509702063267;10897;10901.781964360509;8801.075887032026;9056.275497960016;9079.092090790868;9118.316126290687;9250.398724082914;8938.955305223692;8983.730488085368;9015.233705134875;9057.501837399006;9082.500462474627;8116.513009219466;8123.83752324962;8134.145914678874;8265.173482651686;8266.008079030555;6001.219841420588;6005.549583781147;6063.575549711478;6167.84580385494;6196.535259855439;6054.848628784315;6124.969375153274;6176.66028368426;6235.844103897439;6351.460125889166 14:33:04 INFO - PID 1641 | |4;prototype.html;406.25655051256206;410.3311602088595;413.4914055711475;415.83358678905677;420.4912056411742;4717.64617653676;6191.938080619192;6221;6224.875502489947;6235.9999999999945;5141.937869083419;5792.451321418584;6004.519638428927;6013.458788709016;6022.6687532185715;4593.839215627454;4594.310853371996;4622.768861556909;4629.907401851961;4635.860924172281;3979.343408337621;4491.18107166598;4605.792739326722;4628.282616194495;4629.675922685414;3308.9669103308897;3707.721920855933;4035.01142220155;4408.889777755566;4422.358757980091;3795.7663759278207;3859.4982652255308;4236.834870410631;4385.605295523403;4442.800073996678;3665.157013886794;3826.942595861064;3830.6743926766258;3834.2331533693095;3846.403807409828;4764.761761911891;4840.540148685869;5920.052791553331;5948.196993405922;5973.790917317917;4710.2445069634305;5337.57140501075;5357.9819834231375;5359.866003349908;5373.355197376301;5447.995723143486;5731.770729170828;6268.091126786636;6409.910315246373;6498.220213574354;3549.4498352755104;4140.834366625331;4312.935305970413;4356.455443069616;4356.695031347807;5562.610617256793;6630.569013014187;6876.69054892531;6882.827929301758;6887.793366199022;3519.9296014079573;4408.823647054146;4449.9555004450185;4461.219286624828;4461.620762235181;4287.421198138211;4489.9775501122285;4505.909881802346;4513.961788788597;4531.297648864365;4522.186006518858;5142.61430392722;5257.76340064698;5273.78904843802;5358.624896257303;5498.202760599691;6519.511036672268;6524.336294245032;6569.638669873203;6569.835754106186;1410.0693542262059;1477.9482718104814;1500.9699806003819;1544.9922750386177;1545.1964978211267;939.7885475768035;964.62379671928;1024.4365598920565;1029.1818004686293;1035.135661722455;4826.031990325994;6220.377962203744;6232.034034724625;6256.186695729526;6273.905891411632;6736.46108311334;6739.359760822714;6758.459323254128;6778.6445709374175;6829.931700683029;4758.405199350082;5189.325387699575;6169.598976066542;6211.254649442006;6219.1604133442315;3241.3793103448274;3357.261402491448;3375.341808347349;3427.8286085695618;3473.8436770345397;4889.902201955941;5496.395396506381;5781.785824976802;5917.3076250306;6158.291796443376;5284.9735751320995;6080.422359875804;6484.578502397329;6504.739810407531;6558.508111891627;6431.967840160863;6637.933620663732;6975.883858582704;7015.737167309933;7023.192332881682;5858.882822343615;6761.526693131434;6785.389314961677;6798.354156355138;6820.249772525118;6454;6677.599344039373;6680.799576012728;6683.966580167068;6684.665766711548;5598.9082128984455;5763.337216220189;7020.964895175492;7032.718691252293;7038.718451261892;4069.7354671946227;4139.110091330378;4401.515833258403;4433.958019865394;4440.689151759475;5024.974875125601;6603.9009414859775;6669.7665581704405;6687.966560167168;6808.523403361717;6110.869489144522;6392.9360706392345;6416.00551914454;6528.575642583217;6538.378854008862;5327.813526526708;5707.771689132388;6305.180326557518;6528.706208220547;6566.737330506726;5879.265091863517;6322.905156422566;6372.203474565679;6373.075903993988;6433.453156481752;5406.729663516887;6534.150560427114;6555.4427873631275;6557.311482294481;6581.638009909501;5273.34083239595;6064.151018857452;6345.778977358073;6362.204724409449;6387.616742995435 14:33:04 INFO - PID 1641 | |5;yui.html;783.7531177679032;837.3594200436667;844.7381311793341;880.1242763450368;884.8495755721526;14307.499237526688;14546.490872819453;16644.583885402855;16651.58371040723;17012.659746805057;16587.83412165878;16893.23980420881;17042.573935651613;17046.82953170468;17608;869.2524428991063;997.6957028106425;1022.7187523431079;1025.174734338857;1026.3226270661364;1011.1910471622709;1012.6759436980169;1012.7721262715903;1014.5586669798624;1015.4161357219591;1062.6971313175748;1066.3228849680431;1066.4134725900763;1066.7813098314866;1069.2568664777982;1033.2302434686208;1060.7030031591166;1063.9468026598638;1066.0192622786976;1066.5467176450018;767.6238643064858;785.8231897823001;787.7557957033281;789.1319548496665;790.7627711686471;16731.498055058368;17376.21807018687;17380.56548586283;17526.948383097057;17659.38192163268;16439.91780041092;16505.009699418075;16908.15459227046;17043.829561704348;17129.828701712948;13767.655808604764;13987.230702311368;14098.859011409857;14099.154050756988;14126.576202713935;3229.1927018245437;3400.778949368308;3418;3448.189675426273;3487.808170550619;97666;100765;101872.47191292136;102179.97820021854;102674.45988310181;11826.11304152192;11878.287302761863;12084.274943503418;12087.03303735699;12103.850134237233;20086.69869951952;20127.39617811468;20166.29417970364;20259.987000649908;20409.591808163754;7643.885341719879;7849.686012559434;8518.148185181431;8893.555322233991;8959;4642.767861606973;4718.05638872227;4736.171170045228;4740.312654665123;4765.142274390643;4688.789004494806;4841.346418233564;4880.145974454456;4910.852674419773;4916.360873086547;929.972100836976;947.4978261521404;956.6508224498148;963.4797209506928;963.5904740485265;665.7569986954824;674.6694119881223;676.8612434450926;682.9624370659562;694.7082225465317;11370.31778093317;11913.10651701126;11972.58095966637;12106.031517478757;12171.391430428443;656.3633275722541;672.1463741048939;689.8516818883965;696.2028477393458;712.0671919785098;4755.381800366;4967.7019378837385;5244.056069907377;5584.748686309044;5708.743106560215;88157.11842881617;88885.55557222173;89168.10831891728;89255;92214.53892730494;47441;64646.67676661586;80939;82445;85346.71979920306;70594;74794.13838100506;75657.24342756612;75668;75670.9999999989;12017.339046352534;12037.939810300892;12129.757404851676;12144.939275303566;12191.085668574715;38193;38956.80521597374;39058.6094139055;39147.80426097851;39573.60426395699;49961;50867.74566127146;51244.74377628237;51359.48640513547;53103;12569.87430125687;13533.526326578523;15998.9200053999;16225.269862855963;16608.418705345255;15810.60473488172;17366.39217627377;17932.372366967094;18220.726689099938;18308.908455457637;16470.258838352063;16567.91716041412;16612;16649.583760406087;16866.156692165587;13813.378397971914;16586.25361858695;16659.666806663558;16741.91629041847;16864.241109149872;16108.194590270674;16311;16332.673346532765;16415.42546010884;16420.425285114965;10403.323783954018;11648.359340236368;11803.468843901874;12025.63923082309;12103.942329803778;12804.423800929168;13294.734105318033;13338.533151339656;13558.864411356155;13703 14:33:04 INFO - PID 1641 | __end_tp_report 14:33:04 INFO - PID 1641 | __start_cc_report 14:33:04 INFO - PID 1641 | _x_x_mozilla_cycle_collect,423 14:33:04 INFO - PID 1641 | __end_cc_report 14:33:04 INFO - PID 1641 | __startTimestamp1492119184107__endTimestamp 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | ------- Summary: start ------- 14:33:04 INFO - PID 1641 | Number of tests: 6 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6080.74 Median:6296.56 stddev:721.24 (11.5%) stddev-sans-first:682.58 14:33:04 INFO - PID 1641 | Values: 3029.5 3474.5 3586.6 3650.4 3652.0 6129.8 6144.5 6168.1 6191.3 6215.7 5308.0 6087.5 6098.4 6146.0 6148.8 5415.9 5420.4 5437.1 5505.1 5560.6 4526.6 5346.7 5491.2 5499.1 5500.7 5406.5 5457.3 5465.8 5470.3 5536.8 5303.6 5365.8 5378.7 5389.9 5402.5 5370.4 5397.9 5399.6 5447.3 5475.1 5931.5 6102.9 6197.7 6217.5 6247.5 6380.8 6453.7 6561.8 6658.2 6675.1 6667.2 6676.2 6680.7 6684.6 6692.7 6268.9 6288.2 6290.4 6296.6 6299.3 6575.9 6665.5 6776.1 6827.1 6829.9 6283.9 6317.7 6380.6 6451.3 6484.8 6469.8 6588.8 6672.1 6690.1 6695.1 6501.1 6602.6 6620.9 6633.6 6645.3 6297.8 6323.6 6654.1 6674.7 6679.1 5324.9 5343.2 5407.5 5423.3 5424.7 4740.3 4763.5 4771.9 4783.4 4806.6 5090.9 5583.2 6171.8 6292.5 6300.5 6105.0 6330.0 6729.6 6730.9 6780.4 6241.8 6289.2 6293.5 6302.4 6307.7 5934.7 5989.1 5991.0 5996.0 6002.1 6671.9 6823.0 6832.8 6876.5 6882.2 5641.4 6687.7 6694.9 6703.6 6705.5 6829.1 6866.4 6872.5 6879.7 6882.8 6354.5 6425.5 6500.3 6562.8 6568.0 5636.5 6599.9 6686.2 6702.9 6707.2 6407.2 6467.7 6486.1 6500.0 6503.2 6219.3 6306.2 6469.6 6539.3 6540.9 4820.0 6090.5 6263.6 6337.7 6356.8 6449.5 6479.0 6479.8 6490.5 6492.1 6113.2 6229.1 6235.0 6272.5 6312.7 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:41209.06 Median:173965.03 stddev:70093.78 (40.3%) stddev-sans-first:70224.40 14:33:04 INFO - PID 1641 | Values: 696.5 741.2 829.5 1074.4 1286.9 36740.0 37792.0 37839.4 37914.8 38044.8 37274.4 37529.8 37535.8 37763.8 37821.6 8036.3 8194.3 8502.3 8750.0 8750.3 8685.3 8761.9 8826.8 8829.5 8834.7 8784.0 8789.1 8789.2 8855.0 8869.2 8805.1 8811.1 8819.9 8826.6 8827.6 8544.2 8582.5 8592.0 8596.9 8614.0 36868.8 37023.8 37029.0 37112.4 37156.6 3711.1 3734.0 3737.3 3741.5 3742.9 30447.1 30553.1 30639.2 30682.7 30706.2 2843.5 3130.2 3235.6 3246.7 3253.0 182710.1 185800.1 191984.1 249607.0 251753.0 45508.5 46011.8 46076.8 46164.5 46806.8 35381.8 47975.8 48132.0 48204.0 48483.5 14274.6 14286.6 14352.5 14357.4 14409.6 11615.8 11691.9 11751.9 11798.8 11825.6 13177.9 13208.7 13229.5 13329.0 13338.7 5523.5 5569.2 5895.5 5922.6 5956.1 998.2 1020.8 1024.4 1042.8 1043.8 19315.1 22772.4 23502.5 23573.9 23986.6 1120.5 1120.7 1156.3 1156.4 1163.9 10254.3 11192.5 11616.5 12126.4 12141.9 312003.0 313363.0 313659.4 314301.0 316286.0 49859.0 49974.8 50165.2 50186.0 50385.5 1295.3 1509.4 1552.9 1555.8 1573.2 20042.4 23020.5 23171.1 23509.3 23547.8 28117.4 36186.6 36365.3 36384.8 37027.0 201006.0 278509.6 278722.0 278757.6 278942.0 27902.0 28509.7 31615.1 32284.0 32345.4 34290.0 38420.8 40889.9 40959.4 41215.0 28513.0 28827.9 29496.4 29522.6 29773.3 28387.3 29323.7 29575.3 29580.6 29606.6 33644.8 34697.0 34877.1 34918.8 34922.8 29396.9 30817.5 31564.8 31593.7 31644.1 21599.9 24228.5 24236.0 24449.6 24820.0 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:37722.61 Median:22360.72 stddev:106532.48 (476.4%) stddev-sans-first:106794.53 14:33:04 INFO - PID 1641 | Values: 425.9 429.6 431.3 439.8 455.0 19686.6 21214.5 21920.9 22004.3 22160.3 21354.6 22356.8 23020.2 23098.9 23251.4 6176.4 6205.3 6392.8 6410.5 6420.7 6124.5 6290.9 6355.7 6361.4 6373.0 5182.8 6192.2 6272.2 6274.3 6301.5 6175.8 6236.6 6242.2 6246.1 6257.2 5368.7 5529.6 5543.0 5556.1 5616.1 27221.0 27341.2 27497.9 27574.3 27870.9 2204.6 2252.6 2269.5 2271.0 2292.8 14240.4 15390.2 17995.6 18083.4 18400.9 1930.7 2019.5 2192.0 2228.3 2234.8 108217.1 113269.0 130922.0 132735.0 133917.3 9450.0 12586.2 12589.0 12751.7 12758.6 16086.6 16223.3 16229.0 16229.0 16233.1 8839.6 9074.5 9079.0 9130.3 9217.0 8724.7 8737.6 8747.5 8918.4 8922.4 7728.5 7812.6 7848.5 7883.9 7897.9 2068.2 2104.0 2177.1 2196.6 2250.4 995.9 1005.0 1005.8 1035.3 1044.1 20444.7 21274.9 21294.6 21403.3 21538.6 1037.4 1039.8 1063.4 1077.3 1080.6 8472.8 9549.4 10810.5 11059.7 11060.8 624726.0 629701.9 640802.0 642870.4 652827.0 125811.0 129816.0 132699.0 151467.2 154317.2 1210.7 1211.4 1257.7 1264.2 1264.4 22042.0 22112.9 22138.8 22220.3 22364.7 61431.0 62252.8 62437.4 62546.7 62762.7 64822.0 73806.2 87950.6 88584.0 89219.6 8716.0 8744.8 8780.9 8983.0 9172.3 13703.5 13769.7 13771.7 14037.3 14117.5 10179.7 11750.0 11798.7 11961.6 12112.8 9769.4 10652.5 10708.3 11368.9 11612.9 11154.7 11895.3 12098.6 12161.6 12306.1 6467.8 8732.3 8893.8 8933.8 8977.4 11887.6 11903.8 12001.6 12142.5 12148.0 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7224.04 Median:2563.65 stddev:4514.67 (176.1%) stddev-sans-first:4504.30 14:33:04 INFO - PID 1641 | Values: 1156.9 1287.9 1338.5 1447.0 1447.9 11223.8 11729.0 11800.5 11816.7 12113.9 10022.7 11776.2 11935.4 11988.5 12006.7 2519.2 2559.3 2562.6 2564.7 2565.3 2462.8 2487.9 2529.7 2530.1 2538.2 2464.5 2517.5 2531.5 2542.9 2567.8 2095.4 2428.6 2484.9 2493.1 2516.9 2392.3 2488.3 2498.4 2506.4 2514.8 11839.1 11951.7 11957.6 11964.7 11968.0 6553.0 6791.5 6796.7 6809.7 6819.6 4118.9 4383.9 4455.0 4472.9 4478.3 1260.4 1264.6 1281.9 1306.9 1316.2 14874.3 15337.2 16257.4 16488.7 16574.6 5567.1 5716.1 5874.4 5945.9 5975.1 12257.9 12328.3 12383.3 12412.3 12431.8 6612.1 6624.3 6632.5 6642.4 6649.2 6061.0 6115.8 6137.0 6175.8 6200.6 3713.0 4484.0 4548.7 4582.5 4591.7 1177.7 1292.4 1293.0 1321.1 1335.7 734.5 788.7 789.1 816.3 820.5 6338.5 6820.5 6948.5 7029.6 7042.7 866.7 940.1 973.5 974.1 982.3 4128.2 4285.1 4372.2 4444.1 4445.4 14777.0 15261.8 15341.2 15410.8 15566.3 14951.6 15072.8 15196.2 15218.6 15349.0 9607.8 10871.5 11059.1 11198.2 11214.4 6188.5 7058.8 7235.2 7286.4 7317.1 10482.2 10738.9 12539.3 12674.2 12678.9 13812.3 13890.2 14038.2 14206.6 14247.0 9646.7 9652.1 9687.2 9692.9 9729.6 10783.8 10882.6 10895.5 10897.0 10901.8 8801.1 9056.3 9079.1 9118.3 9250.4 8939.0 8983.7 9015.2 9057.5 9082.5 8116.5 8123.8 8134.1 8265.2 8266.0 6001.2 6005.5 6063.6 6167.8 6196.5 6054.8 6125.0 6176.7 6235.8 6351.5 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5147.88 Median:5653.34 stddev:1636.11 (28.9%) stddev-sans-first:1601.52 14:33:04 INFO - PID 1641 | Values: 406.3 410.3 413.5 415.8 420.5 4717.6 6191.9 6221.0 6224.9 6236.0 5141.9 5792.5 6004.5 6013.5 6022.7 4593.8 4594.3 4622.8 4629.9 4635.9 3979.3 4491.2 4605.8 4628.3 4629.7 3309.0 3707.7 4035.0 4408.9 4422.4 3795.8 3859.5 4236.8 4385.6 4442.8 3665.2 3826.9 3830.7 3834.2 3846.4 4764.8 4840.5 5920.1 5948.2 5973.8 4710.2 5337.6 5358.0 5359.9 5373.4 5448.0 5731.8 6268.1 6409.9 6498.2 3549.4 4140.8 4312.9 4356.5 4356.7 5562.6 6630.6 6876.7 6882.8 6887.8 3519.9 4408.8 4450.0 4461.2 4461.6 4287.4 4490.0 4505.9 4514.0 4531.3 4522.2 5142.6 5257.8 5273.8 5358.6 5498.2 6519.5 6524.3 6569.6 6569.8 1410.1 1477.9 1501.0 1545.0 1545.2 939.8 964.6 1024.4 1029.2 1035.1 4826.0 6220.4 6232.0 6256.2 6273.9 6736.5 6739.4 6758.5 6778.6 6829.9 4758.4 5189.3 6169.6 6211.3 6219.2 3241.4 3357.3 3375.3 3427.8 3473.8 4889.9 5496.4 5781.8 5917.3 6158.3 5285.0 6080.4 6484.6 6504.7 6558.5 6432.0 6637.9 6975.9 7015.7 7023.2 5858.9 6761.5 6785.4 6798.4 6820.2 6454.0 6677.6 6680.8 6684.0 6684.7 5598.9 5763.3 7021.0 7032.7 7038.7 4069.7 4139.1 4401.5 4434.0 4440.7 5025.0 6603.9 6669.8 6688.0 6808.5 6110.9 6392.9 6416.0 6528.6 6538.4 5327.8 5707.8 6305.2 6528.7 6566.7 5879.3 6322.9 6372.2 6373.1 6433.5 5406.7 6534.2 6555.4 6557.3 6581.6 5273.3 6064.2 6345.8 6362.2 6387.6 14:33:04 INFO - PID 1641 | 14:33:04 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:19609.47 Median:17453.76 stddev:25610.52 (146.7%) stddev-sans-first:25643.35 14:33:04 INFO - PID 1641 | Values: 783.8 837.4 844.7 880.1 884.8 14307.5 14546.5 16644.6 16651.6 17012.7 16587.8 16893.2 17042.6 17046.8 17608.0 869.3 997.7 1022.7 1025.2 1026.3 1011.2 1012.7 1012.8 1014.6 1015.4 1062.7 1066.3 1066.4 1066.8 1069.3 1033.2 1060.7 1063.9 1066.0 1066.5 767.6 785.8 787.8 789.1 790.8 16731.5 17376.2 17380.6 17526.9 17659.4 16439.9 16505.0 16908.2 17043.8 17129.8 13767.7 13987.2 14098.9 14099.2 14126.6 3229.2 3400.8 3418.0 3448.2 3487.8 97666.0 100765.0 101872.5 102180.0 102674.5 11826.1 11878.3 12084.3 12087.0 12103.9 20086.7 20127.4 20166.3 20260.0 20409.6 7643.9 7849.7 8518.1 8893.6 8959.0 4642.8 4718.1 4736.2 4740.3 4765.1 4688.8 4841.3 4880.1 4910.9 4916.4 930.0 947.5 956.7 963.5 963.6 665.8 674.7 676.9 683.0 694.7 11370.3 11913.1 11972.6 12106.0 12171.4 656.4 672.1 689.9 696.2 712.1 4755.4 4967.7 5244.1 5584.7 5708.7 88157.1 88885.6 89168.1 89255.0 92214.5 47441.0 64646.7 80939.0 82445.0 85346.7 70594.0 74794.1 75657.2 75668.0 75671.0 12017.3 12037.9 12129.8 12144.9 12191.1 38193.0 38956.8 39058.6 39147.8 39573.6 49961.0 50867.7 51244.7 51359.5 53103.0 12569.9 13533.5 15998.9 16225.3 16608.4 15810.6 17366.4 17932.4 18220.7 18308.9 16470.3 16567.9 16612.0 16649.6 16866.2 13813.4 16586.3 16659.7 16741.9 16864.2 16108.2 16311.0 16332.7 16415.4 16420.4 10403.3 11648.4 11803.5 12025.6 12103.9 12804.4 13294.7 13338.5 13558.9 13703.0 14:33:04 INFO - PID 1641 | -------- Summary: end -------- 14:33:04 INFO - PID 1641 | 14:33:04 INFO - TEST-INFO | 1641: exit 0 14:33:04 INFO - TEST-OK | dromaeo_css | took 1115524ms 14:33:04 INFO - TEST-START | kraken 14:33:04 INFO - operating with platform_type : mac_ 14:33:04 INFO - Initialising browser for kraken test... 14:33:04 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpQeDzvx/profile http://localhost:49241/getInfo.html) 14:33:07 INFO - PID 1654 | 2017-04-13 14:33:07.549 plugin-container[1655:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 14:33:07 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:07 INFO - PID 1654 | 2017-04-13 14:33:07.552 plugin-container[1655:10184] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 14:33:07 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:07 INFO - PID 1654 | 2017-04-13 14:33:07.552 plugin-container[1655:10184] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:33:07 INFO - PID 1654 | __metrics Screen width/height:1600/1200 14:33:07 INFO - PID 1654 | colorDepth:24 14:33:07 INFO - PID 1654 | Browser inner width/height: 1024/689 14:33:07 INFO - PID 1654 | __metrics 14:33:07 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 14:33:08 INFO - TEST-INFO | 1654: exit 0 14:33:08 INFO - Browser initialized. 14:33:08 INFO - Running cycle 1/1 for kraken test... 14:33:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/T/tmpQeDzvx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:11 INFO - PID 1656 | 2017-04-13 14:33:11.134 plugin-container[1657:10307] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473f, name = 'com.apple.tsm.portname' 14:33:11 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:11 INFO - PID 1656 | 2017-04-13 14:33:11.135 plugin-container[1657:10307] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:33:11 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:33:11 INFO - PID 1656 | 2017-04-13 14:33:11.135 plugin-container[1657:10307] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:33:21 INFO - PID 1656 | RSS: Main: 250195968 14:33:21 INFO - PID 1656 | 14:33:24 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 14:33:25 INFO - PID 1656 | RSS: Main: 258760704 14:33:25 INFO - PID 1656 | 14:33:27 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 14:33:28 INFO - PID 1656 | RSS: Main: 265928704 14:33:28 INFO - PID 1656 | 14:33:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 14:33:32 INFO - PID 1656 | RSS: Main: 262111232 14:33:32 INFO - PID 1656 | 14:33:34 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 14:33:34 INFO - PID 1656 | RSS: Main: 264359936 14:33:34 INFO - PID 1656 | 14:33:36 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:33:37 INFO - PID 1656 | RSS: Main: 265011200 14:33:37 INFO - PID 1656 | 14:33:40 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 14:33:41 INFO - PID 1656 | RSS: Main: 271015936 14:33:41 INFO - PID 1656 | 14:33:44 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 14:33:45 INFO - PID 1656 | RSS: Main: 270827520 14:33:45 INFO - PID 1656 | 14:33:48 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 14:33:49 INFO - PID 1656 | RSS: Main: 270987264 14:33:49 INFO - PID 1656 | 14:33:50 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:33:51 INFO - PID 1656 | RSS: Main: 270884864 14:33:51 INFO - PID 1656 | 14:33:53 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:33:54 INFO - PID 1656 | RSS: Main: 270671872 14:33:54 INFO - PID 1656 | 14:33:56 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:33:56 INFO - PID 1656 | RSS: Main: 270696448 14:33:56 INFO - PID 1656 | 14:33:59 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:34:00 INFO - PID 1656 | RSS: Main: 271187968 14:34:00 INFO - PID 1656 | 14:34:03 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:34:04 INFO - PID 1656 | RSS: Main: 270749696 14:34:04 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 14:34:06 INFO - PID 1656 | RSS: Main: 273817600 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | __start_tp_report 14:34:06 INFO - PID 1656 | _x_x_mozilla_page_load 14:34:06 INFO - PID 1656 | _x_x_mozilla_page_load_details 14:34:06 INFO - PID 1656 | |i|pagename|runs| 14:34:06 INFO - PID 1656 | |0;ai-astar;104;114;114;118;117;116;117;116;115;117 14:34:06 INFO - PID 1656 | |1;audio-beat-detection;143;107;111;149;127;114;111;113;132;113 14:34:06 INFO - PID 1656 | |2;audio-dft;199;198;225;260;278;197;197;201;193;194 14:34:06 INFO - PID 1656 | |3;audio-fft;83;58;61;89;59;88;87;51;98;73 14:34:06 INFO - PID 1656 | |4;audio-oscillator;82;70;84;71;72;93;122;103;103;116 14:34:06 INFO - PID 1656 | |5;imaging-gaussian-blur;88;90;90;85;90;101;89;89;80;134 14:34:06 INFO - PID 1656 | |6;imaging-darkroom;122;112;153;116;153;139;98;97;113;97 14:34:06 INFO - PID 1656 | |7;imaging-desaturate;91;144;92;114;143;92;117;136;141;142 14:34:06 INFO - PID 1656 | |8;json-parse-financial;53;51;64;72;76;79;80;76;73;53 14:34:06 INFO - PID 1656 | |9;json-stringify-tinderbox;58;65;75;59;61;57;57;65;50;60 14:34:06 INFO - PID 1656 | |10;stanford-crypto-aes;103;83;86;100;98;72;110;102;106;84 14:34:06 INFO - PID 1656 | |11;stanford-crypto-ccm;162;158;157;132;140;138;182;158;194;129 14:34:06 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;193;196;192;191;194;187;189;188;195;193 14:34:06 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;71;72;71;71;68;71;69;70;72;73 14:34:06 INFO - PID 1656 | __end_tp_report 14:34:06 INFO - PID 1656 | __start_cc_report 14:34:06 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1006 14:34:06 INFO - PID 1656 | __end_cc_report 14:34:06 INFO - PID 1656 | __startTimestamp1492119246559__endTimestamp 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | ------- Summary: start ------- 14:34:06 INFO - PID 1656 | Number of tests: 14 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.50 stddev:4.02 (3.5%) stddev-sans-first:1.41 14:34:06 INFO - PID 1656 | Values: 104.0 114.0 114.0 118.0 117.0 116.0 117.0 116.0 115.0 117.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:122.00 Median:120.50 stddev:14.86 (12.3%) stddev-sans-first:13.68 14:34:06 INFO - PID 1656 | Values: 143.0 107.0 111.0 149.0 127.0 114.0 111.0 113.0 132.0 113.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:214.20 Median:200.00 stddev:30.55 (15.3%) stddev-sans-first:31.91 14:34:06 INFO - PID 1656 | Values: 199.0 198.0 225.0 260.0 278.0 197.0 197.0 201.0 193.0 194.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:74.70 Median:85.00 stddev:16.40 (19.3%) stddev-sans-first:17.12 14:34:06 INFO - PID 1656 | Values: 83.0 58.0 61.0 89.0 59.0 88.0 87.0 51.0 98.0 73.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:71.50 stddev:18.88 (26.4%) stddev-sans-first:19.70 14:34:06 INFO - PID 1656 | Values: 82.0 70.0 84.0 71.0 72.0 93.0 122.0 103.0 103.0 116.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:89.00 stddev:15.12 (17.0%) stddev-sans-first:15.90 14:34:06 INFO - PID 1656 | Values: 88.0 90.0 90.0 85.0 90.0 101.0 89.0 89.0 80.0 134.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:120.00 Median:153.00 stddev:21.64 (14.1%) stddev-sans-first:22.94 14:34:06 INFO - PID 1656 | Values: 122.0 112.0 153.0 116.0 153.0 139.0 98.0 97.0 113.0 97.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:121.20 Median:143.50 stddev:22.91 (16.0%) stddev-sans-first:21.54 14:34:06 INFO - PID 1656 | Values: 91.0 144.0 92.0 114.0 143.0 92.0 117.0 136.0 141.0 142.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:74.50 stddev:11.49 (15.4%) stddev-sans-first:10.89 14:34:06 INFO - PID 1656 | Values: 53.0 51.0 64.0 72.0 76.0 79.0 80.0 76.0 73.0 53.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:6.62 (10.9%) stddev-sans-first:6.95 14:34:06 INFO - PID 1656 | Values: 58.0 65.0 75.0 59.0 61.0 57.0 57.0 65.0 50.0 60.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:77.50 stddev:12.31 (15.9%) stddev-sans-first:12.66 14:34:06 INFO - PID 1656 | Values: 103.0 83.0 86.0 100.0 98.0 72.0 110.0 102.0 106.0 84.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:158.00 stddev:21.19 (13.4%) stddev-sans-first:22.32 14:34:06 INFO - PID 1656 | Values: 162.0 158.0 157.0 132.0 140.0 138.0 182.0 158.0 194.0 129.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.80 Median:193.00 stddev:3.01 (1.6%) stddev-sans-first:3.16 14:34:06 INFO - PID 1656 | Values: 193.0 196.0 192.0 191.0 194.0 187.0 189.0 188.0 195.0 193.0 14:34:06 INFO - PID 1656 | 14:34:06 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 14:34:06 INFO - PID 1656 | Values: 71.0 72.0 71.0 71.0 68.0 71.0 69.0 70.0 72.0 73.0 14:34:06 INFO - PID 1656 | -------- Summary: end -------- 14:34:06 INFO - PID 1656 | 14:34:07 INFO - TEST-INFO | 1656: exit 0 14:34:07 INFO - TEST-OK | kraken | took 62701ms 14:34:07 INFO - SUITE-END | took 1178s 14:34:07 INFO - Completed test suite (00:19:38) 14:34:07 INFO - javascript benchmark 14:34:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7799.87676670189, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.545568164775, 3474.548308719866, 3586.55168103987, 3650.3794354959646, 3652.0322114639607, 6129.754809807602, 6144.477719393852, 6168.105624684424, 6191.28800187978, 6215.689215539228, 5308.0, 6087.4825639820665, 6098.359672234418, 6145.969270153654, 6148.770245950816, 5415.864603384907, 5420.430854760252, 5437.102878025121, 5505.064139096363, 5560.638558493685, 4526.569975852289, 5346.705931173784, 5491.2312276281355, 5499.1476321170285, 5500.697461639608, 5406.486383793534, 5457.345118585756, 5465.836024919259, 5470.261514695525, 5536.806211782588, 5303.602229832778, 5365.7853685852515, 5378.731063446812, 5389.9191512127345, 5402.486763757476, 5370.409254981949, 5397.919031214535, 5399.595030372738, 5447.346318441812, 5475.123980163195, 5931.525477961796, 6102.908456373158, 6197.690115494207, 6217.533684973645, 6247.531435142337, 6380.808575742735, 6453.741850325981, 6561.770338038145, 6658.234303055114, 6675.132232809752, 6667.19993600771, 6676.198856137246, 6680.699368528428, 6684.565503242274, 6692.665366731692, 6268.937310626881, 6288.245410550763, 6290.43386095249, 6296.5592408530965, 6299.307076221658, 6575.901361479581, 6665.500087493458, 6776.11910451648, 6827.112475378169, 6829.93170068293, 6283.874322513524, 6317.715702793385, 6380.649064301508, 6451.29035806061, 6484.805455836333, 6469.77355792545, 6588.8023359299295, 6672.132622759011, 6690.063391125246, 6695.096162018162, 6501.057346684799, 6602.60384376939, 6620.933790662032, 6633.6019838809825, 6645.302243264484, 6297.842553936188, 6323.620582765049, 6654.101696271038, 6674.733010679615, 6679.131712877295, 5324.935012997416, 5343.225232341289, 5407.486288802557, 5423.29497165366, 5424.7016414096815, 4740.265258884879, 4763.476017638057, 4771.880702982384, 4783.378160839069, 4806.5557486963, 5090.9236361454605, 5583.246261754611, 6171.7531298748445, 6292.465140463112, 6300.495960323163, 6104.969475152596, 6330.0, 6729.629870357177, 6730.865382692319, 6780.423663988616, 6241.843953901098, 6289.182406287154, 6293.496520278367, 6302.401271879165, 6307.684615769193, 5934.703264836741, 5989.101634754822, 5991.0, 5995.999999999913, 6002.129691194752, 6671.866562668816, 6822.965885170741, 6832.760853370109, 6876.518643694893, 6882.174139103339, 5641.351244606923, 6687.699053542505, 6694.866102678016, 6703.564268322543, 6705.497087718343, 6829.078074459884, 6866.416354609914, 6872.484563657846, 6879.724811007503, 6882.7591034313555, 6354.491640668828, 6425.518086143465, 6500.349965003462, 6562.770303039561, 6568.0, 5636.520895723909, 6599.901001485077, 6686.231083425469, 6702.865942681216, 6707.195136583446, 6407.199100112486, 6467.708953097028, 6486.124373209556, 6500.0, 6503.154589903283, 6219.346968568416, 6306.243250809932, 6469.611823290429, 6539.346065393423, 6540.934590654033, 4819.963707802839, 6090.512758979183, 6263.592866463665, 6337.65142917144, 6356.841078973062, 6449.4517965971545, 6479.028145778171, 6479.8056058318325, 6490.48076153916, 6492.123563319081, 6113.202667687734, 6229.065640154013, 6234.9688251558455, 6272.529560282906, 6312.684365781784], "value": 6034.065733750497, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.453284171925, 741.2291217134181, 829.4940086547207, 1074.350018238966, 1286.8520120186176, 36740.0, 37792.0, 37839.43240851386, 37914.8104259479, 38044.80977595115, 37274.44088338677, 37529.81235093828, 37535.81232093843, 37763.811180944125, 37821.62178378215, 8036.276735093826, 8194.262516373525, 8502.27730642893, 8750.03749587545, 8750.299976001905, 8685.261752751023, 8761.912380876174, 8826.823463530725, 8829.470231786081, 8834.690785822497, 8784.0, 8789.121087891224, 8789.165029322205, 8854.955725221365, 8869.201771840533, 8805.119488051176, 8811.118888111201, 8819.911800881973, 8826.602802873886, 8827.602757875879, 8544.231019208239, 8582.485050896967, 8591.957040214822, 8596.914030859674, 8613.956930215309, 36868.81565592182, 37023.81488092569, 37029.0, 37112.44331335032, 37156.62843371559, 3711.1464363196615, 3733.9813300933592, 3737.3272810894027, 3741.4574886641285, 3742.850285988557, 30447.086587402413, 30553.083407497812, 30639.234019149477, 30682.693173068208, 30706.23234419135, 2843.5023870822524, 3130.1861516006, 3235.5793746813, 3246.6753324667343, 3253.0, 182710.08644956822, 185800.07099964548, 191984.12023819654, 249607.0, 251753.0, 45508.544914551094, 46011.76994115075, 46076.76961615238, 46164.53835461669, 46806.82982925386, 35381.82309088438, 47975.76012119987, 48132.0, 48204.03591928212, 48483.515164848606, 14274.571762847132, 14286.571402857722, 14352.49766258176, 14357.353919073666, 14409.639759005899, 11615.76768464643, 11691.941540292244, 11751.941240293743, 11798.823017654742, 11825.645230643095, 13177.868221317856, 13208.669783255304, 13229.470821167239, 13329.0, 13338.73322533544, 5523.530499907552, 5569.192467092249, 5895.528357731371, 5922.615030023035, 5956.123820996372, 998.1864780204111, 1020.7907378987289, 1024.3904876598413, 1042.7966546523355, 1043.76515284062, 19315.130819113172, 22772.4306892329, 23502.529949400916, 23573.88213058958, 23986.640200397007, 1120.4845770945456, 1120.7254222715487, 1156.306216270248, 1156.3582211872324, 1163.941802909851, 10254.28220024606, 11192.496337664825, 11616.489856318625, 12126.393680315949, 12141.939290303668, 312003.0, 313363.0, 313659.43170284, 314301.0, 316286.0, 49859.0, 49974.750126249135, 50165.24752128721, 50186.0, 50385.496145038815, 1295.3199570225706, 1509.4264179611678, 1552.906825590468, 1555.7588573771084, 1573.1504987306955, 20042.39872803818, 23020.539589208456, 23171.07315707353, 23509.294721158392, 23547.822608869832, 28117.43765124727, 36186.638133618326, 36365.27269454649, 36384.818075909454, 37027.0, 201006.0, 278509.60745196143, 278722.0, 278757.60621196765, 278942.0, 27902.02342917988, 28509.714902850705, 31615.051548453583, 32284.0, 32345.35309293848, 34290.0, 38420.80789596146, 40889.911008898875, 40959.38560921648, 41215.0, 28513.0, 28827.855860720563, 29496.410071798873, 29522.55716164302, 29773.255668608457, 28387.290317741397, 29323.70676293295, 29575.260618483848, 29580.556291656074, 29606.555901661923, 33644.83177584194, 34696.959091227305, 34877.128071798405, 34918.825405872805, 34922.77770278028, 29396.85301573564, 30817.537736933515, 31564.842175788974, 31593.684063159075, 31644.05067847968, 21599.892000539898, 24228.515429690953, 24236.030558777453, 24449.633255501536, 24820.00719971181], "value": 16992.523683557454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.93823895535127, 429.5970810938052, 431.3249764119154, 439.7559354558221, 455.00027379666346, 19686.606267874635, 21214.469638259052, 21920.89039554804, 22004.33986980393, 22160.335189944308, 21354.57290854182, 22356.776432235674, 23020.19429319974, 23098.88450557749, 23251.418714532145, 6176.444120029197, 6205.317415084349, 6392.776252831151, 6410.487161027107, 6420.711068001951, 6124.540659450559, 6290.905636415435, 6355.745770169211, 6361.4274715275615, 6372.968135159341, 5182.792688292464, 6192.195014648089, 6272.153259310003, 6274.278457977345, 6301.527385446087, 6175.814725558241, 6236.563440559163, 6242.157308763327, 6246.094316324107, 6257.18656574647, 5368.677879327214, 5529.585281103893, 5543.002259593271, 5556.111022236423, 5616.073347897633, 27221.04726334569, 27341.179764607095, 27497.86251068732, 27574.310642233904, 27870.860645696845, 2204.5921504521716, 2252.583272094668, 2269.4780200553964, 2270.9886450567806, 2292.7592602776804, 14240.359183836752, 15390.15354155521, 17995.570597969367, 18083.367082152192, 18400.907995459937, 1930.7200455933812, 2019.4951262184454, 2192.0, 2228.2980861028723, 2234.754177040524, 108217.0961194268, 113269.0, 130922.0, 132735.0, 133917.3304133473, 9449.952750236205, 12586.18189817659, 12589.0, 12751.744965100646, 12758.61724148277, 16086.597835054217, 16223.26995285215, 16229.0, 16229.0, 16233.107179105262, 8839.646414143492, 9074.45553266806, 9078.954605227063, 9130.26957843371, 9217.032211617683, 8724.694635687847, 8737.563121843883, 8747.475151490804, 8918.375713700108, 8922.420042697204, 7728.497647652997, 7812.57030863308, 7848.489848159966, 7883.921160788434, 7897.921020789719, 2068.214078650103, 2104.0, 2177.1182671017946, 2196.5832038335184, 2250.3586477853733, 995.8854731705947, 1004.9748756281151, 1005.7737009172878, 1035.2804800663466, 1044.1177205261542, 20444.693329600068, 21274.893625531775, 21294.574108517743, 21403.250886218906, 21538.56922861534, 1037.4086770540719, 1039.7660526381655, 1063.3619828103076, 1077.2674581284646, 1080.5623722392443, 8472.788180295542, 9549.379290346105, 10810.51352689115, 11059.668209953714, 11060.834087488694, 624726.0, 629701.8514907488, 640802.0, 642870.3569446462, 652827.0, 125811.0, 129816.0, 132699.0, 151467.24266378817, 154317.2284138572, 1210.7094297368744, 1211.4003568233782, 1257.735875466144, 1264.2288204195434, 1264.4057293072242, 22042.0, 22112.889435553363, 22138.77861221367, 22220.333389998326, 22364.664530032387, 61431.0, 62252.75494489994, 62437.375626243156, 62546.68726656338, 62762.686186568775, 64822.0, 73806.15484612927, 87950.56024720092, 88584.0, 89219.55390223008, 8716.041235464221, 8744.825103497767, 8780.912190878265, 8982.955085224532, 9172.266218702622, 13703.45186192581, 13769.655758606115, 13771.655708607364, 14037.298135093, 14117.505887293895, 10179.694609161737, 11750.0, 11798.705032374259, 11961.64115076549, 12112.75774484523, 9769.364991275545, 10652.467376630982, 10708.30396024256, 11368.886311137114, 11612.94193529027, 11154.721131971766, 11895.345755983504, 12098.576549821066, 12161.574344897886, 12306.13857030035, 6467.773627923, 8732.301415886841, 8893.822123557364, 8933.776655583662, 8977.371583989057, 11887.643370698894, 11903.761924761284, 12001.63995080149, 12142.453589588666, 12148.0], "value": 10544.577712902008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1156.8611766588008, 1287.9162854414465, 1338.53820431951, 1447.0449503327807, 1447.8696917277443, 11223.831642525369, 11729.0, 11800.468978895939, 11816.704582385444, 12113.939430302837, 10022.749431264223, 11776.234544754585, 11935.403229838495, 11988.460519276632, 12006.699832504191, 2519.2316343515267, 2559.34736642156, 2562.5771747661615, 2564.7178810330847, 2565.307367010906, 2462.7906627936645, 2487.9378015549664, 2529.7217306096313, 2530.114459939016, 2538.225841118458, 2464.544059349026, 2517.496500699858, 2531.5443220220354, 2542.898284068635, 2567.82025258232, 2095.3609149209483, 2428.623563347675, 2484.888180031894, 2493.0651005872796, 2516.9119080832265, 2392.3181893160368, 2488.278399264211, 2498.350428888502, 2506.373406648338, 2514.7736703696573, 11839.112066594953, 11951.701207469796, 11957.581484648083, 11964.70088247792, 11968.0, 6552.967235163841, 6791.456683465311, 6796.66016699168, 6809.659517024179, 6819.624920629363, 4118.855840045614, 4383.9342409863875, 4454.955450445519, 4472.865814025585, 4478.328250762412, 1260.4496469342669, 1264.64589914824, 1281.8782215689494, 1306.915050521713, 1316.2431601828987, 14874.330655120546, 15337.23313834315, 16257.430989915414, 16488.67022659552, 16574.585635359093, 5567.109262518059, 5716.114002329646, 5874.353821079678, 5945.881082378328, 5975.103734439869, 12257.938710306391, 12328.32194229308, 12383.318917459626, 12412.317322547166, 12431.813522797165, 6612.140421745143, 6624.337566243337, 6632.535722499379, 6642.402183803384, 6649.202095748541, 6060.969695151584, 6115.84710382244, 6137.0, 6175.814725558241, 6200.627962322275, 3712.958593109594, 4484.0, 4548.749818759934, 4582.450105987303, 4591.678582499193, 1177.6996865799167, 1292.3990344489857, 1292.9741405171844, 1321.1016508774126, 1335.6527302901316, 734.5005396330547, 788.66087582339, 789.135896193667, 816.3387655998661, 820.4912953968578, 6338.462150127216, 6820.488463365267, 6948.478864085214, 7029.578225306498, 7042.718291268395, 866.7139843851639, 940.149165005671, 973.529969745675, 974.0794948773482, 982.2731178927543, 4128.174365126986, 4285.142971405731, 4372.191144638252, 4444.1333939881415, 4445.355423463579, 14777.039492432958, 15261.771073433907, 15341.232938353261, 15410.768838467431, 15566.299516521784, 14951.626209344853, 15072.849271507364, 15196.240187990556, 15218.619534511727, 15348.999999999776, 9607.807843843224, 10871.45642717861, 11059.059979901798, 11198.160137989684, 11214.439278036065, 6188.4739797117745, 7058.752943646948, 7235.204127546071, 7286.417086633162, 7317.085364329459, 10482.161427085968, 10738.946305268424, 12539.310337931502, 12674.239545627292, 12678.936605316914, 13812.309384530934, 13890.236037018061, 14038.227897465737, 14206.644833879236, 14247.0, 9646.710598682052, 9652.083052110038, 9687.225021998082, 9692.9030709692, 9729.610815567581, 10783.784324313312, 10882.61910833117, 10895.509702063267, 10897.0, 10901.781964360509, 8801.075887032026, 9056.275497960016, 9079.092090790868, 9118.316126290687, 9250.398724082914, 8938.955305223692, 8983.730488085368, 9015.233705134875, 9057.501837399006, 9082.500462474627, 8116.513009219466, 8123.83752324962, 8134.145914678874, 8265.173482651686, 8266.008079030555, 6001.219841420588, 6005.549583781147, 6063.575549711478, 6167.84580385494, 6196.535259855439, 6054.848628784315, 6124.969375153274, 6176.66028368426, 6235.844103897439, 6351.460125889166], "value": 5464.6148913227835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.25655051256206, 410.3311602088595, 413.4914055711475, 415.83358678905677, 420.4912056411742, 4717.64617653676, 6191.938080619192, 6221.0, 6224.875502489947, 6235.9999999999945, 5141.937869083419, 5792.451321418584, 6004.519638428927, 6013.458788709016, 6022.6687532185715, 4593.839215627454, 4594.310853371996, 4622.768861556909, 4629.907401851961, 4635.860924172281, 3979.343408337621, 4491.18107166598, 4605.792739326722, 4628.282616194495, 4629.675922685414, 3308.9669103308897, 3707.721920855933, 4035.01142220155, 4408.889777755566, 4422.358757980091, 3795.7663759278207, 3859.4982652255308, 4236.834870410631, 4385.605295523403, 4442.800073996678, 3665.157013886794, 3826.942595861064, 3830.6743926766258, 3834.2331533693095, 3846.403807409828, 4764.761761911891, 4840.540148685869, 5920.052791553331, 5948.196993405922, 5973.790917317917, 4710.2445069634305, 5337.57140501075, 5357.9819834231375, 5359.866003349908, 5373.355197376301, 5447.995723143486, 5731.770729170828, 6268.091126786636, 6409.910315246373, 6498.220213574354, 3549.4498352755104, 4140.834366625331, 4312.935305970413, 4356.455443069616, 4356.695031347807, 5562.610617256793, 6630.569013014187, 6876.69054892531, 6882.827929301758, 6887.793366199022, 3519.9296014079573, 4408.823647054146, 4449.9555004450185, 4461.219286624828, 4461.620762235181, 4287.421198138211, 4489.9775501122285, 4505.909881802346, 4513.961788788597, 4531.297648864365, 4522.186006518858, 5142.61430392722, 5257.76340064698, 5273.78904843802, 5358.624896257303, 5498.202760599691, 6519.511036672268, 6524.336294245032, 6569.638669873203, 6569.835754106186, 1410.0693542262059, 1477.9482718104814, 1500.9699806003819, 1544.9922750386177, 1545.1964978211267, 939.7885475768035, 964.62379671928, 1024.4365598920565, 1029.1818004686293, 1035.135661722455, 4826.031990325994, 6220.377962203744, 6232.034034724625, 6256.186695729526, 6273.905891411632, 6736.46108311334, 6739.359760822714, 6758.459323254128, 6778.6445709374175, 6829.931700683029, 4758.405199350082, 5189.325387699575, 6169.598976066542, 6211.254649442006, 6219.1604133442315, 3241.3793103448274, 3357.261402491448, 3375.341808347349, 3427.8286085695618, 3473.8436770345397, 4889.902201955941, 5496.395396506381, 5781.785824976802, 5917.3076250306, 6158.291796443376, 5284.9735751320995, 6080.422359875804, 6484.578502397329, 6504.739810407531, 6558.508111891627, 6431.967840160863, 6637.933620663732, 6975.883858582704, 7015.737167309933, 7023.192332881682, 5858.882822343615, 6761.526693131434, 6785.389314961677, 6798.354156355138, 6820.249772525118, 6454.0, 6677.599344039373, 6680.799576012728, 6683.966580167068, 6684.665766711548, 5598.9082128984455, 5763.337216220189, 7020.964895175492, 7032.718691252293, 7038.718451261892, 4069.7354671946227, 4139.110091330378, 4401.515833258403, 4433.958019865394, 4440.689151759475, 5024.974875125601, 6603.9009414859775, 6669.7665581704405, 6687.966560167168, 6808.523403361717, 6110.869489144522, 6392.9360706392345, 6416.00551914454, 6528.575642583217, 6538.378854008862, 5327.813526526708, 5707.771689132388, 6305.180326557518, 6528.706208220547, 6566.737330506726, 5879.265091863517, 6322.905156422566, 6372.203474565679, 6373.075903993988, 6433.453156481752, 5406.729663516887, 6534.150560427114, 6555.4427873631275, 6557.311482294481, 6581.638009909501, 5273.34083239595, 6064.151018857452, 6345.778977358073, 6362.204724409449, 6387.616742995435], "value": 4652.080221260525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.7531177679032, 837.3594200436667, 844.7381311793341, 880.1242763450368, 884.8495755721526, 14307.499237526688, 14546.490872819453, 16644.583885402855, 16651.58371040723, 17012.659746805057, 16587.83412165878, 16893.23980420881, 17042.573935651613, 17046.82953170468, 17608.0, 869.2524428991063, 997.6957028106425, 1022.7187523431079, 1025.174734338857, 1026.3226270661364, 1011.1910471622709, 1012.6759436980169, 1012.7721262715903, 1014.5586669798624, 1015.4161357219591, 1062.6971313175748, 1066.3228849680431, 1066.4134725900763, 1066.7813098314866, 1069.2568664777982, 1033.2302434686208, 1060.7030031591166, 1063.9468026598638, 1066.0192622786976, 1066.5467176450018, 767.6238643064858, 785.8231897823001, 787.7557957033281, 789.1319548496665, 790.7627711686471, 16731.498055058368, 17376.21807018687, 17380.56548586283, 17526.948383097057, 17659.38192163268, 16439.91780041092, 16505.009699418075, 16908.15459227046, 17043.829561704348, 17129.828701712948, 13767.655808604764, 13987.230702311368, 14098.859011409857, 14099.154050756988, 14126.576202713935, 3229.1927018245437, 3400.778949368308, 3418.0, 3448.189675426273, 3487.808170550619, 97666.0, 100765.0, 101872.47191292136, 102179.97820021854, 102674.45988310181, 11826.11304152192, 11878.287302761863, 12084.274943503418, 12087.03303735699, 12103.850134237233, 20086.69869951952, 20127.39617811468, 20166.29417970364, 20259.987000649908, 20409.591808163754, 7643.885341719879, 7849.686012559434, 8518.148185181431, 8893.555322233991, 8959.0, 4642.767861606973, 4718.05638872227, 4736.171170045228, 4740.312654665123, 4765.142274390643, 4688.789004494806, 4841.346418233564, 4880.145974454456, 4910.852674419773, 4916.360873086547, 929.972100836976, 947.4978261521404, 956.6508224498148, 963.4797209506928, 963.5904740485265, 665.7569986954824, 674.6694119881223, 676.8612434450926, 682.9624370659562, 694.7082225465317, 11370.31778093317, 11913.10651701126, 11972.58095966637, 12106.031517478757, 12171.391430428443, 656.3633275722541, 672.1463741048939, 689.8516818883965, 696.2028477393458, 712.0671919785098, 4755.381800366, 4967.7019378837385, 5244.056069907377, 5584.748686309044, 5708.743106560215, 88157.11842881617, 88885.55557222173, 89168.10831891728, 89255.0, 92214.53892730494, 47441.0, 64646.67676661586, 80939.0, 82445.0, 85346.71979920306, 70594.0, 74794.13838100506, 75657.24342756612, 75668.0, 75670.9999999989, 12017.339046352534, 12037.939810300892, 12129.757404851676, 12144.939275303566, 12191.085668574715, 38193.0, 38956.80521597374, 39058.6094139055, 39147.80426097851, 39573.60426395699, 49961.0, 50867.74566127146, 51244.74377628237, 51359.48640513547, 53103.0, 12569.87430125687, 13533.526326578523, 15998.9200053999, 16225.269862855963, 16608.418705345255, 15810.60473488172, 17366.39217627377, 17932.372366967094, 18220.726689099938, 18308.908455457637, 16470.258838352063, 16567.91716041412, 16612.0, 16649.583760406087, 16866.156692165587, 13813.378397971914, 16586.25361858695, 16659.666806663558, 16741.91629041847, 16864.241109149872, 16108.194590270674, 16311.0, 16332.673346532765, 16415.42546010884, 16420.425285114965, 10403.323783954018, 11648.359340236368, 11803.468843901874, 12025.63923082309, 12103.942329803778, 12804.423800929168, 13294.734105318033, 13338.533151339656, 13558.864411356155, 13703.0], "value": 8192.040716582456, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 118.0, 117.0, 116.0, 117.0, 116.0, 115.0, 117.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 111.0, 149.0, 127.0, 114.0, 111.0, 113.0, 132.0, 113.0], "value": 122.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 225.0, 260.0, 278.0, 197.0, 197.0, 201.0, 193.0, 194.0], "value": 214.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 61.0, 89.0, 59.0, 88.0, 87.0, 51.0, 98.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 84.0, 71.0, 72.0, 93.0, 122.0, 103.0, 103.0, 116.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 90.0, 85.0, 90.0, 101.0, 89.0, 89.0, 80.0, 134.0], "value": 93.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 112.0, 153.0, 116.0, 153.0, 139.0, 98.0, 97.0, 113.0, 97.0], "value": 120.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 144.0, 92.0, 114.0, 143.0, 92.0, 117.0, 136.0, 141.0, 142.0], "value": 121.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 64.0, 72.0, 76.0, 79.0, 80.0, 76.0, 73.0, 53.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 75.0, 59.0, 61.0, 57.0, 57.0, 65.0, 50.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 83.0, 86.0, 100.0, 98.0, 72.0, 110.0, 102.0, 106.0, 84.0], "value": 94.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 157.0, 132.0, 140.0, 138.0, 182.0, 158.0, 194.0, 129.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 196.0, 192.0, 191.0, 194.0, 187.0, 189.0, 188.0, 195.0, 193.0], "value": 191.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 71.0, 68.0, 71.0, 69.0, 70.0, 72.0, 73.0], "value": 70.8, "unit": "score"}]}]} 14:34:07 INFO - Return code: 0 14:34:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:34:07 ERROR - # TBPL SUCCESS # 14:34:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:34:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:34:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:34:07 INFO - 2017-04-13 14:34:07.873 screenresolution[1661:10704] starting screenresolution argv=screenresolution get 14:34:07 INFO - 2017-04-13 14:34:07.876 screenresolution[1661:10704] Display 0: 1600x1200x32@60 14:34:07 INFO - 2017-04-13 14:34:07.883 screenresolution[1662:10707] starting screenresolution argv=screenresolution list 14:34:07 INFO - Available Modes on Display 0 14:34:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:34:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:34:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:34:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:34:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:34:08 INFO - Intel Iris: 14:34:08 INFO - Chipset Model: Intel Iris 14:34:08 INFO - Type: GPU 14:34:08 INFO - Bus: Built-In 14:34:08 INFO - VRAM (Dynamic, Max): 1536 MB 14:34:08 INFO - Vendor: Intel (0x8086) 14:34:08 INFO - Device ID: 0x0a2e 14:34:08 INFO - Revision ID: 0x0009 14:34:08 INFO - Displays: 14:34:08 INFO - Display: 14:34:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:34:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:34:08 INFO - Display Serial Number: 1600x1200 60 14:34:08 INFO - Main Display: Yes 14:34:08 INFO - Mirror: Off 14:34:08 INFO - Online: Yes 14:34:08 INFO - Rotation: Supported 14:34:08 INFO - Return code: 0 14:34:08 INFO - Running post-action listener: _resource_record_post_action 14:34:08 INFO - [mozharness: 2017-04-13 21:34:08.127907Z] Finished run-tests step (success) 14:34:08 INFO - Running post-run listener: _resource_record_post_run 14:34:08 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40368640; Write bytes: 516448256; Read time: 396; Write time: 1732 14:34:08 INFO - TinderboxPrint: CPU usage
54.3% 14:34:08 INFO - TinderboxPrint: I/O read bytes / time
40,368,640 / 396 14:34:08 INFO - TinderboxPrint: I/O write bytes / time
516,448,256 / 1,732 14:34:08 INFO - TinderboxPrint: CPU idle
2,192.3 (45.7%) 14:34:08 INFO - TinderboxPrint: CPU system
967.2 (20.2%) 14:34:08 INFO - TinderboxPrint: CPU user
1,634.2 (34.1%) 14:34:08 INFO - TinderboxPrint: Swap in / out
248,250,368 / 0 14:34:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196667904; Write bytes: 193840640; Read time: 15151; Write time: 413 14:34:08 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 39397888; Write bytes: 305768960; Read time: 380; Write time: 1268 14:34:08 INFO - Running post-run listener: _upload_blobber_files 14:34:08 INFO - Blob upload gear active. 14:34:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:34:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:34:09 INFO - (blobuploader) - INFO - Open directory for files ... 14:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:34:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:10 INFO - (blobuploader) - INFO - Done attempting. 14:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:11 INFO - (blobuploader) - INFO - Done attempting. 14:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:12 INFO - (blobuploader) - INFO - Done attempting. 14:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:34:14 INFO - (blobuploader) - INFO - Done attempting. 14:34:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:34:14 INFO - Return code: 0 14:34:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:34:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:34:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351ee838d3150bab91d3619ca63ebc1b4b51c5ea50f8e070742518447ec41177b1d2828afdd6e5958e8552c6676ab27099d4ad478537cf3be495cebdaf49944d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6ff032cd5a1d11eb1684c3df24b8f4aad0269f9fd5c11a549dc12a8abb1f24c2fd05906e43e764348f63b32233a0744d4d511283422cfad021a9753e9caa582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a41c491b58b39b506295a6c74b514e1ad48f21e6fe01cb1b0289d99226d56fcd0ace32403563c061e9df9e075fbab7f942fd2bac5c245e26d0ad396daec5e142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a7c22ff25a7bc49929986d1199e564e5dce2714aec776b0f768ddb127eca164b8ca886b0b686bbb00d6e28f756304d2ba4da155a7a43a9ca3c64b88ee37fa5"} 14:34:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:34:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:34:14 INFO - Contents: 14:34:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351ee838d3150bab91d3619ca63ebc1b4b51c5ea50f8e070742518447ec41177b1d2828afdd6e5958e8552c6676ab27099d4ad478537cf3be495cebdaf49944d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6ff032cd5a1d11eb1684c3df24b8f4aad0269f9fd5c11a549dc12a8abb1f24c2fd05906e43e764348f63b32233a0744d4d511283422cfad021a9753e9caa582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a41c491b58b39b506295a6c74b514e1ad48f21e6fe01cb1b0289d99226d56fcd0ace32403563c061e9df9e075fbab7f942fd2bac5c245e26d0ad396daec5e142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a7c22ff25a7bc49929986d1199e564e5dce2714aec776b0f768ddb127eca164b8ca886b0b686bbb00d6e28f756304d2ba4da155a7a43a9ca3c64b88ee37fa5"} 14:34:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:34:14 INFO - Copying logs to upload dir... 14:34:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:34:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.348859 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-13 14:34:14.200097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 14:34:14.203722) ========= 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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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/351ee838d3150bab91d3619ca63ebc1b4b51c5ea50f8e070742518447ec41177b1d2828afdd6e5958e8552c6676ab27099d4ad478537cf3be495cebdaf49944d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6ff032cd5a1d11eb1684c3df24b8f4aad0269f9fd5c11a549dc12a8abb1f24c2fd05906e43e764348f63b32233a0744d4d511283422cfad021a9753e9caa582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a41c491b58b39b506295a6c74b514e1ad48f21e6fe01cb1b0289d99226d56fcd0ace32403563c061e9df9e075fbab7f942fd2bac5c245e26d0ad396daec5e142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a7c22ff25a7bc49929986d1199e564e5dce2714aec776b0f768ddb127eca164b8ca886b0b686bbb00d6e28f756304d2ba4da155a7a43a9ca3c64b88ee37fa5"} build_url:https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011138 build_url: 'https://queue.taskcluster.net/v1/task/TlZToCWdRzq7AzdyfmrOeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/351ee838d3150bab91d3619ca63ebc1b4b51c5ea50f8e070742518447ec41177b1d2828afdd6e5958e8552c6676ab27099d4ad478537cf3be495cebdaf49944d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6ff032cd5a1d11eb1684c3df24b8f4aad0269f9fd5c11a549dc12a8abb1f24c2fd05906e43e764348f63b32233a0744d4d511283422cfad021a9753e9caa582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a41c491b58b39b506295a6c74b514e1ad48f21e6fe01cb1b0289d99226d56fcd0ace32403563c061e9df9e075fbab7f942fd2bac5c245e26d0ad396daec5e142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5a7c22ff25a7bc49929986d1199e564e5dce2714aec776b0f768ddb127eca164b8ca886b0b686bbb00d6e28f756304d2ba4da155a7a43a9ca3c64b88ee37fa5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-13 14:34:14.240881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:34:14.241541) ========= 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.Hpb40iD91Z/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.jDshwcS9Wl/Listeners TMPDIR=/var/folders/0y/p7m66bps5fxgrhq27drfxb6r00000w/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.005058 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-13 14:34:14.290588) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 14:34:14.290965) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-13 14:34:14.291392) ========= ========= Total master_lag: 0.19 =========