builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0007 starttime: 1493466713.24 results: success (0) buildid: 20170429030208 builduid: 1e4c852f6d8946559e5a338fabea79f5 revision: 308cdb913d717f8edc932f5bac93854e3e54b84d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 04:51:53.244861) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 04:51:53.245316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-04-29 04:51:53.245589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-04-29 04:51:54.580067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 04:51:54.580457) ========= 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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-29 04:51:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 184M=0s 2017-04-29 04:51:55 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.074914 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 04:51:55.906452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 04:51:55.906796) ========= 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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.031164 ========= master_lag: 0.48 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 04:51:56.417079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2017-04-29 04:51:56.417613) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 308cdb913d717f8edc932f5bac93854e3e54b84d --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 308cdb913d717f8edc932f5bac93854e3e54b84d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-29 04:51:56,645 truncating revision to first 12 chars 2017-04-29 04:51:56,645 Setting DEBUG logging. 2017-04-29 04:51:56,645 attempt 1/10 2017-04-29 04:51:56,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/308cdb913d71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-29 04:52:01,285 unpacking tar archive at: mozilla-central-308cdb913d71/testing/mozharness/ program finished with exit code 0 elapsedTime=9.718884 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2017-04-29 04:52:06.401298) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 04:52:06.401684) ========= script_repo_revision: 308cdb913d717f8edc932f5bac93854e3e54b84d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 04:52:06.402176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-04-29 04:52:06.402460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-04-29 04:52:07.428556) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2017-04-29 04:52:07.429016) ========= /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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:52:07 INFO - MultiFileLogger online at 20170429 04:52:07 in /builds/slave/test 04:52:07 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 04:52:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:07 INFO - {'append_to_log': False, 04:52:07 INFO - 'base_work_dir': '/builds/slave/test', 04:52:07 INFO - 'blob_upload_branch': 'Firefox', 04:52:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:07 INFO - 'branch': 'Firefox', 04:52:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:07 INFO - 'config_files': ('talos/mac_config.py',), 04:52:07 INFO - 'default_actions': ('clobber', 04:52:07 INFO - 'read-buildbot-config', 04:52:07 INFO - 'download-and-extract', 04:52:07 INFO - 'populate-webroot', 04:52:07 INFO - 'create-virtualenv', 04:52:07 INFO - 'install', 04:52:07 INFO - 'run-tests'), 04:52:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:07 INFO - 'download_minidump_stackwalk': True, 04:52:07 INFO - 'download_symbols': 'ondemand', 04:52:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:07 INFO - 'gecko_profile': False, 04:52:07 INFO - 'gecko_profile_interval': 0, 04:52:07 INFO - 'installer_path': 'installer.exe', 04:52:07 INFO - 'log_level': 'info', 04:52:07 INFO - 'log_name': 'talos', 04:52:07 INFO - 'log_to_console': True, 04:52:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:52:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:52:07 INFO - 'opt_config_files': (), 04:52:07 INFO - 'pip_index': False, 04:52:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:07 INFO - 'cmd': ('bash', 04:52:07 INFO - '-c', 04:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:07 INFO - 'enabled': True, 04:52:07 INFO - 'halt_on_failure': False, 04:52:07 INFO - 'name': 'check_screen_resolution'},), 04:52:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:52:07 INFO - 'cmd': ('bash', 04:52:07 INFO - '-c', 04:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:52:07 INFO - 'enabled': True, 04:52:07 INFO - 'halt_on_failure': False, 04:52:07 INFO - 'name': 'check_screen_resolution'},), 04:52:07 INFO - 'run_cmd_checks_enabled': True, 04:52:07 INFO - 'suite': 'dromaeojs-e10s', 04:52:07 INFO - 'system_bits': '32', 04:52:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:07 INFO - 'title': 't-yosemite-r7-0007', 04:52:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:07 INFO - 'use_talos_json': True, 04:52:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:07 INFO - 'work_dir': 'build'} 04:52:07 INFO - [mozharness: 2017-04-29 11:52:07.782503Z] Running clobber step. 04:52:07 INFO - Running pre-action listener: _resource_record_pre_action 04:52:07 INFO - Running main action method: clobber 04:52:07 INFO - rmtree: /builds/slave/test/build 04:52:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:10 INFO - Running post-action listener: _resource_record_post_action 04:52:10 INFO - [mozharness: 2017-04-29 11:52:10.293113Z] Finished clobber step (success) 04:52:10 INFO - [mozharness: 2017-04-29 11:52:10.293252Z] Running read-buildbot-config step. 04:52:10 INFO - Running pre-action listener: _resource_record_pre_action 04:52:10 INFO - Running main action method: read_buildbot_config 04:52:10 INFO - Using buildbot properties: 04:52:10 INFO - { 04:52:10 INFO - "project": "", 04:52:10 INFO - "product": "firefox", 04:52:10 INFO - "script_repo_revision": "production", 04:52:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:52:10 INFO - "repository": "", 04:52:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:52:10 INFO - "buildid": "20170429030208", 04:52:10 INFO - "stage_platform": "macosx64", 04:52:10 INFO - "basedir": "/builds/slave/test", 04:52:10 INFO - "nightly_build": "True", 04:52:10 INFO - "buildnumber": 132, 04:52:10 INFO - "slavename": "t-yosemite-r7-0007", 04:52:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:52:10 INFO - "platform": "yosemite_r7", 04:52:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:52:10 INFO - "branch": "mozilla-central", 04:52:10 INFO - "repo_path": "mozilla-central", 04:52:10 INFO - "revision": "308cdb913d717f8edc932f5bac93854e3e54b84d", 04:52:10 INFO - "pgo_build": "False", 04:52:10 INFO - "builduid": "1e4c852f6d8946559e5a338fabea79f5", 04:52:10 INFO - "slavebuilddir": "test" 04:52:10 INFO - } 04:52:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:52:10 INFO - Running post-action listener: _resource_record_post_action 04:52:10 INFO - [mozharness: 2017-04-29 11:52:10.296762Z] Finished read-buildbot-config step (success) 04:52:10 INFO - [mozharness: 2017-04-29 11:52:10.296894Z] Running download-and-extract step. 04:52:10 INFO - Running pre-action listener: _resource_record_pre_action 04:52:10 INFO - Running main action method: download_and_extract 04:52:10 INFO - mkdir: /builds/slave/test/build/tests 04:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:10 INFO - trying https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:52:10 INFO - Downloading https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/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 04:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/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 04:52:12 INFO - Downloaded 1325 bytes. 04:52:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:52:12 INFO - Using the following test package requirements: 04:52:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:52:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:52:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:52:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:52:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'jsshell-mac.zip'], 04:52:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:52:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:52:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:52:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:52:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:52:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:52:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:52:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:52:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:12 INFO - Fetch https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:14 INFO - Content-Length response header: 52697505 04:52:14 INFO - Bytes received: 52697505 04:52:31 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 04:52:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:31 INFO - Fetch https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:47 INFO - Content-Length response header: 52697505 04:52:47 INFO - Bytes received: 52697505 04:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:53:04 INFO - Content-Length response header: 14408811 04:53:04 INFO - Bytes received: 14408811 04:53:05 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')]} 04:53:05 INFO - trying https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:53:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:53:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/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 04:53:07 INFO - Downloaded 71273784 bytes. 04:53:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:53:07 INFO - mkdir: /builds/slave/test/properties 04:53:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:53:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:53:07 INFO - Contents: 04:53:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:53:08 INFO - Running post-action listener: _resource_record_post_action 04:53:08 INFO - Running post-action listener: set_extra_try_arguments 04:53:08 INFO - [mozharness: 2017-04-29 11:53:08.131945Z] Finished download-and-extract step (success) 04:53:08 INFO - [mozharness: 2017-04-29 11:53:08.132071Z] Running populate-webroot step. 04:53:08 INFO - Running pre-action listener: _resource_record_pre_action 04:53:08 INFO - Running main action method: populate_webroot 04:53:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:53:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:53:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:53:08 INFO - '--tppagecycles', 04:53:08 INFO - '7'], 04:53:08 INFO - 'tests': ['tsvgm']}}, 04:53:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:53:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:53:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:53:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:53:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:53:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['damp', 'tps']}, 04:53:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'tests': ['damp', 'tps']}, 04:53:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['dromaeo_dom']}, 04:53:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:53:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:53:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:53:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['a11yr', 04:53:08 INFO - 'ts_paint', 04:53:08 INFO - 'tpaint', 04:53:08 INFO - 'sessionrestore', 04:53:08 INFO - 'sessionrestore_no_auto_restore', 04:53:08 INFO - 'tabpaint']}, 04:53:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:53:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:53:08 INFO - 'bloom_basic_ref']}, 04:53:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tsvgx', 04:53:08 INFO - 'tsvgr_opacity', 04:53:08 INFO - 'tart', 04:53:08 INFO - 'tscrollx', 04:53:08 INFO - 'cart', 04:53:08 INFO - 'tsvg_static']}, 04:53:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:53:08 INFO - 'tsvgr_opacity', 04:53:08 INFO - 'tart', 04:53:08 INFO - 'tscrollx', 04:53:08 INFO - 'cart', 04:53:08 INFO - 'tsvg_static']}, 04:53:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s'], 04:53:08 INFO - 'tests': ['tp5o']}, 04:53:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:53:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--disable-e10s', 04:53:08 INFO - '--xperf_path', 04:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:08 INFO - 'tests': ['tp5n']}, 04:53:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:53:08 INFO - 'talos_options': ['--xperf_path', 04:53:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:53:08 INFO - 'tests': ['tp5n']}}, 04:53:08 INFO - 'talos.zip': {'path': '', 04:53:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:53:08 INFO - Running post-action listener: _resource_record_post_action 04:53:08 INFO - [mozharness: 2017-04-29 11:53:08.151052Z] Finished populate-webroot step (success) 04:53:08 INFO - [mozharness: 2017-04-29 11:53:08.151177Z] Running create-virtualenv step. 04:53:08 INFO - Running pre-action listener: _resource_record_pre_action 04:53:08 INFO - Running main action method: create_virtualenv 04:53:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:53:08 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 04:53:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:53:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:53:08 INFO - Using real prefix '/tools/python27' 04:53:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:53:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:53:12 INFO - Installing pip.................done. 04:53:12 INFO - Return code: 0 04:53:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:53:12 INFO - Reading from file tmpfile_stdout 04:53:12 INFO - Output received: 04:53:12 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) 04:53:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:12 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 04:53:12 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 04:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:12 INFO - 'HOME': '/Users/cltbld', 04:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:12 INFO - 'LOGNAME': 'cltbld', 04:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:12 INFO - 'MOZ_NO_REMOTE': '1', 04:53:12 INFO - 'NO_EM_RESTART': '1', 04:53:12 INFO - 'PAGER': '/bin/cat', 04:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:12 INFO - 'PWD': '/builds/slave/test', 04:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:12 INFO - 'SHELL': '/bin/bash', 04:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:12 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:12 INFO - 'USER': 'cltbld', 04:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:12 INFO - 'XPC_FLAGS': '0x0', 04:53:12 INFO - 'XPC_SERVICE_NAME': '0', 04:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:12 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 04:53:12 INFO - Cleaning up... 04:53:12 INFO - Return code: 0 04:53:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:12 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:12 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 04:53:12 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 04:53:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:12 INFO - 'HOME': '/Users/cltbld', 04:53:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:12 INFO - 'LOGNAME': 'cltbld', 04:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:12 INFO - 'MOZ_NO_REMOTE': '1', 04:53:12 INFO - 'NO_EM_RESTART': '1', 04:53:12 INFO - 'PAGER': '/bin/cat', 04:53:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:12 INFO - 'PWD': '/builds/slave/test', 04:53:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:12 INFO - 'SHELL': '/bin/bash', 04:53:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:12 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:12 INFO - 'USER': 'cltbld', 04:53:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:12 INFO - 'XPC_FLAGS': '0x0', 04:53:12 INFO - 'XPC_SERVICE_NAME': '0', 04:53:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:13 INFO - Downloading/unpacking psutil>=3.1.1 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:16 INFO - Installing collected packages: psutil 04:53:16 INFO - Running setup.py install for psutil 04:53:17 INFO - building 'psutil._psutil_osx' extension 04:53:17 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 04:53:17 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 04:53:17 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 04:53:17 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 04:53:17 INFO - building 'psutil._psutil_posix' extension 04:53:17 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 04:53:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:53:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:53:17 INFO - ^ 04:53:17 INFO - 1 warning generated. 04:53:17 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 04:53:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:53:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:53:18 INFO - Successfully installed psutil 04:53:18 INFO - Cleaning up... 04:53:18 INFO - Return code: 0 04:53:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:53:18 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')]} 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 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')]} 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:18 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:18 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 04:53:18 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 04:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:18 INFO - 'HOME': '/Users/cltbld', 04:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:18 INFO - 'LOGNAME': 'cltbld', 04:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:18 INFO - 'MOZ_NO_REMOTE': '1', 04:53:18 INFO - 'NO_EM_RESTART': '1', 04:53:18 INFO - 'PAGER': '/bin/cat', 04:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:18 INFO - 'PWD': '/builds/slave/test', 04:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:18 INFO - 'SHELL': '/bin/bash', 04:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:18 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:18 INFO - 'USER': 'cltbld', 04:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:18 INFO - 'XPC_FLAGS': '0x0', 04:53:18 INFO - 'XPC_SERVICE_NAME': '0', 04:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:21 INFO - Installing collected packages: mozsystemmonitor 04:53:21 INFO - Running setup.py install for mozsystemmonitor 04:53:22 INFO - Successfully installed mozsystemmonitor 04:53:22 INFO - Cleaning up... 04:53:22 INFO - Return code: 0 04:53:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:22 INFO - 'HOME': '/Users/cltbld', 04:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:22 INFO - 'LOGNAME': 'cltbld', 04:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:22 INFO - 'MOZ_NO_REMOTE': '1', 04:53:22 INFO - 'NO_EM_RESTART': '1', 04:53:22 INFO - 'PAGER': '/bin/cat', 04:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:22 INFO - 'PWD': '/builds/slave/test', 04:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:22 INFO - 'SHELL': '/bin/bash', 04:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:22 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:22 INFO - 'USER': 'cltbld', 04:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:22 INFO - 'XPC_FLAGS': '0x0', 04:53:22 INFO - 'XPC_SERVICE_NAME': '0', 04:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:22 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:25 INFO - warning: no files found matching '*.txt' 04:53:25 INFO - no previously-included directories found matching 'build' 04:53:25 INFO - no previously-included directories found matching 'dist' 04:53:25 INFO - no previously-included directories found matching '.git*' 04:53:25 INFO - Installing collected packages: jsonschema, functools32 04:53:25 INFO - Running setup.py install for functools32 04:53:25 INFO - warning: no files found matching '*.txt' 04:53:25 INFO - no previously-included directories found matching 'build' 04:53:25 INFO - no previously-included directories found matching 'dist' 04:53:25 INFO - no previously-included directories found matching '.git*' 04:53:25 INFO - Successfully installed jsonschema functools32 04:53:25 INFO - Cleaning up... 04:53:25 INFO - Return code: 0 04:53:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:25 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:25 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 04:53:25 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 04:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:25 INFO - 'HOME': '/Users/cltbld', 04:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:25 INFO - 'LOGNAME': 'cltbld', 04:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:25 INFO - 'MOZ_NO_REMOTE': '1', 04:53:25 INFO - 'NO_EM_RESTART': '1', 04:53:25 INFO - 'PAGER': '/bin/cat', 04:53:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:25 INFO - 'PWD': '/builds/slave/test', 04:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:25 INFO - 'SHELL': '/bin/bash', 04:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:25 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:25 INFO - 'USER': 'cltbld', 04:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:25 INFO - 'XPC_FLAGS': '0x0', 04:53:25 INFO - 'XPC_SERVICE_NAME': '0', 04:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:26 INFO - Cleaning up... 04:53:26 INFO - Return code: 0 04:53:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:26 INFO - 'HOME': '/Users/cltbld', 04:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:26 INFO - 'LOGNAME': 'cltbld', 04:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:26 INFO - 'MOZ_NO_REMOTE': '1', 04:53:26 INFO - 'NO_EM_RESTART': '1', 04:53:26 INFO - 'PAGER': '/bin/cat', 04:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:26 INFO - 'PWD': '/builds/slave/test', 04:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:26 INFO - 'SHELL': '/bin/bash', 04:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:26 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:26 INFO - 'USER': 'cltbld', 04:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:26 INFO - 'XPC_FLAGS': '0x0', 04:53:26 INFO - 'XPC_SERVICE_NAME': '0', 04:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:29 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:30 INFO - Downloading docopt-0.6.1.tar.gz 04:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:30 INFO - Running setup.py install for blobuploader 04:53:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:31 INFO - Running setup.py install for requests 04:53:31 INFO - Running setup.py install for docopt 04:53:31 INFO - Successfully installed blobuploader requests docopt 04:53:31 INFO - Cleaning up... 04:53:31 INFO - Return code: 0 04:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:31 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')]} 04:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 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')]} 04:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:31 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:31 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 04:53:31 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 04:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:31 INFO - 'HOME': '/Users/cltbld', 04:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:31 INFO - 'LOGNAME': 'cltbld', 04:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:31 INFO - 'MOZ_NO_REMOTE': '1', 04:53:31 INFO - 'NO_EM_RESTART': '1', 04:53:31 INFO - 'PAGER': '/bin/cat', 04:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:31 INFO - 'PWD': '/builds/slave/test', 04:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:31 INFO - 'SHELL': '/bin/bash', 04:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:31 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:31 INFO - 'USER': 'cltbld', 04:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:31 INFO - 'XPC_FLAGS': '0x0', 04:53:31 INFO - 'XPC_SERVICE_NAME': '0', 04:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-9Q_VfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hE9B7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-IdikPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-6AYiCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-G1pS8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-D5rRBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-XBgrNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-YW9Zwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:32 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-TnsZ16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-mTrfFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-RMgeTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-uoTfFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-bsHe9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UoX5u2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-A3cf3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-agWsxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:33 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ocP56a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:33 INFO - Running setup.py install for manifestparser 04:53:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Running setup.py install for mozcrash 04:53:34 INFO - Running setup.py install for mozdebug 04:53:34 INFO - Running setup.py install for mozdevice 04:53:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Running setup.py install for mozfile 04:53:34 INFO - Running setup.py install for mozhttpd 04:53:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Running setup.py install for mozinfo 04:53:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Running setup.py install for mozInstall 04:53:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:34 INFO - Running setup.py install for mozleak 04:53:35 INFO - Running setup.py install for mozlog 04:53:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Running setup.py install for moznetwork 04:53:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Running setup.py install for mozprocess 04:53:35 INFO - Running setup.py install for mozprofile 04:53:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Running setup.py install for mozrunner 04:53:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:35 INFO - Running setup.py install for mozscreenshot 04:53:36 INFO - Running setup.py install for moztest 04:53:36 INFO - Running setup.py install for mozversion 04:53:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:36 INFO - Cleaning up... 04:53:36 INFO - Return code: 0 04:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:36 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:36 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 04:53:36 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 04:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:36 INFO - 'HOME': '/Users/cltbld', 04:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:36 INFO - 'LOGNAME': 'cltbld', 04:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:36 INFO - 'MOZ_NO_REMOTE': '1', 04:53:36 INFO - 'NO_EM_RESTART': '1', 04:53:36 INFO - 'PAGER': '/bin/cat', 04:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:36 INFO - 'PWD': '/builds/slave/test', 04:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:36 INFO - 'SHELL': '/bin/bash', 04:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:36 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:36 INFO - 'USER': 'cltbld', 04:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:36 INFO - 'XPC_FLAGS': '0x0', 04:53:36 INFO - 'XPC_SERVICE_NAME': '0', 04:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3FEWho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:36 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)) 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-a_CYuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:36 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)) 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-abBMwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:36 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)) 04:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-VZp8lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-wVqpag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ehXfey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ksu873-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-f22PQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-y198Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3qKiJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-o6PN6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-37s0ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:37 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)) 04:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:37 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-kQZ4Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:38 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)) 04:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:38 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8NPw5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:38 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)) 04:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:38 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-YgHxLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:38 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)) 04:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:38 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-cw9rX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:38 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)) 04:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:38 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3fwsuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:38 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)) 04:53:38 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)) 04:53:38 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)) 04:53:38 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)) 04:53:38 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)) 04:53:38 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)) 04:53:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:38 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 04:53:38 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 04:53:38 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 04:53:38 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 04:53:38 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 04:53:38 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 04:53:41 INFO - Downloading blessings-1.6.tar.gz 04:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:41 INFO - Installing collected packages: blessings 04:53:41 INFO - Running setup.py install for blessings 04:53:41 INFO - Successfully installed blessings 04:53:41 INFO - Cleaning up... 04:53:41 INFO - Return code: 0 04:53:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:41 INFO - Reading from file tmpfile_stdout 04:53:41 INFO - Current package versions: 04:53:41 INFO - blessings == 1.6 04:53:41 INFO - blobuploader == 1.2.4 04:53:41 INFO - docopt == 0.6.1 04:53:41 INFO - functools32 == 3.2.3-2 04:53:41 INFO - jsonschema == 2.5.1 04:53:41 INFO - manifestparser == 1.1 04:53:41 INFO - mozInstall == 1.12 04:53:41 INFO - mozcrash == 1.0 04:53:41 INFO - mozdebug == 0.1 04:53:41 INFO - mozdevice == 0.50 04:53:41 INFO - mozfile == 1.2 04:53:41 INFO - mozhttpd == 0.7 04:53:41 INFO - mozinfo == 0.9 04:53:41 INFO - mozleak == 0.1 04:53:41 INFO - mozlog == 3.4 04:53:41 INFO - moznetwork == 0.27 04:53:41 INFO - mozprocess == 0.25 04:53:41 INFO - mozprofile == 0.28 04:53:41 INFO - mozrunner == 6.13 04:53:41 INFO - mozscreenshot == 0.1 04:53:41 INFO - mozsystemmonitor == 0.3 04:53:41 INFO - moztest == 0.8 04:53:41 INFO - mozversion == 1.4 04:53:41 INFO - psutil == 3.1.1 04:53:41 INFO - requests == 1.2.3 04:53:41 INFO - wsgiref == 0.1.2 04:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:41 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')]} 04:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:41 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')]} 04:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:41 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:41 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 04:53:41 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 04:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:41 INFO - 'HOME': '/Users/cltbld', 04:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:41 INFO - 'LOGNAME': 'cltbld', 04:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:41 INFO - 'MOZ_NO_REMOTE': '1', 04:53:41 INFO - 'NO_EM_RESTART': '1', 04:53:41 INFO - 'PAGER': '/bin/cat', 04:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:41 INFO - 'PWD': '/builds/slave/test', 04:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:41 INFO - 'SHELL': '/bin/bash', 04:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:41 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:41 INFO - 'USER': 'cltbld', 04:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:41 INFO - 'XPC_FLAGS': '0x0', 04:53:41 INFO - 'XPC_SERVICE_NAME': '0', 04:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 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)) 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:42 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 0x1030f8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030fb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1a1d86b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, '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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:53:42 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 04:53:42 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 04:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:42 INFO - 'HOME': '/Users/cltbld', 04:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:42 INFO - 'LOGNAME': 'cltbld', 04:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:42 INFO - 'MOZ_NO_REMOTE': '1', 04:53:42 INFO - 'NO_EM_RESTART': '1', 04:53:42 INFO - 'PAGER': '/bin/cat', 04:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:42 INFO - 'PWD': '/builds/slave/test', 04:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:42 INFO - 'SHELL': '/bin/bash', 04:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:53:42 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:42 INFO - 'USER': 'cltbld', 04:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:42 INFO - 'XPC_FLAGS': '0x0', 04:53:42 INFO - 'XPC_SERVICE_NAME': '0', 04:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:42 INFO - Cleaning up... 04:53:42 INFO - Return code: 0 04:53:42 INFO - Running post-action listener: _resource_record_post_action 04:53:42 INFO - Running post-action listener: _start_resource_monitoring 04:53:42 INFO - Starting resource monitoring. 04:53:42 INFO - [mozharness: 2017-04-29 11:53:42.554634Z] Finished create-virtualenv step (success) 04:53:42 INFO - [mozharness: 2017-04-29 11:53:42.555610Z] Running install step. 04:53:42 INFO - Running pre-action listener: _resource_record_pre_action 04:53:42 INFO - Running main action method: install 04:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:42 INFO - Reading from file tmpfile_stdout 04:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:42 INFO - Reading from file tmpfile_stdout 04:53:42 INFO - Output received: 04:53:42 INFO - Usage: mozinstall [options] installer 04:53:42 INFO - Options: 04:53:42 INFO - -h, --help show this help message and exit 04:53:42 INFO - -d DEST, --destination=DEST 04:53:42 INFO - Directory to install application into. [default: 04:53:42 INFO - "/builds/slave/test"] 04:53:42 INFO - --app=APP Application being installed. [default: firefox] 04:53:42 INFO - mkdir: /builds/slave/test/build/application 04:53:42 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'] 04:53:42 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 04:54:03 INFO - Reading from file tmpfile_stdout 04:54:03 INFO - Output received: 04:54:03 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:54:03 INFO - Running post-action listener: _resource_record_post_action 04:54:03 INFO - [mozharness: 2017-04-29 11:54:03.335041Z] Finished install step (success) 04:54:03 INFO - [mozharness: 2017-04-29 11:54:03.335199Z] Running run-tests step. 04:54:03 INFO - Running pre-action listener: _resource_record_pre_action 04:54:03 INFO - Running main action method: run_tests 04:54:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:03 INFO - 2017-04-29 04:54:03.349 screenresolution[1626:7578] starting screenresolution argv=screenresolution get 04:54:03 INFO - 2017-04-29 04:54:03.352 screenresolution[1626:7578] Display 0: 1600x1200x32@60 04:54:03 INFO - 2017-04-29 04:54:03.357 screenresolution[1627:7581] starting screenresolution argv=screenresolution list 04:54:03 INFO - Available Modes on Display 0 04:54:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:03 INFO - Intel Iris: 04:54:03 INFO - Chipset Model: Intel Iris 04:54:03 INFO - Type: GPU 04:54:03 INFO - Bus: Built-In 04:54:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:03 INFO - Vendor: Intel (0x8086) 04:54:03 INFO - Device ID: 0x0a2e 04:54:03 INFO - Revision ID: 0x0009 04:54:03 INFO - Displays: 04:54:03 INFO - Display: 04:54:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:03 INFO - Display Serial Number: 1600x1200 60 04:54:03 INFO - Main Display: Yes 04:54:03 INFO - Mirror: Off 04:54:03 INFO - Online: Yes 04:54:03 INFO - Rotation: Supported 04:54:03 INFO - Return code: 0 04:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:54:03 INFO - Python 2.7.3 04:54:03 INFO - Return code: 0 04:54:03 INFO - grabbing minidump binary from tooltool 04:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:03 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 0x102ed6d30>, '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 0x102dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ecbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:54:03 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 04:54:03 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 04:54:03 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 04:54:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:54:03 INFO - Return code: 0 04:54:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:54:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:54:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:54:03 INFO - ENV: RUST_BACKTRACE is now 1 04:54:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:54:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:54:03 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 04:54:03 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --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 04:54:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JDjTiBV7Gy/Render', 04:54:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:03 INFO - 'HOME': '/Users/cltbld', 04:54:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:03 INFO - 'LOGNAME': 'cltbld', 04:54:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:54:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:03 INFO - 'MOZ_NO_REMOTE': '1', 04:54:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:54:03 INFO - 'NO_EM_RESTART': '1', 04:54:03 INFO - 'PAGER': '/bin/cat', 04:54:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:03 INFO - 'PWD': '/builds/slave/test', 04:54:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:54:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:03 INFO - 'RUST_BACKTRACE': '1', 04:54:03 INFO - 'SHELL': '/bin/bash', 04:54:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6uQCyzM5j/Listeners', 04:54:03 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:54:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:03 INFO - 'USER': 'cltbld', 04:54:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:03 INFO - 'XPC_FLAGS': '0x0', 04:54:03 INFO - 'XPC_SERVICE_NAME': '0', 04:54:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:03 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 04:54:03 INFO - mozversion application_buildid: 20170429030208 04:54:03 INFO - mozversion application_changeset: 308cdb913d717f8edc932f5bac93854e3e54b84d 04:54:03 INFO - mozversion application_display_name: Nightly 04:54:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:54:03 INFO - mozversion application_name: Firefox 04:54:03 INFO - mozversion application_remotingname: firefox 04:54:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:54:03 INFO - mozversion application_vendor: Mozilla 04:54:03 INFO - mozversion application_version: 55.0a1 04:54:03 INFO - mozversion platform_buildid: 20170429030208 04:54:03 INFO - mozversion platform_changeset: 308cdb913d717f8edc932f5bac93854e3e54b84d 04:54:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:54:03 INFO - mozversion platform_version: 55.0a1 04:54:03 INFO - using testdate: 1493466843 04:54:03 INFO - actual date: 1493466843 04:54:03 INFO - starting webserver on 'localhost:49229' 04:54:03 INFO - SUITE-START | Running 2 tests 04:54:03 INFO - TEST-START | dromaeo_css 04:54:03 INFO - operating with platform_type : mac_ 04:54:03 INFO - Initialising browser for dromaeo_css test... 04:54:03 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpzoBBR9/profile http://localhost:49229/getInfo.html) 04:54:07 INFO - PID 1637 | 2017-04-29 04:54:07.093 plugin-container[1640:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 04:54:07 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:07 INFO - PID 1637 | 2017-04-29 04:54:07.094 plugin-container[1640:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa10b, name = 'com.apple.CFPasteboardClient' 04:54:07 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:07 INFO - PID 1637 | 2017-04-29 04:54:07.094 plugin-container[1640:7770] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:07 INFO - PID 1637 | __metrics Screen width/height:1600/1200 04:54:07 INFO - PID 1637 | colorDepth:24 04:54:07 INFO - PID 1637 | Browser inner width/height: 1024/689 04:54:07 INFO - PID 1637 | __metrics 04:54:08 INFO - TEST-INFO | 1637: exit 0 04:54:08 INFO - Browser initialized. 04:54:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:54:08 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpzoBBR9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:10 INFO - PID 1641 | 2017-04-29 04:54:10.679 plugin-container[1642:7909] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 04:54:10 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:10 INFO - PID 1641 | 2017-04-29 04:54:10.679 plugin-container[1642:7909] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x951f, name = 'com.apple.CFPasteboardClient' 04:54:10 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:54:10 INFO - PID 1641 | 2017-04-29 04:54:10.679 plugin-container[1642:7909] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:54:20 INFO - PID 1641 | RSS: Main: 235442176 04:54:20 INFO - PID 1641 | 04:57:25 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49229/tests/dromaeo/cssquery-ext.html) 04:57:26 INFO - PID 1641 | RSS: Main: 251846656 04:57:26 INFO - PID 1641 | 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 04:59:08 INFO - PID 1641 | 04:59:08 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:59:08 INFO - PID 1641 | Full stack: 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 04:59:08 INFO - PID 1641 | 04:59:08 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:59:08 INFO - PID 1641 | Full stack: 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 04:59:08 INFO - PID 1641 | 04:59:08 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:59:08 INFO - PID 1641 | Full stack: 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | ************************* 04:59:08 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 04:59:08 INFO - PID 1641 | 04:59:08 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:59:08 INFO - PID 1641 | Full stack: 04:59:08 INFO - PID 1641 | ************************* 05:00:28 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-ext.html (next: http://localhost:49229/tests/dromaeo/cssquery-jquery.html) 05:00:29 INFO - PID 1641 | RSS: Main: 259670016 05:00:29 INFO - PID 1641 | 05:03:30 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49229/tests/dromaeo/cssquery-mootools.html) 05:03:31 INFO - PID 1641 | RSS: Main: 269185024 05:03:31 INFO - PID 1641 | 05:06:33 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49229/tests/dromaeo/cssquery-prototype.html) 05:06:33 INFO - PID 1641 | RSS: Main: 261595136 05:06:33 INFO - PID 1641 | 05:09:36 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49229/tests/dromaeo/cssquery-yui.html) 05:09:37 INFO - PID 1641 | RSS: Main: 271777792 05:09:37 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49229/tests/dromaeo/cssquery-yui.html (next: http://localhost:49229/tests/dromaeo/cssquery-dojo.html) 05:12:39 INFO - PID 1641 | RSS: Main: 266399744 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | __start_tp_report 05:12:39 INFO - PID 1641 | _x_x_mozilla_page_load 05:12:39 INFO - PID 1641 | _x_x_mozilla_page_load_details 05:12:39 INFO - PID 1641 | |i|pagename|runs| 05:12:39 INFO - PID 1641 | |0;dojo.html;3408.7613867029318;3584.713222942163;3615.5661320641525;3652.5069115669394;3654.5066416033837;5081.263216833566;6126.632402055874;6201.255849298079;6203.782867599629;6213.689315534222;6061.484773794233;6137.560853825989;6147.692615369225;6151.384861513847;6252.812415627527;5358.008768377843;5410.08028635133;5429.995450841588;5447.400785913536;5530.806421775239;5360;5451.781928722847;5511.173324001412;5526.972365138168;5527.55779537638;5111.90094129762;5243.2659427680155;5457.208704737831;5533.972330138344;5539.639923404986;5327.3074500314715;5402.37872644643;5422.15956526739;5450.754716037788;5456.972715136439;4405.31717583775;5392.110301800199;5395.244665746799;5422.295101636762;5468.2891224141;4838.951610483885;6251.3123556408755;6254.46837018854;6267.05994100884;6274.247090349188;6450.903236451457;6518.380753828379;6636.93363066368;6695.631740254284;6719.328067193291;6777.864442711168;6813.284605116491;6818.965905170442;6839.2818754031105;6846.418054465376;6146.692665366714;6367.4906007519285;6376.107344971708;6379.202599675041;6390.84022899422;6567.376099270562;6739;6818.931810681929;6921.134858142732;6928.411085057826;6376.7130479128555;6518.217813862367;6564.146660934048;6616.503762217853;6623.635700036448;6588;6602;6691.933080669229;6782.559133656297;6782.728690852409;6627.602343859384;6695.096162018162;6704.832379190461;6710.798676039727;6724.327567243335;6484.837879053061;6708.664566771642;6729.49528785343;6730.93269067303;6737.831554211086;5255.08036093682;5282.181261904411;5286.418493965661;5293.655912365684;5369.248305237192;3645.143391303042;4561.498235194126;4734.573888349996;4771.904561908743;4864.294677271776;5027.371578552681;5085.821996230115;5246.947530524722;5798.246227990418;6328.272248691367;6507.642079685663;6618.669066546653;6619.404253617197;6665.905265091836;6740.62926539045;4914.483979182206;6286.119943207955;6318.968405157945;6334.841628959313;6352.523560732963;5849.824505264849;5875.970620146872;5893.793717219876;5901.232839730807;5903.26209223847;6685.866282674417;6877.449804015767;6994.615296158659;7006.4745144114395;7018.543794653331;6623.470122390101;6724.966375168093;6747.359000894907;6749.392554670103;6787.93212067873;6955.478339124687;6956.373926346653;6970.407515361251;6976.290808751888;6979.2671769465505;6570.605763654196;6622.139121914121;6671.666416679243;6679.398854102959;6719.664016799043;6108.22065524731;6652.234992975869;6719.664016799238;6752.898706519504;6808.5914845109455;5175.404828444777;6333.746650133943;6555.246146693191;6587.934120658732;6601.504887133388;6340.873182536416;6383.329750376143;6468.288488266381;6576.638284894377;6589.439897608565;6368.140301059483;6400.583962042452;6490.253620833664;6497.350264973465;6504.414602685781;6382.648954307558;6443.548951573345;6534.640594767334;6540.8364790880605;6587.9670601646685;6408.743650254124;6417.197850268716;6431.48548116159;6447.065175549613;6461.450776684034 05:12:39 INFO - PID 1641 | |1;ext.html;753.07371932523;770.5530792140559;827.2265431821246;1224.589762429586;1286.781247187979;37107.25785484289;37820.621793782055;37836.43245351322;37873.81063094688;37883.431748523726;37879.81060094703;38086;38234.80882595583;38290.23419531608;38395.80802095993;7783.688652453895;7867.173946735567;8377.45546539473;8585.18440748128;8592.613332400026;8508.489490630582;8587.52768597727;8588.785280368009;8609.956950215272;8613.397062205648;8530.829383412329;8574.099719529453;8615.483071015758;8616.612252448655;8645.69740059098;8571.657133714643;8571.828563428728;8607.698730544464;8632.39573229874;8632.438891472035;8478.576071196416;8522.48865068098;8522.659093636246;8540.572971351408;8553.144685531459;37736.05659858498;37761.622383776084;37914.43128353077;37977.0505737356;37995.81002095;3612.3317186320614;3616.65641764032;3651.06897741077;3652.4338727497015;3655.0679576708035;31219;31302.243730752456;31331.843340783376;31374.05877823669;31392.686073139204;2450.603156200966;2834.730700583462;3053.931124106567;3144.3868445653106;3148.795328303676;273937;275031.6248418745;309504;318207;319921;48852;48965.87926509186;49024.754876225394;49134;49202;50563.241551376756;50682.74658626683;51334.48665513372;51382;51383.22925156126;11944.701382465335;14403.279836008367;14524.854751452562;14536.781948270784;14539.200343981183;11266.774664506664;11828.40857957116;11947.163698541193;11972.161948663685;11993.940030299967;10934.726631834268;11070.059044981106;13504;13722.588322350346;13910.234937078356;4978.327925730053;5046.823361182341;5339.359276886798;5877.618759591493;6070.908936365958;916.4867674102524;1007.7379881230933;1022.5909636145452;1091.1270983213396;1103.7847619714078;23691.815409229468;24605.63091553628;24797.00811967537;24910;24935.877885495196;1148.7070796946725;1152.2970987697497;1189.120051162134;1190.547591915084;1195.8804119587971;8867.911320886838;11463.598774042868;12036.45835937385;12701.809472857914;12795.104342695922;335364;335380;338131;338428.3078584591;339836;49407.75296123496;51390.48609513857;54983.45016549783;55139;55262;1493.5220729366715;1514.5759187427318;1564.7496400575853;1567.8588926996624;1581.2014932459035;19673.409797706092;20153;20540;23509.177178798658;24391.658458784936;38730.6126938727;38758.61241387663;38835.41746873856;38841.2231755369;38892.80553597214;279810.8028379535;282995;283111;283402;284016;35375.46936796002;35616;35643.28713425769;36869.44695829511;37147.6998305058;44878.55121448874;45700.314495281935;46053.76973115113;46496.30255546102;46536.53463465458;29668.851655741582;31368.686313136575;31412;32015;32085;31219.84390078126;31281.374372511968;31641.36717265688;31768.36463270768;31867;37806.86579402622;37893;38138.80930595329;38247;38248.42627360648;30239.848800755855;31827.20431989219;32012.839935800173;32497;32770.344593107526;22967.736774476896;24222.273331800076;24913.50172996566;25148.371290717878;25427.87286063558 05:12:39 INFO - PID 1641 | |2;jquery.html;435.7755755785769;444.2625242098118;445.8474842532053;459.8206699387239;462.1058252281833;18931.432057038277;20663.070161842716;21347.78652213481;21428.892855535738;21492.462688432777;21700;22098.116075356967;22321;22395.888020559916;22643.54712905745;5955.106733989915;6203.813885583417;6208.286047104596;6213.2233470816145;6224.035274532454;5644.3508996465525;6239.37606239377;6255.468285195741;6284.905726414107;6292.968535157318;6086.6348019119;6213.533984951124;6241.500679945593;6261.968690156543;6262.279837818641;6154.938450615504;6253.343398943114;6257.812265632038;6259.123722678829;6267.279262884758;5516.558675305966;5537.335519737617;5551.333839939192;5564.8330550083565;5615.9157612635845;21062;27892.16323510298;28673.713262867313;28705.712942870723;29129.70870291291;2200.273909609825;2212.314182603398;2244.7418546867157;2267.7278726552754;2269.4893648929024;17673.38143164996;17725.379611713528;17897.821021789747;18115.36596219126;18359.265629374942;2133.296012315932;2158.028887000856;2199.8900054997184;2201.801837834603;2208.950748394516;118065.40967295108;127422;158221.41778582183;158847;160273.79452411004;9408.459715876676;12485;12487.876091151658;12492.562760303346;12529.18560293578;16119.67760644804;16412.917935410245;16436.75344869828;16437;16437.09595972233;6636.402723754885;7990.360771138295;8083.959580202179;9128.087191280818;9188.540572971324;8551.059383467813;8593.742187734379;8607.78480537979;8750.256228220545;8763.605637746317;7828.530288182727;7895.447318687637;7909.559381616326;7948.006499187602;7973.641186146638;2158.568286342738;2164.5021645021734;2166.3825809644177;2168.7831216878185;2368.0172728317557;935.4293880732747;937.9155875971059;960.577345967772;968.7287559483356;996.2627655534997;20947;21206.681899771516;21332;21475.03362348698;21847.563048739255;927.2813569483569;1004.7990401919645;1011.9696409107738;1021.3463383434607;1034.9534270957824;10673.679789606324;10940.12479001678;11048.779024419466;11061.502232399562;11098.2786118902;529295;549518;550101;552014;553136;99064.00935990692;128945;131953;133771;137341;1199.7180662544295;1233.173773571709;1251.205484517338;1251.3055254333933;1251.6182564317971;21188.94055297198;21581.676274856203;22958.770412295664;23020;23085;40409.19181616292;57479.712601436724;57756.71121644533;58570.707146463996;60527.69736151291;83617;84287.20707568052;84316.57841710752;84750.15249847423;84920.4523864285;8839.381243312906;9012.369134160546;9021.421251280868;9222.262219022328;9264.814703705753;14648.340824662702;14752.049590081811;14827.92586037063;14965.251737413304;15158.3178756954;11186.832197517206;12091.39543022863;12168.2699038058;12427.689307767378;12500.562480313145;11621;11644.88355116472;11858.34779087124;11909.821352679543;12271.57049503263;10985.681718193868;12607.117501774788;12661.240325580125;12702.110852240625;12800.423980921067;8049.356051515982;8283.62723677448;8965.775855603662;9088.772780680536;9132.863007054766;12118.151729378858;12188;12268.938655306667;12400.875991239973;12527.624171274876 05:12:39 INFO - PID 1641 | |3;mootools.html;1346.3335648853817;1383.584924522643;1405.7048019915817;1409.4080486195796;1411.5483045425465;11335.546578136875;11466.08271338293;11806.350650714206;11896.524139034449;11914.0468762499;11568.421578921041;11772.234804737685;11783.175177737561;11795.70510737232;11820.468078936447;2480.3055144559553;2512.9120480783176;2529.8229123961332;2530.063876365738;2534.3157347516158;2360.6341017142286;2399.1722855614785;2400.3639035655565;2408.2654790288957;2412.9034838606435;1853.3142737187193;2486.664300319461;2493.2644869763462;2533.138732830837;2541.186820217531;2419.6491508731224;2446.755324467557;2476.777090061894;2477.318737347226;2483.875806209682;2424.793892519138;2515;2523.9495210095697;2530.658361121262;2537.606670966003;11726.941365293203;11822.704432389173;11823.586174483939;11838.112141589416;11860.347680877549;6572.309907459696;6836.829079273058;6837.384635382839;6838.7264509419565;6843.110395648584;4007.158496715693;4065.166640838621;4250.893727656802;4344.652427805768;4365.454318210223;1107.1751545098953;1255.8806913343217;1264.3551788587795;1306.1640550047978;1310.1156719214587;15645.217739112999;16314.265858036417;16425.753613695804;16516.669666606602;16528.75206871898;5515.751791169327;5641.153826925912;5698.088305871041;5796.1595568642315;5814.360420353758;9709.271804614682;11768.117391195694;11887.465064072137;11926.224795388272;11938;5263.6315457918345;5443.210734443563;6519.989401642753;6590.077389165521;6593.967030164818;6010.699465026732;6121.418465245794;6220.906686399708;6291.213598300213;6296.150019747367;3657.743957922973;4272.46594175728;4405.118976204772;4413.646908247332;4424.867253982386;1259.8236246925437;1282.0192552697195;1282.9928506122649;1287.349888306418;1290.8838204561634;775.2673723331397;793.8610743119931;800.8958835351367;813.7680760983092;821.5194111444753;5611.7474713637985;6218.471429928416;6258.249010118815;6341.207349081365;6442.6778661066755;586.4721750424652;587.6943989125631;609.065085094378;617.062065660194;619.5074915442234;3898.3762597984755;4430.822767089345;4463.419755431773;4525.275955847049;4592.885177870513;14460.710785784226;14818.481353152589;14903.403863845542;15290.617734556725;15303.234838258266;14304.141751494944;14544.909131815157;14940.551783446514;14948.32732527039;14971.775423368657;7167.89248161278;8249.752507424906;8596.91403085961;8627.568621568897;8652.480851148825;6982.812921803204;7090.893636595559;7160.820979475347;7200.49596528238;7409.222031686811;10208.856140210639;12012.159148859846;12488.562900298446;13606.795898061338;13835.79246311286;12884.48462061507;13580.524681636096;13763.38064787067;13978.790318145033;14038.508652197124;9301.279263336033;9540.809183816424;9544.284178686765;9551.570179341807;9582.472963987047;10665.786684266115;10675.199360048182;10745;10784.352938823695;10822.729431764268;9051.592678329624;9112.271018318652;9146.771330716785;9198.172164504958;9444.905550944402;8868.822623547621;9065.546722663972;9096.9538503073;9097;9261.907380926374;8246.422750407413;8284.875726863982;8341.95829020851;8354.45696029756;8376.748697539084;6133.172021777182;6262.342454042442;6278.686065696788;6319.842003949754;6381.553291269566;6076.817695469143;6284.74861005573;6353.078803573549;6396.584222025554;6406.167198264196 05:12:39 INFO - PID 1641 | |4;prototype.html;351.3955995687418;391.93141200289944;393.6674357300537;418.2617679795162;419.1073014479159;5942.1978032965535;6116.327204007555;6166.828302622499;6290.087937249102;6300.716467758951;4906.582940450066;6023.216981792371;6097.237845269341;6150.969245153768;6182.721777520022;3852.84588616455;4707.882302942428;4709.422343514927;4716.292556116576;4729.550692684206;3747.8313475893515;4010.739301945379;4172.687048471362;4280.208161490119;4633.768311584424;4388.473383194021;4400.339949007658;4403.185410699015;4408.669349798778;4435.356873253377;3857.267119247362;4406.294992801152;4425.358323043173;4445.199864024475;4445.799939002753;3275.721563667067;3293.9835300823584;3655.94516082259;3809.12390150267;3812.6377994090517;4611.76941152941;5959.463648271633;5969.432903874168;5989.940100599026;6017.518598512109;5330.680159190461;5339.946600534023;5347.983883062206;5362.613636931567;5404.8108316208745;6465.288818229991;6522.608643481406;6615;6619.304972977864;6676.332366763333;3611.656892595199;4336.6530677545725;4341.6526677865695;4349.151915376503;4362.694611377205;6283.842903927392;6472.805815825533;6720.899186512206;6929.79210623677;6941.132358455193;3419;3480.154429355576;3818.4654148419245;4308.3968244445805;4380.299152135643;3295.6210035845706;4261.913212130887;4279.379489973936;4472.127935052634;4491.3487544306545;4543.5002149763495;4826.227803551415;5099.821506247264;5259.92233067936;5293.153095504701;5383.67697938125;5893.557983151195;6184.783532576338;6620.933790662032;6657.968014957689;1423.665438621923;1498.3482185249452;1519.931603077864;1524.1312451902309;1525.9237038148049;860.2902605350611;861.5993562993239;985.571276494727;990.7027891632481;999.415342024909;6123.693815309217;6261.342559031236;6265.467435267962;6278.591891527036;6301.4328710416285;5686.516646085129;6645.335466453316;6805.06055774102;6870.519063665595;6974.895376569356;5024.7689316117785;5650.378458369576;5946.821595352147;6016.977113890649;6046.818595442144;2621.2437666763312;3035.907073453555;3435.639257877937;3480.686738193575;3557.5375201223674;6091;6978;7023.332783385672;7048.541844780073;7093.89359159613;5782;6635.971424429221;6694.828405029198;7072.222055573883;7095.290470952967;6181.660008699475;6441.194850643669;7074.823129421806;7098.716051357991;7111.608861512563;5969.641821490551;6189.535784816067;6387.265464471459;6859.382655561023;6890.552114112566;6151.477124444473;6485.481161506974;6761.526693131434;6777.390034896883;6816.659167041727;7089.220185779664;7111.964440177766;7130.2869713028285;7132.003039149046;7134.215236324104;4171.874843754692;4349.478062632505;4379.277419225792;4392.231359512137;4396.9120617588105;6720.529562930744;6831.618348917119;6901.723931042702;6915.688794004182;6942.687579058854;5203.5576975957465;6098.255784896725;6374.3306952771145;6627.701753421204;6649.434798042221;5026.84919452417;5149.948500514947;5436.6194366393975;5489.670619762827;6176.3514830943905;5477.589180811376;6490.967545162244;6502.902456463252;6506.544541882212;6512.251091124392;4814.013127308824;5194.3247377840635;6555;6587.440067594116;6628.436582890508;6153.969230153821;6494.1232933553365;6507.577007494498;6534.967325163534;6536.705848236746 05:12:39 INFO - PID 1641 | |5;yui.html;714.4034730999615;830.9750707478778;835.2399316621876;867.4491697771913;872.337023861865;16269.511914642564;16640.83359166408;16654.25055872484;18501.629967400644;19089.61820763584;17786;18197.727034094467;18362.26550937961;18435.723464148014;18580.53548661284;979.4466126638462;984.8916619171903;994.5226291380142;996.8953259907714;997.8004399120168;979.2508730820928;986.6743974488402;991.7421470417707;994.6170724271135;996.7757254617726;1041.1878734587035;1050.726811029134;1056.1920131099714;1056.6618682021756;1059.9347655606105;1041.8176819056634;1052.394872948058;1054;1054.6941386997762;1057.1278695076553;749.9062617172854;755.2749360613817;756.1984296645518;756.4024420707634;762.523422860712;16712.83287167125;16749.078800665957;16855.747163792552;16878;16905.915470422693;16997.66004679912;17131.657366852593;17215.913920430445;17361.7395739064;17497.300107995667;11295.661130166109;11968.70078248042;14151.29243537819;14475.638109047253;14487.492937747129;3464.7921124732597;3511.6839484446523;3511.929761404783;3513.3149035938004;3514.1917359007316;94387;134006;134393;135031;136235.31882340525;13404.5308414207;13419;13703.794443083361;13774.173549587056;13802.861971380158;25339.493210135694;25873.22380328593;25922.611160832603;26345.209643710336;26373.604395934075;7686.46194766361;7784.2215778421705;7836.490628109154;7915.84168316642;7921.287084162453;3822.2546603412065;3895.922081558353;3898.7270891037356;3901.765894046366;3902.434147048719;3875.96124038756;3886.3393223152134;3948.526176858795;3988.12261302513;4000.319945609195;941.110650435332;953.1278879825021;961.4135377419768;969.5733877094056;971.3540495570367;640.4748106552582;659.3340725866909;665.3413121010165;666.2571233075087;682.1405029662661;11207.66377008691;12025.075987841903;12103.757924841453;12212.450439730233;12300.81548776769;642.9423598180966;645.1935081148564;659.3439527669904;676.509530590318;682.0689758479739;5174.767135478913;5409.945900541023;5629.043062679272;5658;5688.23208866806;87360.56319718361;110692;110759.56961721441;111293.44353278182;113079;97573;98068;99011;99425.50287248517;100407.49796250972;86892;87046.69429958555;88219.67670484948;88252.99999999872;89392.5530372344;10596.682099537025;11323.03754180871;11498.425078745862;11556.133290003116;11677.124215684027;34075.14812129716;39385.606143938196;43375.78312108419;44102.779486102365;44203;72313;77706.83439748522;77837.221627783;79591.20408795838;82982.45701744377;15809.498097680702;17695.823041769418;17862.46412607624;17964.55088622795;18005.2797888083;16574.171291435137;18862.24551017944;19066.618667626848;19101.71347429762;19106.7133992993;16792.24434900408;17398.39105631297;17439.82560174382;17749.822501775332;17902.015389153723;17368.82631173672;17418.651626967643;18126.18432170582;18145.274189032818;18225.179866906285;16838.905471144335;16868.66262674715;17215.7417638738;17334.47996560105;17335.393261235797;11769.293842369485;11778.587749428729;12320.938395307967;12478.001759859008;12576.496940122293;13458;13711.17732935987;13991.090579112326;14068.859311407165;14249.073810202304 05:12:39 INFO - PID 1641 | __end_tp_report 05:12:39 INFO - PID 1641 | __start_cc_report 05:12:39 INFO - PID 1641 | _x_x_mozilla_cycle_collect,418 05:12:39 INFO - PID 1641 | __end_cc_report 05:12:39 INFO - PID 1641 | __startTimestamp1493467959284__endTimestamp 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | ------- Summary: start ------- 05:12:39 INFO - PID 1641 | Number of tests: 6 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6108.71 Median:6390.84 stddev:786.03 (12.3%) stddev-sans-first:759.37 05:12:39 INFO - PID 1641 | Values: 3408.8 3584.7 3615.6 3652.5 3654.5 5081.3 6126.6 6201.3 6203.8 6213.7 6061.5 6137.6 6147.7 6151.4 6252.8 5358.0 5410.1 5430.0 5447.4 5530.8 5360.0 5451.8 5511.2 5527.0 5527.6 5111.9 5243.3 5457.2 5534.0 5539.6 5327.3 5402.4 5422.2 5450.8 5457.0 4405.3 5392.1 5395.2 5422.3 5468.3 4839.0 6251.3 6254.5 6267.1 6274.2 6450.9 6518.4 6636.9 6695.6 6719.3 6777.9 6813.3 6819.0 6839.3 6846.4 6146.7 6367.5 6376.1 6379.2 6390.8 6567.4 6739.0 6818.9 6921.1 6928.4 6376.7 6518.2 6564.1 6616.5 6623.6 6588.0 6602.0 6691.9 6782.6 6782.7 6627.6 6695.1 6704.8 6710.8 6724.3 6484.8 6708.7 6729.5 6730.9 6737.8 5255.1 5282.2 5286.4 5293.7 5369.2 3645.1 4561.5 4734.6 4771.9 4864.3 5027.4 5085.8 5246.9 5798.2 6328.3 6507.6 6618.7 6619.4 6665.9 6740.6 4914.5 6286.1 6319.0 6334.8 6352.5 5849.8 5876.0 5893.8 5901.2 5903.3 6685.9 6877.4 6994.6 7006.5 7018.5 6623.5 6725.0 6747.4 6749.4 6787.9 6955.5 6956.4 6970.4 6976.3 6979.3 6570.6 6622.1 6671.7 6679.4 6719.7 6108.2 6652.2 6719.7 6752.9 6808.6 5175.4 6333.7 6555.2 6587.9 6601.5 6340.9 6383.3 6468.3 6576.6 6589.4 6368.1 6400.6 6490.3 6497.4 6504.4 6382.6 6443.5 6534.6 6540.8 6588.0 6408.7 6417.2 6431.5 6447.1 6461.5 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:45877.20 Median:35495.73 stddev:80718.86 (227.4%) stddev-sans-first:80874.20 05:12:39 INFO - PID 1641 | Values: 753.1 770.6 827.2 1224.6 1286.8 37107.3 37820.6 37836.4 37873.8 37883.4 37879.8 38086.0 38234.8 38290.2 38395.8 7783.7 7867.2 8377.5 8585.2 8592.6 8508.5 8587.5 8588.8 8610.0 8613.4 8530.8 8574.1 8615.5 8616.6 8645.7 8571.7 8571.8 8607.7 8632.4 8632.4 8478.6 8522.5 8522.7 8540.6 8553.1 37736.1 37761.6 37914.4 37977.1 37995.8 3612.3 3616.7 3651.1 3652.4 3655.1 31219.0 31302.2 31331.8 31374.1 31392.7 2450.6 2834.7 3053.9 3144.4 3148.8 273937.0 275031.6 309504.0 318207.0 319921.0 48852.0 48965.9 49024.8 49134.0 49202.0 50563.2 50682.7 51334.5 51382.0 51383.2 11944.7 14403.3 14524.9 14536.8 14539.2 11266.8 11828.4 11947.2 11972.2 11993.9 10934.7 11070.1 13504.0 13722.6 13910.2 4978.3 5046.8 5339.4 5877.6 6070.9 916.5 1007.7 1022.6 1091.1 1103.8 23691.8 24605.6 24797.0 24910.0 24935.9 1148.7 1152.3 1189.1 1190.5 1195.9 8867.9 11463.6 12036.5 12701.8 12795.1 335364.0 335380.0 338131.0 338428.3 339836.0 49407.8 51390.5 54983.5 55139.0 55262.0 1493.5 1514.6 1564.7 1567.9 1581.2 19673.4 20153.0 20540.0 23509.2 24391.7 38730.6 38758.6 38835.4 38841.2 38892.8 279810.8 282995.0 283111.0 283402.0 284016.0 35375.5 35616.0 35643.3 36869.4 37147.7 44878.6 45700.3 46053.8 46496.3 46536.5 29668.9 31368.7 31412.0 32015.0 32085.0 31219.8 31281.4 31641.4 31768.4 31867.0 37806.9 37893.0 38138.8 38247.0 38248.4 30239.8 31827.2 32012.8 32497.0 32770.3 22967.7 24222.3 24913.5 25148.4 25427.9 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:35402.87 Median:12444.14 stddev:92507.30 (743.4%) stddev-sans-first:92729.55 05:12:39 INFO - PID 1641 | Values: 435.8 444.3 445.8 459.8 462.1 18931.4 20663.1 21347.8 21428.9 21492.5 21700.0 22098.1 22321.0 22395.9 22643.5 5955.1 6203.8 6208.3 6213.2 6224.0 5644.4 6239.4 6255.5 6284.9 6293.0 6086.6 6213.5 6241.5 6262.0 6262.3 6154.9 6253.3 6257.8 6259.1 6267.3 5516.6 5537.3 5551.3 5564.8 5615.9 21062.0 27892.2 28673.7 28705.7 29129.7 2200.3 2212.3 2244.7 2267.7 2269.5 17673.4 17725.4 17897.8 18115.4 18359.3 2133.3 2158.0 2199.9 2201.8 2209.0 118065.4 127422.0 158221.4 158847.0 160273.8 9408.5 12485.0 12487.9 12492.6 12529.2 16119.7 16412.9 16436.8 16437.0 16437.1 6636.4 7990.4 8084.0 9128.1 9188.5 8551.1 8593.7 8607.8 8750.3 8763.6 7828.5 7895.4 7909.6 7948.0 7973.6 2158.6 2164.5 2166.4 2168.8 2368.0 935.4 937.9 960.6 968.7 996.3 20947.0 21206.7 21332.0 21475.0 21847.6 927.3 1004.8 1012.0 1021.3 1035.0 10673.7 10940.1 11048.8 11061.5 11098.3 529295.0 549518.0 550101.0 552014.0 553136.0 99064.0 128945.0 131953.0 133771.0 137341.0 1199.7 1233.2 1251.2 1251.3 1251.6 21188.9 21581.7 22958.8 23020.0 23085.0 40409.2 57479.7 57756.7 58570.7 60527.7 83617.0 84287.2 84316.6 84750.2 84920.5 8839.4 9012.4 9021.4 9222.3 9264.8 14648.3 14752.0 14827.9 14965.3 15158.3 11186.8 12091.4 12168.3 12427.7 12500.6 11621.0 11644.9 11858.3 11909.8 12271.6 10985.7 12607.1 12661.2 12702.1 12800.4 8049.4 8283.6 8965.8 9088.8 9132.9 12118.2 12188.0 12268.9 12400.9 12527.6 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7081.36 Median:3952.77 stddev:4467.21 (113.0%) stddev-sans-first:4458.95 05:12:39 INFO - PID 1641 | Values: 1346.3 1383.6 1405.7 1409.4 1411.5 11335.5 11466.1 11806.4 11896.5 11914.0 11568.4 11772.2 11783.2 11795.7 11820.5 2480.3 2512.9 2529.8 2530.1 2534.3 2360.6 2399.2 2400.4 2408.3 2412.9 1853.3 2486.7 2493.3 2533.1 2541.2 2419.6 2446.8 2476.8 2477.3 2483.9 2424.8 2515.0 2523.9 2530.7 2537.6 11726.9 11822.7 11823.6 11838.1 11860.3 6572.3 6836.8 6837.4 6838.7 6843.1 4007.2 4065.2 4250.9 4344.7 4365.5 1107.2 1255.9 1264.4 1306.2 1310.1 15645.2 16314.3 16425.8 16516.7 16528.8 5515.8 5641.2 5698.1 5796.2 5814.4 9709.3 11768.1 11887.5 11926.2 11938.0 5263.6 5443.2 6520.0 6590.1 6594.0 6010.7 6121.4 6220.9 6291.2 6296.2 3657.7 4272.5 4405.1 4413.6 4424.9 1259.8 1282.0 1283.0 1287.3 1290.9 775.3 793.9 800.9 813.8 821.5 5611.7 6218.5 6258.2 6341.2 6442.7 586.5 587.7 609.1 617.1 619.5 3898.4 4430.8 4463.4 4525.3 4592.9 14460.7 14818.5 14903.4 15290.6 15303.2 14304.1 14544.9 14940.6 14948.3 14971.8 7167.9 8249.8 8596.9 8627.6 8652.5 6982.8 7090.9 7160.8 7200.5 7409.2 10208.9 12012.2 12488.6 13606.8 13835.8 12884.5 13580.5 13763.4 13978.8 14038.5 9301.3 9540.8 9544.3 9551.6 9582.5 10665.8 10675.2 10745.0 10784.4 10822.7 9051.6 9112.3 9146.8 9198.2 9444.9 8868.8 9065.5 9097.0 9097.0 9261.9 8246.4 8284.9 8342.0 8354.5 8376.7 6133.2 6262.3 6278.7 6319.8 6381.6 6076.8 6284.7 6353.1 6396.6 6406.2 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5205.50 Median:5979.79 stddev:1711.30 (28.6%) stddev-sans-first:1676.87 05:12:39 INFO - PID 1641 | Values: 351.4 391.9 393.7 418.3 419.1 5942.2 6116.3 6166.8 6290.1 6300.7 4906.6 6023.2 6097.2 6151.0 6182.7 3852.8 4707.9 4709.4 4716.3 4729.6 3747.8 4010.7 4172.7 4280.2 4633.8 4388.5 4400.3 4403.2 4408.7 4435.4 3857.3 4406.3 4425.4 4445.2 4445.8 3275.7 3294.0 3655.9 3809.1 3812.6 4611.8 5959.5 5969.4 5989.9 6017.5 5330.7 5339.9 5348.0 5362.6 5404.8 6465.3 6522.6 6615.0 6619.3 6676.3 3611.7 4336.7 4341.7 4349.2 4362.7 6283.8 6472.8 6720.9 6929.8 6941.1 3419.0 3480.2 3818.5 4308.4 4380.3 3295.6 4261.9 4279.4 4472.1 4491.3 4543.5 4826.2 5099.8 5259.9 5293.2 5383.7 5893.6 6184.8 6620.9 6658.0 1423.7 1498.3 1519.9 1524.1 1525.9 860.3 861.6 985.6 990.7 999.4 6123.7 6261.3 6265.5 6278.6 6301.4 5686.5 6645.3 6805.1 6870.5 6974.9 5024.8 5650.4 5946.8 6017.0 6046.8 2621.2 3035.9 3435.6 3480.7 3557.5 6091.0 6978.0 7023.3 7048.5 7093.9 5782.0 6636.0 6694.8 7072.2 7095.3 6181.7 6441.2 7074.8 7098.7 7111.6 5969.6 6189.5 6387.3 6859.4 6890.6 6151.5 6485.5 6761.5 6777.4 6816.7 7089.2 7112.0 7130.3 7132.0 7134.2 4171.9 4349.5 4379.3 4392.2 4396.9 6720.5 6831.6 6901.7 6915.7 6942.7 5203.6 6098.3 6374.3 6627.7 6649.4 5026.8 5149.9 5436.6 5489.7 6176.4 5477.6 6491.0 6502.9 6506.5 6512.3 4814.0 5194.3 6555.0 6587.4 6628.4 6154.0 6494.1 6507.6 6535.0 6536.7 05:12:39 INFO - PID 1641 | 05:12:39 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:23124.76 Median:19078.12 stddev:32779.28 (171.8%) stddev-sans-first:32828.04 05:12:39 INFO - PID 1641 | Values: 714.4 831.0 835.2 867.4 872.3 16269.5 16640.8 16654.3 18501.6 19089.6 17786.0 18197.7 18362.3 18435.7 18580.5 979.4 984.9 994.5 996.9 997.8 979.3 986.7 991.7 994.6 996.8 1041.2 1050.7 1056.2 1056.7 1059.9 1041.8 1052.4 1054.0 1054.7 1057.1 749.9 755.3 756.2 756.4 762.5 16712.8 16749.1 16855.7 16878.0 16905.9 16997.7 17131.7 17215.9 17361.7 17497.3 11295.7 11968.7 14151.3 14475.6 14487.5 3464.8 3511.7 3511.9 3513.3 3514.2 94387.0 134006.0 134393.0 135031.0 136235.3 13404.5 13419.0 13703.8 13774.2 13802.9 25339.5 25873.2 25922.6 26345.2 26373.6 7686.5 7784.2 7836.5 7915.8 7921.3 3822.3 3895.9 3898.7 3901.8 3902.4 3876.0 3886.3 3948.5 3988.1 4000.3 941.1 953.1 961.4 969.6 971.4 640.5 659.3 665.3 666.3 682.1 11207.7 12025.1 12103.8 12212.5 12300.8 642.9 645.2 659.3 676.5 682.1 5174.8 5409.9 5629.0 5658.0 5688.2 87360.6 110692.0 110759.6 111293.4 113079.0 97573.0 98068.0 99011.0 99425.5 100407.5 86892.0 87046.7 88219.7 88253.0 89392.6 10596.7 11323.0 11498.4 11556.1 11677.1 34075.1 39385.6 43375.8 44102.8 44203.0 72313.0 77706.8 77837.2 79591.2 82982.5 15809.5 17695.8 17862.5 17964.6 18005.3 16574.2 18862.2 19066.6 19101.7 19106.7 16792.2 17398.4 17439.8 17749.8 17902.0 17368.8 17418.7 18126.2 18145.3 18225.2 16838.9 16868.7 17215.7 17334.5 17335.4 11769.3 11778.6 12320.9 12478.0 12576.5 13458.0 13711.2 13991.1 14068.9 14249.1 05:12:39 INFO - PID 1641 | -------- Summary: end -------- 05:12:39 INFO - PID 1641 | 05:12:39 INFO - TEST-INFO | 1641: exit 0 05:12:39 INFO - TEST-OK | dromaeo_css | took 1115978ms 05:12:39 INFO - TEST-START | kraken 05:12:39 INFO - operating with platform_type : mac_ 05:12:39 INFO - Initialising browser for kraken test... 05:12:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpDf6Xxc/profile http://localhost:49229/getInfo.html) 05:12:42 INFO - PID 1652 | 2017-04-29 05:12:42.593 plugin-container[1653:10287] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 05:12:42 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:42 INFO - PID 1652 | 2017-04-29 05:12:42.593 plugin-container[1653:10287] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:12:42 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:42 INFO - PID 1652 | 2017-04-29 05:12:42.593 plugin-container[1653:10287] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:42 INFO - PID 1652 | __metrics Screen width/height:1600/1200 05:12:42 INFO - PID 1652 | colorDepth:24 05:12:42 INFO - PID 1652 | Browser inner width/height: 1024/689 05:12:42 INFO - PID 1652 | __metrics 05:12:43 INFO - TEST-INFO | 1652: exit 0 05:12:43 INFO - Browser initialized. 05:12:43 INFO - Running cycle 1/1 for kraken test... 05:12:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpDf6Xxc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:46 INFO - PID 1654 | 2017-04-29 05:12:46.227 plugin-container[1655:10416] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 05:12:46 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:46 INFO - PID 1654 | 2017-04-29 05:12:46.228 plugin-container[1655:10416] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9413, name = 'com.apple.CFPasteboardClient' 05:12:46 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:46 INFO - PID 1654 | 2017-04-29 05:12:46.228 plugin-container[1655:10416] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:56 INFO - PID 1654 | RSS: Main: 235053056 05:12:56 INFO - PID 1654 | 05:12:58 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:59 INFO - PID 1654 | RSS: Main: 248446976 05:12:59 INFO - PID 1654 | 05:13:02 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-dft) 05:13:02 INFO - PID 1654 | RSS: Main: 256704512 05:13:02 INFO - PID 1654 | 05:13:06 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-fft) 05:13:06 INFO - PID 1654 | RSS: Main: 258977792 05:13:06 INFO - PID 1654 | 05:13:08 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator) 05:13:09 INFO - PID 1654 | RSS: Main: 260255744 05:13:09 INFO - PID 1654 | 05:13:11 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:13:11 INFO - PID 1654 | RSS: Main: 261894144 05:13:11 INFO - PID 1654 | 05:13:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom) 05:13:15 INFO - PID 1654 | RSS: Main: 267501568 05:13:15 INFO - PID 1654 | 05:13:18 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate) 05:13:18 INFO - PID 1654 | RSS: Main: 269389824 05:13:18 INFO - PID 1654 | 05:13:21 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial) 05:13:22 INFO - PID 1654 | RSS: Main: 269004800 05:13:22 INFO - PID 1654 | 05:13:23 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:13:24 INFO - PID 1654 | RSS: Main: 268079104 05:13:24 INFO - PID 1654 | 05:13:26 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:13:26 INFO - PID 1654 | RSS: Main: 267735040 05:13:26 INFO - PID 1654 | 05:13:28 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:13:29 INFO - PID 1654 | RSS: Main: 268279808 05:13:29 INFO - PID 1654 | 05:13:32 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:33 INFO - PID 1654 | RSS: Main: 267608064 05:13:33 INFO - PID 1654 | 05:13:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:37 INFO - PID 1654 | RSS: Main: 267857920 05:13:37 INFO - PID 1654 | 05:13:38 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49229/tests/kraken/driver.html?testName=ai-astar) 05:13:39 INFO - PID 1654 | RSS: Main: 269692928 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | __start_tp_report 05:13:39 INFO - PID 1654 | _x_x_mozilla_page_load 05:13:39 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:13:39 INFO - PID 1654 | |i|pagename|runs| 05:13:39 INFO - PID 1654 | |0;ai-astar;103;116;113;112;115;116;114;114;114;115 05:13:39 INFO - PID 1654 | |1;audio-beat-detection;143;109;109;149;111;116;147;112;137;111 05:13:39 INFO - PID 1654 | |2;audio-dft;189;201;200;206;210;252;207;276;199;200 05:13:39 INFO - PID 1654 | |3;audio-fft;87;61;87;115;77;61;60;58;78;59 05:13:39 INFO - PID 1654 | |4;audio-oscillator;91;71;83;75;71;69;89;91;59;93 05:13:39 INFO - PID 1654 | |5;imaging-gaussian-blur;90;90;89;87;90;88;89;89;88;81 05:13:39 INFO - PID 1654 | |6;imaging-darkroom;95;96;96;97;96;96;97;96;96;98 05:13:39 INFO - PID 1654 | |7;imaging-desaturate;91;95;89;93;94;93;90;92;91;89 05:13:39 INFO - PID 1654 | |8;json-parse-financial;49;48;49;50;49;49;51;57;58;64 05:13:39 INFO - PID 1654 | |9;json-stringify-tinderbox;56;64;57;57;69;63;58;54;56;56 05:13:39 INFO - PID 1654 | |10;stanford-crypto-aes;83;88;96;108;108;83;85;86;82;86 05:13:39 INFO - PID 1654 | |11;stanford-crypto-ccm;160;145;138;138;144;159;138;157;206;152 05:13:39 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;186;185;177;186;188;200;242;187;181;184 05:13:39 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;66;69;67;69;64;68;97;99;82;67 05:13:39 INFO - PID 1654 | __end_tp_report 05:13:39 INFO - PID 1654 | __start_cc_report 05:13:39 INFO - PID 1654 | _x_x_mozilla_cycle_collect,981 05:13:39 INFO - PID 1654 | __end_cc_report 05:13:39 INFO - PID 1654 | __startTimestamp1493468019147__endTimestamp 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | ------- Summary: start ------- 05:13:39 INFO - PID 1654 | Number of tests: 14 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.79 (3.3%) stddev-sans-first:1.32 05:13:39 INFO - PID 1654 | Values: 103.0 116.0 113.0 112.0 115.0 116.0 114.0 114.0 114.0 115.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:126.50 stddev:17.25 (13.6%) stddev-sans-first:16.93 05:13:39 INFO - PID 1654 | Values: 143.0 109.0 109.0 149.0 111.0 116.0 147.0 112.0 137.0 111.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:214.00 Median:206.50 stddev:27.54 (13.3%) stddev-sans-first:27.69 05:13:39 INFO - PID 1654 | Values: 189.0 201.0 200.0 206.0 210.0 252.0 207.0 276.0 199.0 200.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:74.30 Median:69.00 stddev:18.43 (26.7%) stddev-sans-first:18.97 05:13:39 INFO - PID 1654 | Values: 87.0 61.0 87.0 115.0 77.0 61.0 60.0 58.0 78.0 59.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:79.20 Median:86.00 stddev:11.75 (13.7%) stddev-sans-first:11.67 05:13:39 INFO - PID 1654 | Values: 91.0 71.0 83.0 75.0 71.0 69.0 89.0 91.0 59.0 93.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:89.00 stddev:2.69 (3.0%) stddev-sans-first:2.76 05:13:39 INFO - PID 1654 | Values: 90.0 90.0 89.0 87.0 90.0 88.0 89.0 89.0 88.0 81.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 05:13:39 INFO - PID 1654 | Values: 95.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 98.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.50 stddev:2.06 (2.2%) stddev-sans-first:2.17 05:13:39 INFO - PID 1654 | Values: 91.0 95.0 89.0 93.0 94.0 93.0 90.0 92.0 91.0 89.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:50.50 stddev:5.38 (10.7%) stddev-sans-first:5.56 05:13:39 INFO - PID 1654 | Values: 49.0 48.0 49.0 50.0 49.0 49.0 51.0 57.0 58.0 64.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:57.50 stddev:4.74 (8.2%) stddev-sans-first:4.90 05:13:39 INFO - PID 1654 | Values: 56.0 64.0 57.0 57.0 69.0 63.0 58.0 54.0 56.0 56.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:85.50 stddev:10.02 (11.7%) stddev-sans-first:10.26 05:13:39 INFO - PID 1654 | Values: 83.0 88.0 96.0 108.0 108.0 83.0 85.0 86.0 82.0 86.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:154.50 stddev:20.35 (13.2%) stddev-sans-first:21.45 05:13:39 INFO - PID 1654 | Values: 160.0 145.0 138.0 138.0 144.0 159.0 138.0 157.0 206.0 152.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.60 Median:186.50 stddev:18.66 (10.0%) stddev-sans-first:19.68 05:13:39 INFO - PID 1654 | Values: 186.0 185.0 177.0 186.0 188.0 200.0 242.0 187.0 181.0 184.0 05:13:39 INFO - PID 1654 | 05:13:39 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:69.00 stddev:13.16 (19.1%) stddev-sans-first:13.57 05:13:39 INFO - PID 1654 | Values: 66.0 69.0 67.0 69.0 64.0 68.0 97.0 99.0 82.0 67.0 05:13:39 INFO - PID 1654 | -------- Summary: end -------- 05:13:39 INFO - PID 1654 | 05:13:40 INFO - TEST-INFO | 1654: exit 0 05:13:40 INFO - TEST-OK | kraken | took 60433ms 05:13:40 INFO - SUITE-END | took 1176s 05:13:40 INFO - Completed test suite (00:19:36) 05:13:40 INFO - javascript benchmark 05:13:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7886.205579732365, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3408.7613867029318, 3584.713222942163, 3615.5661320641525, 3652.5069115669394, 3654.5066416033837, 5081.263216833566, 6126.632402055874, 6201.255849298079, 6203.782867599629, 6213.689315534222, 6061.484773794233, 6137.560853825989, 6147.692615369225, 6151.384861513847, 6252.812415627527, 5358.008768377843, 5410.08028635133, 5429.995450841588, 5447.400785913536, 5530.806421775239, 5360.0, 5451.781928722847, 5511.173324001412, 5526.972365138168, 5527.55779537638, 5111.90094129762, 5243.2659427680155, 5457.208704737831, 5533.972330138344, 5539.639923404986, 5327.3074500314715, 5402.37872644643, 5422.15956526739, 5450.754716037788, 5456.972715136439, 4405.31717583775, 5392.110301800199, 5395.244665746799, 5422.295101636762, 5468.2891224141, 4838.951610483885, 6251.3123556408755, 6254.46837018854, 6267.05994100884, 6274.247090349188, 6450.903236451457, 6518.380753828379, 6636.93363066368, 6695.631740254284, 6719.328067193291, 6777.864442711168, 6813.284605116491, 6818.965905170442, 6839.2818754031105, 6846.418054465376, 6146.692665366714, 6367.4906007519285, 6376.107344971708, 6379.202599675041, 6390.84022899422, 6567.376099270562, 6739.0, 6818.931810681929, 6921.134858142732, 6928.411085057826, 6376.7130479128555, 6518.217813862367, 6564.146660934048, 6616.503762217853, 6623.635700036448, 6588.0, 6602.0, 6691.933080669229, 6782.559133656297, 6782.728690852409, 6627.602343859384, 6695.096162018162, 6704.832379190461, 6710.798676039727, 6724.327567243335, 6484.837879053061, 6708.664566771642, 6729.49528785343, 6730.93269067303, 6737.831554211086, 5255.08036093682, 5282.181261904411, 5286.418493965661, 5293.655912365684, 5369.248305237192, 3645.143391303042, 4561.498235194126, 4734.573888349996, 4771.904561908743, 4864.294677271776, 5027.371578552681, 5085.821996230115, 5246.947530524722, 5798.246227990418, 6328.272248691367, 6507.642079685663, 6618.669066546653, 6619.404253617197, 6665.905265091836, 6740.62926539045, 4914.483979182206, 6286.119943207955, 6318.968405157945, 6334.841628959313, 6352.523560732963, 5849.824505264849, 5875.970620146872, 5893.793717219876, 5901.232839730807, 5903.26209223847, 6685.866282674417, 6877.449804015767, 6994.615296158659, 7006.4745144114395, 7018.543794653331, 6623.470122390101, 6724.966375168093, 6747.359000894907, 6749.392554670103, 6787.93212067873, 6955.478339124687, 6956.373926346653, 6970.407515361251, 6976.290808751888, 6979.2671769465505, 6570.605763654196, 6622.139121914121, 6671.666416679243, 6679.398854102959, 6719.664016799043, 6108.22065524731, 6652.234992975869, 6719.664016799238, 6752.898706519504, 6808.5914845109455, 5175.404828444777, 6333.746650133943, 6555.246146693191, 6587.934120658732, 6601.504887133388, 6340.873182536416, 6383.329750376143, 6468.288488266381, 6576.638284894377, 6589.439897608565, 6368.140301059483, 6400.583962042452, 6490.253620833664, 6497.350264973465, 6504.414602685781, 6382.648954307558, 6443.548951573345, 6534.640594767334, 6540.8364790880605, 6587.9670601646685, 6408.743650254124, 6417.197850268716, 6431.48548116159, 6447.065175549613, 6461.450776684034], "value": 6055.861564585082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.07371932523, 770.5530792140559, 827.2265431821246, 1224.589762429586, 1286.781247187979, 37107.25785484289, 37820.621793782055, 37836.43245351322, 37873.81063094688, 37883.431748523726, 37879.81060094703, 38086.0, 38234.80882595583, 38290.23419531608, 38395.80802095993, 7783.688652453895, 7867.173946735567, 8377.45546539473, 8585.18440748128, 8592.613332400026, 8508.489490630582, 8587.52768597727, 8588.785280368009, 8609.956950215272, 8613.397062205648, 8530.829383412329, 8574.099719529453, 8615.483071015758, 8616.612252448655, 8645.69740059098, 8571.657133714643, 8571.828563428728, 8607.698730544464, 8632.39573229874, 8632.438891472035, 8478.576071196416, 8522.48865068098, 8522.659093636246, 8540.572971351408, 8553.144685531459, 37736.05659858498, 37761.622383776084, 37914.43128353077, 37977.0505737356, 37995.81002095, 3612.3317186320614, 3616.65641764032, 3651.06897741077, 3652.4338727497015, 3655.0679576708035, 31219.0, 31302.243730752456, 31331.843340783376, 31374.05877823669, 31392.686073139204, 2450.603156200966, 2834.730700583462, 3053.931124106567, 3144.3868445653106, 3148.795328303676, 273937.0, 275031.6248418745, 309504.0, 318207.0, 319921.0, 48852.0, 48965.87926509186, 49024.754876225394, 49134.0, 49202.0, 50563.241551376756, 50682.74658626683, 51334.48665513372, 51382.0, 51383.22925156126, 11944.701382465335, 14403.279836008367, 14524.854751452562, 14536.781948270784, 14539.200343981183, 11266.774664506664, 11828.40857957116, 11947.163698541193, 11972.161948663685, 11993.940030299967, 10934.726631834268, 11070.059044981106, 13504.0, 13722.588322350346, 13910.234937078356, 4978.327925730053, 5046.823361182341, 5339.359276886798, 5877.618759591493, 6070.908936365958, 916.4867674102524, 1007.7379881230933, 1022.5909636145452, 1091.1270983213396, 1103.7847619714078, 23691.815409229468, 24605.63091553628, 24797.00811967537, 24910.0, 24935.877885495196, 1148.7070796946725, 1152.2970987697497, 1189.120051162134, 1190.547591915084, 1195.8804119587971, 8867.911320886838, 11463.598774042868, 12036.45835937385, 12701.809472857914, 12795.104342695922, 335364.0, 335380.0, 338131.0, 338428.3078584591, 339836.0, 49407.75296123496, 51390.48609513857, 54983.45016549783, 55139.0, 55262.0, 1493.5220729366715, 1514.5759187427318, 1564.7496400575853, 1567.8588926996624, 1581.2014932459035, 19673.409797706092, 20153.0, 20540.0, 23509.177178798658, 24391.658458784936, 38730.6126938727, 38758.61241387663, 38835.41746873856, 38841.2231755369, 38892.80553597214, 279810.8028379535, 282995.0, 283111.0, 283402.0, 284016.0, 35375.46936796002, 35616.0, 35643.28713425769, 36869.44695829511, 37147.6998305058, 44878.55121448874, 45700.314495281935, 46053.76973115113, 46496.30255546102, 46536.53463465458, 29668.851655741582, 31368.686313136575, 31412.0, 32015.0, 32085.0, 31219.84390078126, 31281.374372511968, 31641.36717265688, 31768.36463270768, 31867.0, 37806.86579402622, 37893.0, 38138.80930595329, 38247.0, 38248.42627360648, 30239.848800755855, 31827.20431989219, 32012.839935800173, 32497.0, 32770.344593107526, 22967.736774476896, 24222.273331800076, 24913.50172996566, 25148.371290717878, 25427.87286063558], "value": 17639.3594826459, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.7755755785769, 444.2625242098118, 445.8474842532053, 459.8206699387239, 462.1058252281833, 18931.432057038277, 20663.070161842716, 21347.78652213481, 21428.892855535738, 21492.462688432777, 21700.0, 22098.116075356967, 22321.0, 22395.888020559916, 22643.54712905745, 5955.106733989915, 6203.813885583417, 6208.286047104596, 6213.2233470816145, 6224.035274532454, 5644.3508996465525, 6239.37606239377, 6255.468285195741, 6284.905726414107, 6292.968535157318, 6086.6348019119, 6213.533984951124, 6241.500679945593, 6261.968690156543, 6262.279837818641, 6154.938450615504, 6253.343398943114, 6257.812265632038, 6259.123722678829, 6267.279262884758, 5516.558675305966, 5537.335519737617, 5551.333839939192, 5564.8330550083565, 5615.9157612635845, 21062.0, 27892.16323510298, 28673.713262867313, 28705.712942870723, 29129.70870291291, 2200.273909609825, 2212.314182603398, 2244.7418546867157, 2267.7278726552754, 2269.4893648929024, 17673.38143164996, 17725.379611713528, 17897.821021789747, 18115.36596219126, 18359.265629374942, 2133.296012315932, 2158.028887000856, 2199.8900054997184, 2201.801837834603, 2208.950748394516, 118065.40967295108, 127422.0, 158221.41778582183, 158847.0, 160273.79452411004, 9408.459715876676, 12485.0, 12487.876091151658, 12492.562760303346, 12529.18560293578, 16119.67760644804, 16412.917935410245, 16436.75344869828, 16437.0, 16437.09595972233, 6636.402723754885, 7990.360771138295, 8083.959580202179, 9128.087191280818, 9188.540572971324, 8551.059383467813, 8593.742187734379, 8607.78480537979, 8750.256228220545, 8763.605637746317, 7828.530288182727, 7895.447318687637, 7909.559381616326, 7948.006499187602, 7973.641186146638, 2158.568286342738, 2164.5021645021734, 2166.3825809644177, 2168.7831216878185, 2368.0172728317557, 935.4293880732747, 937.9155875971059, 960.577345967772, 968.7287559483356, 996.2627655534997, 20947.0, 21206.681899771516, 21332.0, 21475.03362348698, 21847.563048739255, 927.2813569483569, 1004.7990401919645, 1011.9696409107738, 1021.3463383434607, 1034.9534270957824, 10673.679789606324, 10940.12479001678, 11048.779024419466, 11061.502232399562, 11098.2786118902, 529295.0, 549518.0, 550101.0, 552014.0, 553136.0, 99064.00935990692, 128945.0, 131953.0, 133771.0, 137341.0, 1199.7180662544295, 1233.173773571709, 1251.205484517338, 1251.3055254333933, 1251.6182564317971, 21188.94055297198, 21581.676274856203, 22958.770412295664, 23020.0, 23085.0, 40409.19181616292, 57479.712601436724, 57756.71121644533, 58570.707146463996, 60527.69736151291, 83617.0, 84287.20707568052, 84316.57841710752, 84750.15249847423, 84920.4523864285, 8839.381243312906, 9012.369134160546, 9021.421251280868, 9222.262219022328, 9264.814703705753, 14648.340824662702, 14752.049590081811, 14827.92586037063, 14965.251737413304, 15158.3178756954, 11186.832197517206, 12091.39543022863, 12168.2699038058, 12427.689307767378, 12500.562480313145, 11621.0, 11644.88355116472, 11858.34779087124, 11909.821352679543, 12271.57049503263, 10985.681718193868, 12607.117501774788, 12661.240325580125, 12702.110852240625, 12800.423980921067, 8049.356051515982, 8283.62723677448, 8965.775855603662, 9088.772780680536, 9132.863007054766, 12118.151729378858, 12188.0, 12268.938655306667, 12400.875991239973, 12527.624171274876], "value": 10562.00745260756, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.3335648853817, 1383.584924522643, 1405.7048019915817, 1409.4080486195796, 1411.5483045425465, 11335.546578136875, 11466.08271338293, 11806.350650714206, 11896.524139034449, 11914.0468762499, 11568.421578921041, 11772.234804737685, 11783.175177737561, 11795.70510737232, 11820.468078936447, 2480.3055144559553, 2512.9120480783176, 2529.8229123961332, 2530.063876365738, 2534.3157347516158, 2360.6341017142286, 2399.1722855614785, 2400.3639035655565, 2408.2654790288957, 2412.9034838606435, 1853.3142737187193, 2486.664300319461, 2493.2644869763462, 2533.138732830837, 2541.186820217531, 2419.6491508731224, 2446.755324467557, 2476.777090061894, 2477.318737347226, 2483.875806209682, 2424.793892519138, 2515.0, 2523.9495210095697, 2530.658361121262, 2537.606670966003, 11726.941365293203, 11822.704432389173, 11823.586174483939, 11838.112141589416, 11860.347680877549, 6572.309907459696, 6836.829079273058, 6837.384635382839, 6838.7264509419565, 6843.110395648584, 4007.158496715693, 4065.166640838621, 4250.893727656802, 4344.652427805768, 4365.454318210223, 1107.1751545098953, 1255.8806913343217, 1264.3551788587795, 1306.1640550047978, 1310.1156719214587, 15645.217739112999, 16314.265858036417, 16425.753613695804, 16516.669666606602, 16528.75206871898, 5515.751791169327, 5641.153826925912, 5698.088305871041, 5796.1595568642315, 5814.360420353758, 9709.271804614682, 11768.117391195694, 11887.465064072137, 11926.224795388272, 11938.0, 5263.6315457918345, 5443.210734443563, 6519.989401642753, 6590.077389165521, 6593.967030164818, 6010.699465026732, 6121.418465245794, 6220.906686399708, 6291.213598300213, 6296.150019747367, 3657.743957922973, 4272.46594175728, 4405.118976204772, 4413.646908247332, 4424.867253982386, 1259.8236246925437, 1282.0192552697195, 1282.9928506122649, 1287.349888306418, 1290.8838204561634, 775.2673723331397, 793.8610743119931, 800.8958835351367, 813.7680760983092, 821.5194111444753, 5611.7474713637985, 6218.471429928416, 6258.249010118815, 6341.207349081365, 6442.6778661066755, 586.4721750424652, 587.6943989125631, 609.065085094378, 617.062065660194, 619.5074915442234, 3898.3762597984755, 4430.822767089345, 4463.419755431773, 4525.275955847049, 4592.885177870513, 14460.710785784226, 14818.481353152589, 14903.403863845542, 15290.617734556725, 15303.234838258266, 14304.141751494944, 14544.909131815157, 14940.551783446514, 14948.32732527039, 14971.775423368657, 7167.89248161278, 8249.752507424906, 8596.91403085961, 8627.568621568897, 8652.480851148825, 6982.812921803204, 7090.893636595559, 7160.820979475347, 7200.49596528238, 7409.222031686811, 10208.856140210639, 12012.159148859846, 12488.562900298446, 13606.795898061338, 13835.79246311286, 12884.48462061507, 13580.524681636096, 13763.38064787067, 13978.790318145033, 14038.508652197124, 9301.279263336033, 9540.809183816424, 9544.284178686765, 9551.570179341807, 9582.472963987047, 10665.786684266115, 10675.199360048182, 10745.0, 10784.352938823695, 10822.729431764268, 9051.592678329624, 9112.271018318652, 9146.771330716785, 9198.172164504958, 9444.905550944402, 8868.822623547621, 9065.546722663972, 9096.9538503073, 9097.0, 9261.907380926374, 8246.422750407413, 8284.875726863982, 8341.95829020851, 8354.45696029756, 8376.748697539084, 6133.172021777182, 6262.342454042442, 6278.686065696788, 6319.842003949754, 6381.553291269566, 6076.817695469143, 6284.74861005573, 6353.078803573549, 6396.584222025554, 6406.167198264196], "value": 5308.860027655629, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3955995687418, 391.93141200289944, 393.6674357300537, 418.2617679795162, 419.1073014479159, 5942.1978032965535, 6116.327204007555, 6166.828302622499, 6290.087937249102, 6300.716467758951, 4906.582940450066, 6023.216981792371, 6097.237845269341, 6150.969245153768, 6182.721777520022, 3852.84588616455, 4707.882302942428, 4709.422343514927, 4716.292556116576, 4729.550692684206, 3747.8313475893515, 4010.739301945379, 4172.687048471362, 4280.208161490119, 4633.768311584424, 4388.473383194021, 4400.339949007658, 4403.185410699015, 4408.669349798778, 4435.356873253377, 3857.267119247362, 4406.294992801152, 4425.358323043173, 4445.199864024475, 4445.799939002753, 3275.721563667067, 3293.9835300823584, 3655.94516082259, 3809.12390150267, 3812.6377994090517, 4611.76941152941, 5959.463648271633, 5969.432903874168, 5989.940100599026, 6017.518598512109, 5330.680159190461, 5339.946600534023, 5347.983883062206, 5362.613636931567, 5404.8108316208745, 6465.288818229991, 6522.608643481406, 6615.0, 6619.304972977864, 6676.332366763333, 3611.656892595199, 4336.6530677545725, 4341.6526677865695, 4349.151915376503, 4362.694611377205, 6283.842903927392, 6472.805815825533, 6720.899186512206, 6929.79210623677, 6941.132358455193, 3419.0, 3480.154429355576, 3818.4654148419245, 4308.3968244445805, 4380.299152135643, 3295.6210035845706, 4261.913212130887, 4279.379489973936, 4472.127935052634, 4491.3487544306545, 4543.5002149763495, 4826.227803551415, 5099.821506247264, 5259.92233067936, 5293.153095504701, 5383.67697938125, 5893.557983151195, 6184.783532576338, 6620.933790662032, 6657.968014957689, 1423.665438621923, 1498.3482185249452, 1519.931603077864, 1524.1312451902309, 1525.9237038148049, 860.2902605350611, 861.5993562993239, 985.571276494727, 990.7027891632481, 999.415342024909, 6123.693815309217, 6261.342559031236, 6265.467435267962, 6278.591891527036, 6301.4328710416285, 5686.516646085129, 6645.335466453316, 6805.06055774102, 6870.519063665595, 6974.895376569356, 5024.7689316117785, 5650.378458369576, 5946.821595352147, 6016.977113890649, 6046.818595442144, 2621.2437666763312, 3035.907073453555, 3435.639257877937, 3480.686738193575, 3557.5375201223674, 6091.0, 6978.0, 7023.332783385672, 7048.541844780073, 7093.89359159613, 5782.0, 6635.971424429221, 6694.828405029198, 7072.222055573883, 7095.290470952967, 6181.660008699475, 6441.194850643669, 7074.823129421806, 7098.716051357991, 7111.608861512563, 5969.641821490551, 6189.535784816067, 6387.265464471459, 6859.382655561023, 6890.552114112566, 6151.477124444473, 6485.481161506974, 6761.526693131434, 6777.390034896883, 6816.659167041727, 7089.220185779664, 7111.964440177766, 7130.2869713028285, 7132.003039149046, 7134.215236324104, 4171.874843754692, 4349.478062632505, 4379.277419225792, 4392.231359512137, 4396.9120617588105, 6720.529562930744, 6831.618348917119, 6901.723931042702, 6915.688794004182, 6942.687579058854, 5203.5576975957465, 6098.255784896725, 6374.3306952771145, 6627.701753421204, 6649.434798042221, 5026.84919452417, 5149.948500514947, 5436.6194366393975, 5489.670619762827, 6176.3514830943905, 5477.589180811376, 6490.967545162244, 6502.902456463252, 6506.544541882212, 6512.251091124392, 4814.013127308824, 5194.3247377840635, 6555.0, 6587.440067594116, 6628.436582890508, 6153.969230153821, 6494.1232933553365, 6507.577007494498, 6534.967325163534, 6536.705848236746], "value": 4671.840061794951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.4034730999615, 830.9750707478778, 835.2399316621876, 867.4491697771913, 872.337023861865, 16269.511914642564, 16640.83359166408, 16654.25055872484, 18501.629967400644, 19089.61820763584, 17786.0, 18197.727034094467, 18362.26550937961, 18435.723464148014, 18580.53548661284, 979.4466126638462, 984.8916619171903, 994.5226291380142, 996.8953259907714, 997.8004399120168, 979.2508730820928, 986.6743974488402, 991.7421470417707, 994.6170724271135, 996.7757254617726, 1041.1878734587035, 1050.726811029134, 1056.1920131099714, 1056.6618682021756, 1059.9347655606105, 1041.8176819056634, 1052.394872948058, 1054.0, 1054.6941386997762, 1057.1278695076553, 749.9062617172854, 755.2749360613817, 756.1984296645518, 756.4024420707634, 762.523422860712, 16712.83287167125, 16749.078800665957, 16855.747163792552, 16878.0, 16905.915470422693, 16997.66004679912, 17131.657366852593, 17215.913920430445, 17361.7395739064, 17497.300107995667, 11295.661130166109, 11968.70078248042, 14151.29243537819, 14475.638109047253, 14487.492937747129, 3464.7921124732597, 3511.6839484446523, 3511.929761404783, 3513.3149035938004, 3514.1917359007316, 94387.0, 134006.0, 134393.0, 135031.0, 136235.31882340525, 13404.5308414207, 13419.0, 13703.794443083361, 13774.173549587056, 13802.861971380158, 25339.493210135694, 25873.22380328593, 25922.611160832603, 26345.209643710336, 26373.604395934075, 7686.46194766361, 7784.2215778421705, 7836.490628109154, 7915.84168316642, 7921.287084162453, 3822.2546603412065, 3895.922081558353, 3898.7270891037356, 3901.765894046366, 3902.434147048719, 3875.96124038756, 3886.3393223152134, 3948.526176858795, 3988.12261302513, 4000.319945609195, 941.110650435332, 953.1278879825021, 961.4135377419768, 969.5733877094056, 971.3540495570367, 640.4748106552582, 659.3340725866909, 665.3413121010165, 666.2571233075087, 682.1405029662661, 11207.66377008691, 12025.075987841903, 12103.757924841453, 12212.450439730233, 12300.81548776769, 642.9423598180966, 645.1935081148564, 659.3439527669904, 676.509530590318, 682.0689758479739, 5174.767135478913, 5409.945900541023, 5629.043062679272, 5658.0, 5688.23208866806, 87360.56319718361, 110692.0, 110759.56961721441, 111293.44353278182, 113079.0, 97573.0, 98068.0, 99011.0, 99425.50287248517, 100407.49796250972, 86892.0, 87046.69429958555, 88219.67670484948, 88252.99999999872, 89392.5530372344, 10596.682099537025, 11323.03754180871, 11498.425078745862, 11556.133290003116, 11677.124215684027, 34075.14812129716, 39385.606143938196, 43375.78312108419, 44102.779486102365, 44203.0, 72313.0, 77706.83439748522, 77837.221627783, 79591.20408795838, 82982.45701744377, 15809.498097680702, 17695.823041769418, 17862.46412607624, 17964.55088622795, 18005.2797888083, 16574.171291435137, 18862.24551017944, 19066.618667626848, 19101.71347429762, 19106.7133992993, 16792.24434900408, 17398.39105631297, 17439.82560174382, 17749.822501775332, 17902.015389153723, 17368.82631173672, 17418.651626967643, 18126.18432170582, 18145.274189032818, 18225.179866906285, 16838.905471144335, 16868.66262674715, 17215.7417638738, 17334.47996560105, 17335.393261235797, 11769.293842369485, 11778.587749428729, 12320.938395307967, 12478.001759859008, 12576.496940122293, 13458.0, 13711.17732935987, 13991.090579112326, 14068.859311407165, 14249.073810202304], "value": 8595.710676019848, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 113.0, 112.0, 115.0, 116.0, 114.0, 114.0, 114.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 149.0, 111.0, 116.0, 147.0, 112.0, 137.0, 111.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 201.0, 200.0, 206.0, 210.0, 252.0, 207.0, 276.0, 199.0, 200.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 61.0, 87.0, 115.0, 77.0, 61.0, 60.0, 58.0, 78.0, 59.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 83.0, 75.0, 71.0, 69.0, 89.0, 91.0, 59.0, 93.0], "value": 79.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 87.0, 90.0, 88.0, 89.0, 89.0, 88.0, 81.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 98.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 89.0, 93.0, 94.0, 93.0, 90.0, 92.0, 91.0, 89.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 50.0, 49.0, 49.0, 51.0, 57.0, 58.0, 64.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 57.0, 57.0, 69.0, 63.0, 58.0, 54.0, 56.0, 56.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 96.0, 108.0, 108.0, 83.0, 85.0, 86.0, 82.0, 86.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 145.0, 138.0, 138.0, 144.0, 159.0, 138.0, 157.0, 206.0, 152.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 177.0, 186.0, 188.0, 200.0, 242.0, 187.0, 181.0, 184.0], "value": 191.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 69.0, 64.0, 68.0, 97.0, 99.0, 82.0, 67.0], "value": 74.8, "unit": "score"}]}]} 05:13:40 INFO - Return code: 0 05:13:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:40 ERROR - # TBPL SUCCESS # 05:13:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:40 INFO - 2017-04-29 05:13:40.971 screenresolution[1660:10819] starting screenresolution argv=screenresolution get 05:13:40 INFO - 2017-04-29 05:13:40.974 screenresolution[1660:10819] Display 0: 1600x1200x32@60 05:13:40 INFO - 2017-04-29 05:13:40.980 screenresolution[1661:10822] starting screenresolution argv=screenresolution list 05:13:40 INFO - Available Modes on Display 0 05:13:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:41 INFO - Intel Iris: 05:13:41 INFO - Chipset Model: Intel Iris 05:13:41 INFO - Type: GPU 05:13:41 INFO - Bus: Built-In 05:13:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:41 INFO - Vendor: Intel (0x8086) 05:13:41 INFO - Device ID: 0x0a2e 05:13:41 INFO - Revision ID: 0x0009 05:13:41 INFO - Displays: 05:13:41 INFO - Display: 05:13:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:41 INFO - Display Serial Number: 1600x1200 60 05:13:41 INFO - Main Display: Yes 05:13:41 INFO - Mirror: Off 05:13:41 INFO - Online: Yes 05:13:41 INFO - Rotation: Supported 05:13:41 INFO - Return code: 0 05:13:41 INFO - Running post-action listener: _resource_record_post_action 05:13:41 INFO - [mozharness: 2017-04-29 12:13:41.216516Z] Finished run-tests step (success) 05:13:41 INFO - Running post-run listener: _resource_record_post_run 05:13:41 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 41746944; Write bytes: 512530432; Read time: 438; Write time: 2029 05:13:41 INFO - TinderboxPrint: CPU usage
53.8% 05:13:41 INFO - TinderboxPrint: I/O read bytes / time
41,746,944 / 438 05:13:41 INFO - TinderboxPrint: I/O write bytes / time
512,530,432 / 2,029 05:13:41 INFO - TinderboxPrint: CPU idle
2,213.0 (46.2%) 05:13:41 INFO - TinderboxPrint: CPU system
959.2 (20.0%) 05:13:41 INFO - TinderboxPrint: CPU user
1,621.4 (33.8%) 05:13:41 INFO - TinderboxPrint: Swap in / out
240,496,640 / 0 05:13:41 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 199371264; Write bytes: 194611200; Read time: 15488; Write time: 441 05:13:41 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 40751616; Write bytes: 301076480; Read time: 418; Write time: 1534 05:13:41 INFO - Running post-run listener: _upload_blobber_files 05:13:41 INFO - Blob upload gear active. 05:13:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:13:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:13:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:43 INFO - (blobuploader) - INFO - Done attempting. 05:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:44 INFO - (blobuploader) - INFO - Done attempting. 05:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:46 INFO - (blobuploader) - INFO - Done attempting. 05:13:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:48 INFO - (blobuploader) - INFO - Done attempting. 05:13:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:48 INFO - Return code: 0 05:13:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79134245f46e44f7d165734ac47e2d2e257af7480aa495316fc55ccfa156a77215763964c3e66c50e047e7158db1e4691272f03989fa21b586bbdf5eb7289356", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd89fdd1ed482c7da33230cd3d11967ea251f2ea6eed7f38d30369de7a63c87df29a935c25d4b226263e4918b3dc5a9775bb82414032fc5d7a69b257774317b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/071912fe84a7777812ca63e44a373196054757793d1dc79b5e8d6f8dca3e8e55287d94487d98e38bf8473be00b1a0fe0314c3bf4d5d2cff962c77e68969b37a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31a2f4bbf4f15ca3bf29018be4d142aadd0b4f6f9442e2eea7421536de91e7ef9dae875f9ad7433806ed339ec9d708faf4466ce6323690bcb14a03960d941b3c"} 05:13:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:48 INFO - Contents: 05:13:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79134245f46e44f7d165734ac47e2d2e257af7480aa495316fc55ccfa156a77215763964c3e66c50e047e7158db1e4691272f03989fa21b586bbdf5eb7289356", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd89fdd1ed482c7da33230cd3d11967ea251f2ea6eed7f38d30369de7a63c87df29a935c25d4b226263e4918b3dc5a9775bb82414032fc5d7a69b257774317b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/071912fe84a7777812ca63e44a373196054757793d1dc79b5e8d6f8dca3e8e55287d94487d98e38bf8473be00b1a0fe0314c3bf4d5d2cff962c77e68969b37a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31a2f4bbf4f15ca3bf29018be4d142aadd0b4f6f9442e2eea7421536de91e7ef9dae875f9ad7433806ed339ec9d708faf4466ce6323690bcb14a03960d941b3c"} 05:13:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:48 INFO - Copying logs to upload dir... 05:13:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1301.171551 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2017-04-29 05:13:48.776855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 05:13:48.782389) ========= 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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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/79134245f46e44f7d165734ac47e2d2e257af7480aa495316fc55ccfa156a77215763964c3e66c50e047e7158db1e4691272f03989fa21b586bbdf5eb7289356", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd89fdd1ed482c7da33230cd3d11967ea251f2ea6eed7f38d30369de7a63c87df29a935c25d4b226263e4918b3dc5a9775bb82414032fc5d7a69b257774317b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/071912fe84a7777812ca63e44a373196054757793d1dc79b5e8d6f8dca3e8e55287d94487d98e38bf8473be00b1a0fe0314c3bf4d5d2cff962c77e68969b37a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31a2f4bbf4f15ca3bf29018be4d142aadd0b4f6f9442e2eea7421536de91e7ef9dae875f9ad7433806ed339ec9d708faf4466ce6323690bcb14a03960d941b3c"} build_url:https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010967 build_url: 'https://queue.taskcluster.net/v1/task/KjAuJGXZRGmfjRXiiHwiag/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/79134245f46e44f7d165734ac47e2d2e257af7480aa495316fc55ccfa156a77215763964c3e66c50e047e7158db1e4691272f03989fa21b586bbdf5eb7289356", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd89fdd1ed482c7da33230cd3d11967ea251f2ea6eed7f38d30369de7a63c87df29a935c25d4b226263e4918b3dc5a9775bb82414032fc5d7a69b257774317b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/071912fe84a7777812ca63e44a373196054757793d1dc79b5e8d6f8dca3e8e55287d94487d98e38bf8473be00b1a0fe0314c3bf4d5d2cff962c77e68969b37a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31a2f4bbf4f15ca3bf29018be4d142aadd0b4f6f9442e2eea7421536de91e7ef9dae875f9ad7433806ed339ec9d708faf4466ce6323690bcb14a03960d941b3c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 05:13:48.818696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 05:13:48.819081) ========= 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.JDjTiBV7Gy/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.H6uQCyzM5j/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.004905 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 05:13:48.868216) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 05:13:48.868534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 05:13:48.869044) ========= ========= Total master_lag: 1.24 =========