builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0342 starttime: 1493293808.67 results: success (0) buildid: 20170427030231 builduid: 04cf21f6a0db47c8a8b93e20312ecb90 revision: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.674921) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.675395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.675677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.703103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.703483) ========= 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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-27 04:50:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 82.4M=0s 2017-04-27 04:50:08 (82.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091710 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.820721) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.821131) ========= 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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.027160 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:08.871770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 04:50:08.872179) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b77ed3f26c5335503bc16e85b8c067382e7bb1e --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 0b77ed3f26c5335503bc16e85b8c067382e7bb1e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-27 04:50:08,979 truncating revision to first 12 chars 2017-04-27 04:50:08,979 Setting DEBUG logging. 2017-04-27 04:50:08,979 attempt 1/10 2017-04-27 04:50:08,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b77ed3f26c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 04:50:10,324 unpacking tar archive at: mozilla-central-0b77ed3f26c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624671 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 04:50:10.543899) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:10.544233) ========= script_repo_revision: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:10.544632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:10.544910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 04:50:10.565306) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 04:50:10.565663) ========= /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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:50:10 INFO - MultiFileLogger online at 20170427 04:50:10 in /builds/slave/test 04:50:10 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:50:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:10 INFO - {'append_to_log': False, 04:50:10 INFO - 'base_work_dir': '/builds/slave/test', 04:50:10 INFO - 'blob_upload_branch': 'Firefox', 04:50:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:10 INFO - 'branch': 'Firefox', 04:50:10 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:10 INFO - 'config_files': ('talos/mac_config.py',), 04:50:10 INFO - 'default_actions': ('clobber', 04:50:10 INFO - 'read-buildbot-config', 04:50:10 INFO - 'download-and-extract', 04:50:10 INFO - 'populate-webroot', 04:50:10 INFO - 'create-virtualenv', 04:50:10 INFO - 'install', 04:50:10 INFO - 'run-tests'), 04:50:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:10 INFO - 'download_minidump_stackwalk': True, 04:50:10 INFO - 'download_symbols': 'ondemand', 04:50:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:10 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:10 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:10 INFO - 'gecko_profile': False, 04:50:10 INFO - 'gecko_profile_interval': 0, 04:50:10 INFO - 'installer_path': 'installer.exe', 04:50:10 INFO - 'log_level': 'info', 04:50:10 INFO - 'log_name': 'talos', 04:50:10 INFO - 'log_to_console': True, 04:50:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:50:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:50:10 INFO - 'opt_config_files': (), 04:50:10 INFO - 'pip_index': False, 04:50:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:10 INFO - 'cmd': ('bash', 04:50:10 INFO - '-c', 04:50:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:10 INFO - 'enabled': True, 04:50:10 INFO - 'halt_on_failure': False, 04:50:10 INFO - 'name': 'check_screen_resolution'},), 04:50:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:50:10 INFO - 'cmd': ('bash', 04:50:10 INFO - '-c', 04:50:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:50:10 INFO - 'enabled': True, 04:50:10 INFO - 'halt_on_failure': False, 04:50:10 INFO - 'name': 'check_screen_resolution'},), 04:50:10 INFO - 'run_cmd_checks_enabled': True, 04:50:10 INFO - 'suite': 'dromaeojs-e10s', 04:50:10 INFO - 'system_bits': '32', 04:50:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:10 INFO - 'title': 't-yosemite-r7-0342', 04:50:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:10 INFO - 'use_talos_json': True, 04:50:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:10 INFO - 'work_dir': 'build'} 04:50:10 INFO - [mozharness: 2017-04-27 11:50:10.781260Z] Running clobber step. 04:50:10 INFO - Running pre-action listener: _resource_record_pre_action 04:50:10 INFO - Running main action method: clobber 04:50:10 INFO - rmtree: /builds/slave/test/build 04:50:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:13 INFO - Running post-action listener: _resource_record_post_action 04:50:13 INFO - [mozharness: 2017-04-27 11:50:13.303203Z] Finished clobber step (success) 04:50:13 INFO - [mozharness: 2017-04-27 11:50:13.303365Z] Running read-buildbot-config step. 04:50:13 INFO - Running pre-action listener: _resource_record_pre_action 04:50:13 INFO - Running main action method: read_buildbot_config 04:50:13 INFO - Using buildbot properties: 04:50:13 INFO - { 04:50:13 INFO - "project": "", 04:50:13 INFO - "product": "firefox", 04:50:13 INFO - "script_repo_revision": "production", 04:50:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:50:13 INFO - "repository": "", 04:50:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:50:13 INFO - "buildid": "20170427030231", 04:50:13 INFO - "stage_platform": "macosx64", 04:50:13 INFO - "basedir": "/builds/slave/test", 04:50:13 INFO - "nightly_build": "True", 04:50:13 INFO - "buildnumber": 50, 04:50:13 INFO - "slavename": "t-yosemite-r7-0342", 04:50:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:50:13 INFO - "platform": "yosemite_r7", 04:50:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:50:13 INFO - "branch": "mozilla-central", 04:50:13 INFO - "repo_path": "mozilla-central", 04:50:13 INFO - "revision": "0b77ed3f26c5335503bc16e85b8c067382e7bb1e", 04:50:13 INFO - "pgo_build": "False", 04:50:13 INFO - "builduid": "04cf21f6a0db47c8a8b93e20312ecb90", 04:50:13 INFO - "slavebuilddir": "test" 04:50:13 INFO - } 04:50:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:50:13 INFO - Running post-action listener: _resource_record_post_action 04:50:13 INFO - [mozharness: 2017-04-27 11:50:13.306965Z] Finished read-buildbot-config step (success) 04:50:13 INFO - [mozharness: 2017-04-27 11:50:13.307093Z] Running download-and-extract step. 04:50:13 INFO - Running pre-action listener: _resource_record_pre_action 04:50:13 INFO - Running main action method: download_and_extract 04:50:13 INFO - mkdir: /builds/slave/test/build/tests 04:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:13 INFO - trying https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:50:13 INFO - Downloading https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/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:50:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/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:50:14 INFO - Downloaded 1325 bytes. 04:50:14 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:50:14 INFO - Using the following test package requirements: 04:50:14 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:50:14 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:50:14 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:50:14 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:50:14 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'jsshell-mac.zip'], 04:50:14 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:50:14 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:50:14 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:50:14 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:50:14 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:50:14 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:50:14 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:50:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:50:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:50:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:50:14 INFO - Fetch https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:50:16 INFO - Content-Length response header: 52532779 04:50:16 INFO - Bytes received: 52532779 04:50:32 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:50:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:50:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:50:32 INFO - Fetch https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:50:34 INFO - Content-Length response header: 52532779 04:50:34 INFO - Bytes received: 52532779 04:50:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:50:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:50:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:50:50 INFO - Content-Length response header: 14408809 04:50:50 INFO - Bytes received: 14408809 04:50:50 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:50:50 INFO - trying https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:50:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/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:50:52 INFO - Downloaded 71254961 bytes. 04:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:50:52 INFO - mkdir: /builds/slave/test/properties 04:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:50:52 INFO - Contents: 04:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:50:53 INFO - Running post-action listener: _resource_record_post_action 04:50:53 INFO - Running post-action listener: set_extra_try_arguments 04:50:53 INFO - [mozharness: 2017-04-27 11:50:53.494592Z] Finished download-and-extract step (success) 04:50:53 INFO - [mozharness: 2017-04-27 11:50:53.494697Z] Running populate-webroot step. 04:50:53 INFO - Running pre-action listener: _resource_record_pre_action 04:50:53 INFO - Running main action method: populate_webroot 04:50:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:53 INFO - '--tppagecycles', 04:50:53 INFO - '7'], 04:50:53 INFO - 'tests': ['tsvgm']}}, 04:50:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:50:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:50:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:50:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['damp', 'tps']}, 04:50:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'tests': ['damp', 'tps']}, 04:50:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['dromaeo_dom']}, 04:50:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:50:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:50:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['a11yr', 04:50:53 INFO - 'ts_paint', 04:50:53 INFO - 'tpaint', 04:50:53 INFO - 'sessionrestore', 04:50:53 INFO - 'sessionrestore_no_auto_restore', 04:50:53 INFO - 'tabpaint']}, 04:50:53 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:50:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:50:53 INFO - 'bloom_basic_ref']}, 04:50:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['tsvgx', 04:50:53 INFO - 'tsvgr_opacity', 04:50:53 INFO - 'tart', 04:50:53 INFO - 'tscrollx', 04:50:53 INFO - 'cart', 04:50:53 INFO - 'tsvg_static']}, 04:50:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:50:53 INFO - 'tsvgr_opacity', 04:50:53 INFO - 'tart', 04:50:53 INFO - 'tscrollx', 04:50:53 INFO - 'cart', 04:50:53 INFO - 'tsvg_static']}, 04:50:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'talos_options': ['--disable-e10s'], 04:50:53 INFO - 'tests': ['tp5o']}, 04:50:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:50:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'talos_options': ['--disable-e10s', 04:50:53 INFO - '--xperf_path', 04:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:53 INFO - 'tests': ['tp5n']}, 04:50:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:50:53 INFO - 'talos_options': ['--xperf_path', 04:50:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:53 INFO - 'tests': ['tp5n']}}, 04:50:53 INFO - 'talos.zip': {'path': '', 04:50:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:53 INFO - Running post-action listener: _resource_record_post_action 04:50:53 INFO - [mozharness: 2017-04-27 11:50:53.513421Z] Finished populate-webroot step (success) 04:50:53 INFO - [mozharness: 2017-04-27 11:50:53.513555Z] Running create-virtualenv step. 04:50:53 INFO - Running pre-action listener: _resource_record_pre_action 04:50:53 INFO - Running main action method: create_virtualenv 04:50:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:50:53 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:50:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:50:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:53 INFO - Using real prefix '/tools/python27' 04:50:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:50:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:57 INFO - Installing pip.................done. 04:50:57 INFO - Return code: 0 04:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:50:57 INFO - Reading from file tmpfile_stdout 04:50:57 INFO - Output received: 04:50:57 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:50:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:50:57 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:50:57 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:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:57 INFO - 'HOME': '/Users/cltbld', 04:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:57 INFO - 'LOGNAME': 'cltbld', 04:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:57 INFO - 'MOZ_NO_REMOTE': '1', 04:50:57 INFO - 'NO_EM_RESTART': '1', 04:50:57 INFO - 'PAGER': '/bin/cat', 04:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:57 INFO - 'PWD': '/builds/slave/test', 04:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:57 INFO - 'SHELL': '/bin/bash', 04:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:50:57 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:57 INFO - 'USER': 'cltbld', 04:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:57 INFO - 'XPC_FLAGS': '0x0', 04:50:57 INFO - 'XPC_SERVICE_NAME': '0', 04:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:57 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:50:57 INFO - Cleaning up... 04:50:57 INFO - Return code: 0 04:50:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:50:57 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:50:57 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:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:57 INFO - 'HOME': '/Users/cltbld', 04:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:57 INFO - 'LOGNAME': 'cltbld', 04:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:57 INFO - 'MOZ_NO_REMOTE': '1', 04:50:57 INFO - 'NO_EM_RESTART': '1', 04:50:57 INFO - 'PAGER': '/bin/cat', 04:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:57 INFO - 'PWD': '/builds/slave/test', 04:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:57 INFO - 'SHELL': '/bin/bash', 04:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:50:57 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:57 INFO - 'USER': 'cltbld', 04:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:57 INFO - 'XPC_FLAGS': '0x0', 04:50:57 INFO - 'XPC_SERVICE_NAME': '0', 04:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:58 INFO - Downloading/unpacking psutil>=3.1.1 04:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:51:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:01 INFO - Installing collected packages: psutil 04:51:01 INFO - Running setup.py install for psutil 04:51:01 INFO - building 'psutil._psutil_osx' extension 04:51:01 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:51:02 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:51:02 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:51:02 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:51:02 INFO - building 'psutil._psutil_posix' extension 04:51:02 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:51:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:51:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:51:02 INFO - ^ 04:51:02 INFO - 1 warning generated. 04:51:02 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:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:51:02 INFO - Successfully installed psutil 04:51:02 INFO - Cleaning up... 04:51:02 INFO - Return code: 0 04:51:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:02 INFO - 'HOME': '/Users/cltbld', 04:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:02 INFO - 'LOGNAME': 'cltbld', 04:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:02 INFO - 'MOZ_NO_REMOTE': '1', 04:51:02 INFO - 'NO_EM_RESTART': '1', 04:51:02 INFO - 'PAGER': '/bin/cat', 04:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:02 INFO - 'PWD': '/builds/slave/test', 04:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:02 INFO - 'SHELL': '/bin/bash', 04:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:02 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:02 INFO - 'USER': 'cltbld', 04:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:02 INFO - 'XPC_FLAGS': '0x0', 04:51:02 INFO - 'XPC_SERVICE_NAME': '0', 04:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:51:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:51:05 INFO - Installing collected packages: mozsystemmonitor 04:51:05 INFO - Running setup.py install for mozsystemmonitor 04:51:05 INFO - Successfully installed mozsystemmonitor 04:51:05 INFO - Cleaning up... 04:51:05 INFO - Return code: 0 04:51:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:51: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:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:06 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:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:06 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:06 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:51:06 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:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:06 INFO - 'HOME': '/Users/cltbld', 04:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:06 INFO - 'LOGNAME': 'cltbld', 04:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:06 INFO - 'MOZ_NO_REMOTE': '1', 04:51:06 INFO - 'NO_EM_RESTART': '1', 04:51:06 INFO - 'PAGER': '/bin/cat', 04:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:06 INFO - 'PWD': '/builds/slave/test', 04:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:06 INFO - 'SHELL': '/bin/bash', 04:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:06 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:06 INFO - 'USER': 'cltbld', 04:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:06 INFO - 'XPC_FLAGS': '0x0', 04:51:06 INFO - 'XPC_SERVICE_NAME': '0', 04:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:10 INFO - warning: no files found matching '*.txt' 04:51:10 INFO - no previously-included directories found matching 'build' 04:51:10 INFO - no previously-included directories found matching 'dist' 04:51:10 INFO - no previously-included directories found matching '.git*' 04:51:10 INFO - Installing collected packages: jsonschema, functools32 04:51:10 INFO - Running setup.py install for functools32 04:51:10 INFO - warning: no files found matching '*.txt' 04:51:10 INFO - no previously-included directories found matching 'build' 04:51:10 INFO - no previously-included directories found matching 'dist' 04:51:10 INFO - no previously-included directories found matching '.git*' 04:51:10 INFO - Successfully installed jsonschema functools32 04:51:10 INFO - Cleaning up... 04:51:10 INFO - Return code: 0 04:51:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:51: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:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:10 INFO - 'HOME': '/Users/cltbld', 04:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:10 INFO - 'LOGNAME': 'cltbld', 04:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:10 INFO - 'MOZ_NO_REMOTE': '1', 04:51:10 INFO - 'NO_EM_RESTART': '1', 04:51:10 INFO - 'PAGER': '/bin/cat', 04:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:10 INFO - 'PWD': '/builds/slave/test', 04:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:10 INFO - 'SHELL': '/bin/bash', 04:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:10 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:10 INFO - 'USER': 'cltbld', 04:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:10 INFO - 'XPC_FLAGS': '0x0', 04:51:10 INFO - 'XPC_SERVICE_NAME': '0', 04:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:51:10 INFO - Cleaning up... 04:51:10 INFO - Return code: 0 04:51:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51: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:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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:51:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:51:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:51:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:10 INFO - 'HOME': '/Users/cltbld', 04:51:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:10 INFO - 'LOGNAME': 'cltbld', 04:51:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:10 INFO - 'MOZ_NO_REMOTE': '1', 04:51:10 INFO - 'NO_EM_RESTART': '1', 04:51:10 INFO - 'PAGER': '/bin/cat', 04:51:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:10 INFO - 'PWD': '/builds/slave/test', 04:51:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:10 INFO - 'SHELL': '/bin/bash', 04:51:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:10 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:10 INFO - 'USER': 'cltbld', 04:51:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:10 INFO - 'XPC_FLAGS': '0x0', 04:51:10 INFO - 'XPC_SERVICE_NAME': '0', 04:51:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:13 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51: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:51: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:51: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:51: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:51: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:51: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:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:14 INFO - Downloading docopt-0.6.1.tar.gz 04:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:15 INFO - Running setup.py install for blobuploader 04:51:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:15 INFO - Running setup.py install for requests 04:51:15 INFO - Running setup.py install for docopt 04:51:15 INFO - Successfully installed blobuploader requests docopt 04:51:15 INFO - Cleaning up... 04:51:16 INFO - Return code: 0 04:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:16 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:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:16 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:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:16 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:16 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:51:16 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:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:16 INFO - 'HOME': '/Users/cltbld', 04:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:16 INFO - 'LOGNAME': 'cltbld', 04:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:16 INFO - 'MOZ_NO_REMOTE': '1', 04:51:16 INFO - 'NO_EM_RESTART': '1', 04:51:16 INFO - 'PAGER': '/bin/cat', 04:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:16 INFO - 'PWD': '/builds/slave/test', 04:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:16 INFO - 'SHELL': '/bin/bash', 04:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:16 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:16 INFO - 'USER': 'cltbld', 04:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:16 INFO - 'XPC_FLAGS': '0x0', 04:51:16 INFO - 'XPC_SERVICE_NAME': '0', 04:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-hARF3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-E895WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ssct2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-4q1lT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-5EXkHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-o0WFvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:16 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-VXwwDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-AajWIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-UoxqyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-mOGdBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-tfTlhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-sgrZlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Q907pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-bXLJhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-jcUJ13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-fBzpe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:17 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-9quQny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:18 INFO - Running setup.py install for manifestparser 04:51:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:18 INFO - Running setup.py install for mozcrash 04:51:18 INFO - Running setup.py install for mozdebug 04:51:18 INFO - Running setup.py install for mozdevice 04:51:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:18 INFO - Running setup.py install for mozfile 04:51:18 INFO - Running setup.py install for mozhttpd 04:51:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:18 INFO - Running setup.py install for mozinfo 04:51:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Running setup.py install for mozInstall 04:51:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Running setup.py install for mozleak 04:51:19 INFO - Running setup.py install for mozlog 04:51:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Running setup.py install for moznetwork 04:51:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:19 INFO - Running setup.py install for mozprocess 04:51:19 INFO - Running setup.py install for mozprofile 04:51:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:20 INFO - Running setup.py install for mozrunner 04:51:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:20 INFO - Running setup.py install for mozscreenshot 04:51:20 INFO - Running setup.py install for moztest 04:51:20 INFO - Running setup.py install for mozversion 04:51:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:20 INFO - Cleaning up... 04:51:20 INFO - Return code: 0 04:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:20 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:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:20 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:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:20 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:20 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:51:20 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:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:20 INFO - 'HOME': '/Users/cltbld', 04:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:20 INFO - 'LOGNAME': 'cltbld', 04:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:20 INFO - 'MOZ_NO_REMOTE': '1', 04:51:20 INFO - 'NO_EM_RESTART': '1', 04:51:20 INFO - 'PAGER': '/bin/cat', 04:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:20 INFO - 'PWD': '/builds/slave/test', 04:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:20 INFO - 'SHELL': '/bin/bash', 04:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:20 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:20 INFO - 'USER': 'cltbld', 04:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:20 INFO - 'XPC_FLAGS': '0x0', 04:51:20 INFO - 'XPC_SERVICE_NAME': '0', 04:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:20 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-iNPgV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-d3fU5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-u1Ffp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-zHxobm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-KE3Euw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-vtScQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Gd0NHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-AsLLKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-gIoqSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-3xQevf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:21 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:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:21 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-y664GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-H9cZnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-GixExP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Kw4tdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-84yMoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-JickrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:22 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:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:22 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Vj83ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 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:51:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51: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:51: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:51: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:51: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:51: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:51: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:51:25 INFO - Downloading blessings-1.6.tar.gz 04:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:25 INFO - Installing collected packages: blessings 04:51:25 INFO - Running setup.py install for blessings 04:51:25 INFO - Successfully installed blessings 04:51:25 INFO - Cleaning up... 04:51:25 INFO - Return code: 0 04:51:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:26 INFO - Reading from file tmpfile_stdout 04:51:26 INFO - Current package versions: 04:51:26 INFO - blessings == 1.6 04:51:26 INFO - blobuploader == 1.2.4 04:51:26 INFO - docopt == 0.6.1 04:51:26 INFO - functools32 == 3.2.3-2 04:51:26 INFO - jsonschema == 2.5.1 04:51:26 INFO - manifestparser == 1.1 04:51:26 INFO - mozInstall == 1.12 04:51:26 INFO - mozcrash == 1.0 04:51:26 INFO - mozdebug == 0.1 04:51:26 INFO - mozdevice == 0.50 04:51:26 INFO - mozfile == 1.2 04:51:26 INFO - mozhttpd == 0.7 04:51:26 INFO - mozinfo == 0.9 04:51:26 INFO - mozleak == 0.1 04:51:26 INFO - mozlog == 3.4 04:51:26 INFO - moznetwork == 0.27 04:51:26 INFO - mozprocess == 0.25 04:51:26 INFO - mozprofile == 0.28 04:51:26 INFO - mozrunner == 6.13 04:51:26 INFO - mozscreenshot == 0.1 04:51:26 INFO - mozsystemmonitor == 0.3 04:51:26 INFO - moztest == 0.8 04:51:26 INFO - mozversion == 1.4 04:51:26 INFO - psutil == 3.1.1 04:51:26 INFO - requests == 1.2.3 04:51:26 INFO - wsgiref == 0.1.2 04:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51: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:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:26 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 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51:26 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:51:26 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:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:26 INFO - 'HOME': '/Users/cltbld', 04:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:26 INFO - 'LOGNAME': 'cltbld', 04:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:26 INFO - 'MOZ_NO_REMOTE': '1', 04:51:26 INFO - 'NO_EM_RESTART': '1', 04:51:26 INFO - 'PAGER': '/bin/cat', 04:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:26 INFO - 'PWD': '/builds/slave/test', 04:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:26 INFO - 'SHELL': '/bin/bash', 04:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:26 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:26 INFO - 'USER': 'cltbld', 04:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:26 INFO - 'XPC_FLAGS': '0x0', 04:51:26 INFO - 'XPC_SERVICE_NAME': '0', 04:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 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:51:26 INFO - Cleaning up... 04:51:26 INFO - Return code: 0 04:51:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51: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:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1c6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b3bd9efd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, '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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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:51: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', 'jsonschema'] in /builds/slave/test/build 04:51: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 jsonschema 04:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:26 INFO - 'HOME': '/Users/cltbld', 04:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:26 INFO - 'LOGNAME': 'cltbld', 04:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:26 INFO - 'MOZ_NO_REMOTE': '1', 04:51:26 INFO - 'NO_EM_RESTART': '1', 04:51:26 INFO - 'PAGER': '/bin/cat', 04:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:26 INFO - 'PWD': '/builds/slave/test', 04:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:26 INFO - 'SHELL': '/bin/bash', 04:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:26 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:26 INFO - 'USER': 'cltbld', 04:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:26 INFO - 'XPC_FLAGS': '0x0', 04:51:26 INFO - 'XPC_SERVICE_NAME': '0', 04:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:51:26 INFO - Cleaning up... 04:51:26 INFO - Return code: 0 04:51:26 INFO - Running post-action listener: _resource_record_post_action 04:51:26 INFO - Running post-action listener: _start_resource_monitoring 04:51:26 INFO - Starting resource monitoring. 04:51:26 INFO - [mozharness: 2017-04-27 11:51:26.624575Z] Finished create-virtualenv step (success) 04:51:26 INFO - [mozharness: 2017-04-27 11:51:26.625600Z] Running install step. 04:51:26 INFO - Running pre-action listener: _resource_record_pre_action 04:51:26 INFO - Running main action method: install 04:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:26 INFO - Reading from file tmpfile_stdout 04:51:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:26 INFO - Reading from file tmpfile_stdout 04:51:26 INFO - Output received: 04:51:26 INFO - Usage: mozinstall [options] installer 04:51:26 INFO - Options: 04:51:26 INFO - -h, --help show this help message and exit 04:51:26 INFO - -d DEST, --destination=DEST 04:51:26 INFO - Directory to install application into. [default: 04:51:26 INFO - "/builds/slave/test"] 04:51:26 INFO - --app=APP Application being installed. [default: firefox] 04:51:26 INFO - mkdir: /builds/slave/test/build/application 04:51:26 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:51:26 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:51:47 INFO - Reading from file tmpfile_stdout 04:51:47 INFO - Output received: 04:51:47 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:51:47 INFO - Running post-action listener: _resource_record_post_action 04:51:47 INFO - [mozharness: 2017-04-27 11:51:47.202174Z] Finished install step (success) 04:51:47 INFO - [mozharness: 2017-04-27 11:51:47.202339Z] Running run-tests step. 04:51:47 INFO - Running pre-action listener: _resource_record_pre_action 04:51:47 INFO - Running main action method: run_tests 04:51:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:47 INFO - 2017-04-27 04:51:47.217 screenresolution[1624:7320] starting screenresolution argv=screenresolution get 04:51:47 INFO - 2017-04-27 04:51:47.220 screenresolution[1624:7320] Display 0: 1600x1200x32@60 04:51:47 INFO - 2017-04-27 04:51:47.226 screenresolution[1625:7323] starting screenresolution argv=screenresolution list 04:51:47 INFO - Available Modes on Display 0 04:51:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:47 INFO - Intel Iris: 04:51:47 INFO - Chipset Model: Intel Iris 04:51:47 INFO - Type: GPU 04:51:47 INFO - Bus: Built-In 04:51:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:47 INFO - Vendor: Intel (0x8086) 04:51:47 INFO - Device ID: 0x0a2e 04:51:47 INFO - Revision ID: 0x0009 04:51:47 INFO - Displays: 04:51:47 INFO - Display: 04:51:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:47 INFO - Display Serial Number: 1600x1200 60 04:51:47 INFO - Main Display: Yes 04:51:47 INFO - Mirror: Off 04:51:47 INFO - Online: Yes 04:51:47 INFO - Rotation: Supported 04:51:47 INFO - Return code: 0 04:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:51:47 INFO - Python 2.7.3 04:51:47 INFO - Return code: 0 04:51:47 INFO - grabbing minidump binary from tooltool 04:51:47 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:51:47 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 0x10cfa1d30>, '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 0x10cec7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cf96be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:51:47 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:51:47 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:51:47 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:51:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:51:47 INFO - Return code: 0 04:51:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:51:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:51:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:51:47 INFO - ENV: RUST_BACKTRACE is now 1 04:51:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:51:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:51:47 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/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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:51:47 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/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0342 --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:51:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fy9MVwr5dp/Render', 04:51:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:47 INFO - 'HOME': '/Users/cltbld', 04:51:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:47 INFO - 'LOGNAME': 'cltbld', 04:51:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:51:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:47 INFO - 'MOZ_NO_REMOTE': '1', 04:51:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:51:47 INFO - 'NO_EM_RESTART': '1', 04:51:47 INFO - 'PAGER': '/bin/cat', 04:51:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:47 INFO - 'PWD': '/builds/slave/test', 04:51:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:51:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:47 INFO - 'RUST_BACKTRACE': '1', 04:51:47 INFO - 'SHELL': '/bin/bash', 04:51:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hURXW7qoBc/Listeners', 04:51:47 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 04:51:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:47 INFO - 'USER': 'cltbld', 04:51:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:47 INFO - 'XPC_FLAGS': '0x0', 04:51:47 INFO - 'XPC_SERVICE_NAME': '0', 04:51:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:47 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/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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:51:47 INFO - mozversion application_buildid: 20170427030231 04:51:47 INFO - mozversion application_changeset: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e 04:51:47 INFO - mozversion application_display_name: Nightly 04:51:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:51:47 INFO - mozversion application_name: Firefox 04:51:47 INFO - mozversion application_remotingname: firefox 04:51:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:51:47 INFO - mozversion application_vendor: Mozilla 04:51:47 INFO - mozversion application_version: 55.0a1 04:51:47 INFO - mozversion platform_buildid: 20170427030231 04:51:47 INFO - mozversion platform_changeset: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e 04:51:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:51:47 INFO - mozversion platform_version: 55.0a1 04:51:47 INFO - using testdate: 1493293907 04:51:47 INFO - actual date: 1493293907 04:51:47 INFO - starting webserver on 'localhost:49241' 04:51:47 INFO - SUITE-START | Running 2 tests 04:51:47 INFO - TEST-START | dromaeo_css 04:51:47 INFO - operating with platform_type : mac_ 04:51:47 INFO - Initialising browser for dromaeo_css test... 04:51:47 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpveYIZ7/profile http://localhost:49241/getInfo.html) 04:51:50 INFO - PID 1635 | 2017-04-27 04:51:50.804 plugin-container[1637:7494] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 04:51:50 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:50 INFO - PID 1635 | 2017-04-27 04:51:50.805 plugin-container[1637:7494] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa30b, name = 'com.apple.CFPasteboardClient' 04:51:50 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:50 INFO - PID 1635 | 2017-04-27 04:51:50.805 plugin-container[1637:7494] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:51:50 INFO - PID 1635 | __metrics Screen width/height:1600/1200 04:51:50 INFO - PID 1635 | colorDepth:24 04:51:50 INFO - PID 1635 | Browser inner width/height: 1024/689 04:51:50 INFO - PID 1635 | __metrics 04:51:50 ERROR - PID 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 04:51:51 INFO - TEST-INFO | 1635: exit 0 04:51:51 INFO - Browser initialized. 04:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 04:51:51 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpveYIZ7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:54 INFO - PID 1639 | 2017-04-27 04:51:54.215 plugin-container[1640:7645] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 04:51:54 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:54 INFO - PID 1639 | 2017-04-27 04:51:54.216 plugin-container[1640:7645] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 04:51:54 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:51:54 INFO - PID 1639 | 2017-04-27 04:51:54.216 plugin-container[1640:7645] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:52:04 INFO - PID 1639 | RSS: Main: 235982848 04:52:04 INFO - PID 1639 | 04:55:08 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:55:09 INFO - PID 1639 | RSS: Main: 252043264 04:55:09 INFO - PID 1639 | 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:56:52 INFO - PID 1639 | 04:56:52 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:56:52 INFO - PID 1639 | Full stack: 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:56:52 INFO - PID 1639 | 04:56:52 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:56:52 INFO - PID 1639 | Full stack: 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:56:52 INFO - PID 1639 | 04:56:52 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:56:52 INFO - PID 1639 | Full stack: 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | ************************* 04:56:52 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:56:52 INFO - PID 1639 | 04:56:52 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:56:52 INFO - PID 1639 | Full stack: 04:56:52 INFO - PID 1639 | ************************* 04:58:11 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:58:12 INFO - PID 1639 | RSS: Main: 257507328 04:58:12 INFO - PID 1639 | 05:01:13 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:01:14 INFO - PID 1639 | RSS: Main: 267472896 05:01:14 INFO - PID 1639 | 05:04:16 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:04:16 INFO - PID 1639 | RSS: Main: 260300800 05:04:16 INFO - PID 1639 | 05:07:19 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:07:20 INFO - PID 1639 | RSS: Main: 270589952 05:07:20 INFO - PID 1639 | 05:10:21 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:10:22 INFO - PID 1639 | RSS: Main: 265216000 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | __start_tp_report 05:10:22 INFO - PID 1639 | _x_x_mozilla_page_load 05:10:22 INFO - PID 1639 | _x_x_mozilla_page_load_details 05:10:22 INFO - PID 1639 | |i|pagename|runs| 05:10:22 INFO - PID 1639 | |0;dojo.html;3589.6230895755943;3589.641035896411;3610.9277814443726;3635.1093981974414;3650.3064417760625;6076.656442482733;6110.694465276735;6206.875862482753;6220.595661282014;6228.84427889303;6111.713288451782;6168.105624684418;6168.228971378578;6222.5955312904625;6283.497320214383;5365.302510673607;5388.326459192601;5396.325459317585;5406.459354064582;5422.15956526739;5428.864278393052;5504.504594586487;5555.666660000413;5571.582131340146;5579.246801681762;5308.8141915033175;5420.891582168374;5454.236406903036;5494.917576236339;5511.476409741088;5347.0909945309395;5456.91814622781;5489.752961116719;5528.419515950807;5537.667739935577;5374.48942350476;5419.295491586068;5421.647592906448;5440.700761458118;5444.972775136139;4890.902181956377;6034.426729460738;6217;6222.160008398853;6239.37606239377;5554.777808887639;6387.105805187278;6475.093486911836;6599.4060534551645;6747.987801829716;6818.011388348662;6836.623985680785;6845.212800527953;6855.245922948472;6871.209810871764;6239.625622462667;6374.58565193261;6375.234971803413;6403.583767055126;6403.903941440882;6636.402723754789;6720.630365329954;6995.825104372431;7007.194172670208;7023.8595228095155;6531.934680653133;6613.305602911625;6631.602103873783;6652.301508341651;6674.23246326669;6808.353206445379;6809.148856392951;6824.454043676494;6831.385175334144;6851;6394.808155755335;6654.467642588581;6669.833254168685;6700.1308386108685;6744.42672372844;5369.4630536946;6495.512836537278;6693.732250710014;6729;6756.0879281297375;5342.412334643186;5357.19642053695;5362.490563396471;5380.43505431924;5381.13901775714;4297.871063868089;4706.458757242893;4737.668363214542;4753.786079626425;4764.618830493552;6108.251008765869;6182.1345011698395;6318.368163183645;6353.777617783356;6365.108884756138;6772.288909664513;6800.4219641330055;6818.28408017151;6820.283870193657;6832.043513908056;6351.841203969845;6364.745410183634;6370.904436433457;6380;6381.1704478417505;5696.430356964271;5820.738066787005;5830.912536311958;5836.153757705109;5930.140129681172;6880.830258856006;6948.444124470131;6984.511084224056;7018.473614479037;7055.435565154673;6527.3472652734345;6795.592264464148;6802.489813263926;6816.454683625199;6845.0759147514445;6703.765368212089;6792.01515780219;6936.375726184668;7026.402755765817;7030.543014704028;6436.903446448214;6702.664866756741;6706.798796036127;6721.663916804238;6721.798346049626;6603.108580341785;6680.63256520896;6708.094407255153;6718.193816742022;6788.898166527605;6557.049227861838;6558.770443034471;6568.817612829736;6574.408303252539;6585.80242592723;6531.444827189742;6561.179852518435;6561.639109849004;6561.901571476336;6581.276059633532;5095.821646242363;5568.303962004749;6285.088662144055;6345.7144428499905;6390.520710946605;6538.117354157128;6592.110065141144;6593.703283352164;6596.571222870498;6621.139251897415;4735.526447355237;6296.370362963667;6403.423691867754;6403.935960640334;6419.582727122722 05:10:22 INFO - PID 1639 | |1;ext.html;670.8389986403265;795.2802713544243;826.4297634632103;1057.825458799298;1199.5981346249007;36804;36995.81502092492;37013.25973480529;37146;37186.88439346821;30979.38041239174;37759.81120094396;38171.854844354646;38240;38306.808465957634;7948.403869709751;8093.838123237531;8412.705555305565;8656.220940115389;8671.783205419884;7350.6692198850915;8572.22849943505;8612;8630.568471576396;8670.566471676391;8625.525596092213;8706.564671766419;8707;8714.172153645393;8715.172058654418;8628.309735221168;8651.178138076873;8686.782830429227;8696.608652610585;8699.869501957475;8494.74515764528;8541;8552.786180345542;8567.357448191411;8569.657213711444;37731;37886.24227515434;37978.430323545166;37994.81002594969;38044.23911521754;3585.784852908808;3605.8377373018016;3612.6748592626527;3622.981885090584;3627.3289441453153;30830.22924426885;30880;30926.381472370653;30948;30960.690393096233;2923.72224638659;3161.7470602351755;3172.539981702663;3186.060112266887;3206.1343437271807;240513;246119;277491;291373;294215;47656.7617161912;48086.91261242764;48206.75896620494;48208;48272.51727482751;50473.74763126234;50505.242421363706;50746;50864.982700346525;50940;14304.356303966346;14336.139831609928;14462.783058254134;14467.348969296407;14528.491502797351;11692.356920369291;11711.355875426932;11714.121440891968;11716.589919352782;11721.179517433868;13591.252481113435;13614.387352569158;13615.18308901469;13728;13756.17462952226;5247.895042099137;6057.818265452043;6072.878542429126;6095.420935011167;6096.420840020191;1021.9489025548842;1030.1192480429124;1032.8140934631838;1052.5579256712047;1069.5080263078914;21023.8948805255;23709.170179043995;23713.881430592737;24897;24955.5008899821;1130.350048721988;1132.9660110196708;1167.772284404533;1168.9590864319707;1171.5372427890936;12179.086568507397;12688.619341419771;12743.36283185837;12745.426455809511;12796.2962037087;322291;325234;326454;326511;327034.36482817907;54500;54585.181222281695;54765.90468190614;54836.72581637146;54954;1378.4417310989065;1419.2903548225886;1497.2064805653022;1498.6478177628248;1515.5680631020107;21920.780792191876;22033.669494957267;22401.663975040712;23613.763862361156;24424.389390265387;38448;38544.03639908913;38619.22761544809;38640;38656.22687546177;251656.74171629024;252826;253657;254710.45289547608;255869;33488;34584.65415345915;35016;35084.947451576496;35217.295654087284;43360.566394335656;45330;45478;45550.77224613856;46116.30825537552;22958.42603934848;29811;30017.232963771385;30605.56546096593;31325.373492530478;30428.543571846883;30587.388252235276;31250.531242030935;31354.843225783727;31465.528017079305;37388.626113738515;37419.251614967005;37462.625373747;37485.43771843479;37494.43758343573;29527.114186574436;31142.377152457277;32072.67927320697;32098.037058888272;32214.03357899267;22679.319620411414;24595.754042460063;24731;24794;25212.873935630938 05:10:22 INFO - PID 1639 | |2;jquery.html;424.27237288050986;424.4754904346979;430.33513222071906;442.29454020836766;451.334281934147;19834.504137396572;21550.89224553877;22236.77763222367;22450.88774556127;22477.775222247772;22179.889100554476;23435;23502.29493115205;23632.409189770264;23698.40753981147;4988.42633097193;5626.437356264381;6027.246594175728;6088.634681919088;6332.081848132018;5638.182463542784;6064;6190.81427557174;6234.127222188898;6235.7505699771955;5903.586748927577;5958.731857066442;6120;6194.845128871769;6212.254529456472;6121.326654068049;6160.599561028541;6187.690615469253;6194.070889366586;6199.380061993809;4660.904687398459;5324.440933701944;5461.42655021221;5483.122700367922;5541.085720856054;22423;25526.10658626939;26895.924163033455;27404.177874663794;27710.753016114322;2172.3048624440185;2225.121077174523;2226.8441209115367;2228.019671344603;2232.0625337358347;17732.55668608295;17857.910710446493;18155;18310.542236444064;18598.163082661176;2147.871127732341;2178.6405243134864;2212.7123473948445;2220.544788318391;2225.655023471348;148809;149776.2511187437;150313.97488200918;151406.97186056327;153516.2324188383;12338.198017128858;12845.614631561068;12890.484380624857;12911.806322905164;12945;13956.720865582834;16588.66822663564;16757.41349052777;16825;16836.326546937984;8913.331500137516;9125.81748365029;9151.496667683208;9254.907450925404;9291.814163716688;8680.30557555394;8692.826143477096;8710.47737135774;8856.468611883307;8866.024737278894;7941.061807131283;8031.437799354106;8086.5148091114725;8093.676252949816;8097.825815256755;1885.6134492429019;2146.4097373222176;2183.2140429445385;2198.438818776108;2199.8570092943905;1006.4062203300089;1008.4302369161547;1011.185995273797;1044.9216308776872;1046.2205656785743;20657.58684826325;21976.34070977873;22047.11811527553;22074.896255187177;22334.329970100924;919.5402298850574;1031.4017869635593;1031.7936412717486;1076.983845242322;1091.0725882999545;9236.8614470783;10197.572339872424;11435.371054592077;11470.426478676032;11475.475395412996;478040;526020;532794;548932;557118;110751;123774.14338784925;124533;128051;128639.35680321539;1205.6804946689135;1226.9938650306692;1267.3283159925254;1270.371166272701;1274.7705413025744;22704.432389190402;22945.597975738765;23369.065237390314;23373;23379.298621041395;52842.73578632082;55796.88406231934;56212.71893640506;56702.7164864173;57421;74519;76269.23730762622;77231.22768772465;77959.22040779519;78277;7140.750073747394;8678.218960293603;8693.261072808882;8812.427192232484;8827.735167944971;13902.791458128338;13915.930420347833;13945.58163255104;14246.857531424554;14315.212663303619;10043.548040338057;11753.706157345792;11888.881111189123;11911.523539058688;12086.335251561248;10347.689569312932;11052.171087168334;11085.833712494157;11324.716882078013;11340.94329528347;11850.940745296219;11917.880821191677;12130.272183669009;12184.20802647825;12401.93799030999;8794.692185773467;8943.37396382247;8992.325575581988;9062.50156241413;9082.591283392396;10057.346272492265;11814.232074915102;12100.515979360727;12109.091818113853;12190.146689731633 05:10:22 INFO - PID 1639 | |3;mootools.html;1242.2174030360873;1456.7741999990005;1479.319513024009;1485.8737007354375;1487.9553613391588;11618.535258589647;11794.646160615173;12284.385780710962;12312.630621081371;12420.937895310533;12063.698407539816;12261.570845020426;12293.508259669625;12304.93847530761;12311.199772014812;2531.177367355612;2565.307367010906;2571.0744132112422;2577.1624222127884;2577.9999999999905;2081.6149012432675;2544.096845619806;2545.809064320174;2546.770790628843;2546.961795573068;2490.6139548369943;2512.849229046254;2521.6721826162575;2529.6458495810602;2537.5305568469894;2468.1731619907355;2489.8630575318352;2522.962155567668;2524.2679622909336;2528.380546766045;2413.179518963561;2508.7240403555593;2515.861627610481;2524;2528.835625684343;11994.70013249667;12051.15641905067;12066.638000859988;12071.577494787729;12090.818637720442;6617.702203400859;6855.691493882788;6872.759453419157;6888.483363747689;6895.241523432469;3641.963580364189;3982.8406863725418;4287.892802679927;4363.170997510463;4389.31965545341;1257.2079589858422;1273.8089286607083;1286.4468278640181;1305.073397887501;1310.4561606933207;16316;17005.48983530496;17038.574035649082;17202.655946881117;17204.56988575283;5548.944510554843;5660.943390566042;5702.686352250583;5807.651540907475;5829.941700583025;12104.031677465782;12169.391530423443;12176.634700958986;12180.878191218151;12199.817002744789;6648.069270302161;6656.800295991031;6660.433863121689;6675.065490831287;6689.531732778756;5242.7640756166065;6018.638881667114;6302.590331628429;6308.369163083747;6312.495000399957;4338.370936214231;4436.112777444524;4480.955190448119;4485.955140448619;4494.4606647202545;1280.5838102616688;1302.3097758188176;1302.3423171298434;1315.2043013976597;1317.0451422718645;785.8035491127218;800.8638531449668;809.6032943857467;810.4731924249285;824.7649419915296;6181.96909015452;6225.8132256032395;6345.682715864188;6415.486761059197;6506.642134682638;544.0750723769528;553.6567328256507;570.6119838509853;584.8245526342081;606.5178183344252;3182.8726850925705;3722.962770372316;3840.8271627776257;3877.8254978526033;3886.591907849692;13891.235982021086;14059.507917223053;15238.933274670888;15561.910666253254;15580;11297.943510282395;11696.35670038156;15119.035760534005;15343;15516.534503964898;6441.967790161113;7026.367626913602;8809.647614095493;8852.8672069919;8917.73246802584;6744.494162937897;7229.421646268181;7306.59813710251;7312.41500679955;7375.741849035473;12837.871621283668;13461.798073028716;13605.931970340085;13670.384832682752;13894.235817029756;11437.656870293904;13993.440262389391;14007.229602371968;14089.647758805702;14198.858011419754;7134.286571342825;8452.619632116692;8531.189536993976;8535.274501667427;8557.700480483154;10655.147588193082;10928.01647851697;11004.064654504456;11022.448877556251;11051.613193538187;9359.719208423758;9372.578233979624;9393.966663666855;9554.85667714971;9563.426194428357;9117.270618350649;9176.862347064933;9231.538423078684;9249.583768730557;9251.76870578214;6702.899456508254;8155.306798922158;8177.264046235868;8216;8245.95877020611;6096.847578810565;6133.662648554372;6144.539159562962;6157.26112866441;6174.413430724074;6043.153958445909;6044.607100538451;6186.597871138361;6217.440430361289;6330.556861019869 05:10:22 INFO - PID 1639 | |4;prototype.html;352.2567382822245;387.7867173054819;412.7853516171589;414.8236999275307;415.98336066557323;6007.369226231248;6107.175531303273;6196.473299769519;6339.714712837922;6362.6638405934755;4833.154198015351;6070.5447091468095;6158.753649854;6189.9978510422525;6202.565820392574;4678.90642187156;4690.4605970313505;4698.91924857283;4720.33915251865;4728.952710472903;4662.3239630253765;4706.74112923789;4719.882002949937;4732.7694799352075;4734;4660.557247061523;4661.603763680075;4678.181318269306;4681.765911704419;4691.90616187676;3672.529459660622;4070.2063097695664;4451.176532341495;4636.86089417318;4723.149833030053;4029.9723570489336;4108.281050816125;4162.146759914211;4179.728317659373;4203.348480985452;4379.58393952574;4569.794359253841;4870.707757534559;5136.5890728741615;5258.6581872178185;5428.212909128154;5577.191307260425;5579.832605021856;5589.888202235973;5637.8590535236535;4975.701457912537;5927.199828023248;6529.804105876831;6622.768203112868;6661.867482527982;4670.878989042605;4732.124556956939;4754.215554433515;4761.547652972997;4769.952300476985;5668.546516278688;6836.282190370039;6965.268646792065;7001.344106169442;7005.474589405815;3645.5235629570066;4328.4074218398655;4345.3699213613845;4365.847195348148;4382.8085957021485;4438.134563760101;4445.199864024442;4445.644348452116;4462.933056004163;4465.397171381822;4251.936220956688;4593.494715581283;4596.632269418438;5224.843254702365;5317.8404647860625;5026.969471258383;6614.371634694697;6615.073889655452;6624.7681331154145;6655.667216639149;1387.9306034698225;1496.5510346896106;1514.2655811931204;1515.6438237014293;1520.7262692715196;765.3571000359725;975.7121649113528;979.3829887171179;989.7822479054596;994.269212129099;6196.729670417553;6228.5017198624;6254.343293954069;6261.186045814015;6268.811935641938;5927.992241318986;6720.2943690912725;6743.853544897379;6806.965965170241;6822.761203357958;5498.697571633518;6218.875622487525;6237.407446292595;6237.625742455467;6243.687815609202;3049.3139043714987;3457.27397246576;3555.520004799371;3573.4818451324413;3582.570091588974;5570.972145139248;5890.322612899486;6490.448311893448;6509;7032.753853615099;5693.516051135617;5958;6396.456301214449;6999.405050570656;6999.405050570656;5922.993091174424;6365.331640177715;6864.5881247125335;7007.964960175268;7012.964935175393;5037.596992240685;5304.840854774363;5929.911051334319;5981.371955944737;5985.40145985398;5720.170575266647;6462.321456247027;6625.840477916249;6717.429018533284;6738.528303018742;6467.741290348334;7005.264447233171;7021.929780702128;7057.70671996003;7095.148582170173;3616.764910280823;4165.4584903962295;4302.182585308781;4304.504981927118;4342.261815491311;6290.370962903856;6756.358145976124;6815.217554257435;6837.35045170708;6887.380135787803;5969.76120955157;6323.841903952438;6483.546151769331;6548.624788794406;6561.507886908596;5341.359036915595;5999.610025348338;6089.817305480843;6509.544331896911;6509.730602532461;5471.562275018068;6188.2883468399905;6276.089966954857;6401.487880969605;6426.485881129592;5626.043572592751;6605.438537724347;6619.106420633153;6625.768098116543;6662.700178492077;5886.676232807236;6351.237851457855;6491.610503369813;6492.513061520311;6527.5757075789925 05:10:22 INFO - PID 1639 | |5;yui.html;800.2477670989272;813.8494378539971;836.8159005018902;846.4582667093058;869.6521391443422;14716.484923027696;16309.102999335031;16823.49529514115;16853.747193792104;19230.807691923077;17581.03304318265;18016.369427070054;18154.818451815478;18161.364352247674;18211.90894045528;1002.9097381235688;1028.239103063735;1029.958801647937;1033.0237925160727;1033.3438266700662;829.340674164041;979.9510024498783;1023.718477418712;1025.3027941000116;1029.1766586730623;1065.4140222877425;1070.459417993912;1071.437495314962;1074.1031238915475;1074.785042991401;868.6785889220997;1062.3572738493178;1067.738404090995;1069.395791377869;1071.2501249125605;747.178104085507;768.0092680442223;791.711025475703;793.2543409195396;795.4153697032676;15332.00341977779;15594.29825657848;16716.74924876128;16733.247003884855;16856.74714879278;16413;16557.42049028278;16970.236339364757;17062.658746825116;17213.655726885518;11185.384803835786;13904.235267060307;13986.230757308344;14005;14005.719885602333;3359.731221502274;3541.3979623463815;3541.628129046439;3543.6102028776813;3557.5908770491465;73520;115067.42466287699;120303;120723;126765;13476.797848032287;13640.52258170979;13686.905047596367;13728;13742.519011834538;24576;24904.875475622506;25632;26058.478830423286;26221.737782622313;7788.766337009899;7852.685892564347;7926.8810967835525;7989.560574168477;7990.280874721187;3937.6062393760394;4008.0581063450068;4009.1781184857036;4015.457913181683;4018.457508236351;4264.573542645772;4321.956780432219;4358.193734159191;4370.2570563004365;4384.69307148503;937.4141161773891;954.2032402943481;956.5026186383042;963.6579014449909;964.2189826240767;624.2446639566176;650.1223348479515;674.7604600366799;675.2302375292072;692.0449779304628;10799.244052916221;11282.605108821152;11519.712007199887;12089;12194.756104877853;657.9473642108716;660.4815220052332;664.0603545982477;664.1830548425464;684.7192651013061;5307.203919412042;5314.830737237801;5443.918341224885;5467.480589344006;5522.9447705523235;89272;100556.99443005622;103839.4808025955;104602.95397045932;104909;91750;98096.50951745195;98255.50872245592;98280.50859745656;99323.50338248262;57478;83090.58454707688;85144;86109.56945215359;86154.99999999875;10551.525181367011;10715.624953126604;10759.784804304027;11043.834342484708;11085.556577736801;32814;33510.832445837616;43251.70244892658;43322.566774331855;43836.780816095714;42749;57293.71353143374;57384.71307643435;57690;58168.709156453944;14242.857571424567;14413.279336033365;14420.206888621227;16539.586510337336;17395.04327262013;15932.096636324175;18484.722729158806;18796;18806.717899231797;18949.90525047366;15374.923125384748;16532;16843.41048063312;17250.56607168738;17499.912500437415;16774.49676509707;17112;17135.971841689538;17154.82845171582;17475.56311092182;16121.516354509384;16137;16813.91593042076;17209.827901721324;17318;11527.365994870363;11930.582429614922;12251;12266.693332666755;12569.748605027666;13379.264140472367;14013.019088663696;14024.368903399167;14046.297685115907;14117.717645646824 05:10:22 INFO - PID 1639 | __end_tp_report 05:10:22 INFO - PID 1639 | __start_cc_report 05:10:22 INFO - PID 1639 | _x_x_mozilla_cycle_collect,436 05:10:22 INFO - PID 1639 | __end_cc_report 05:10:22 INFO - PID 1639 | __startTimestamp1493295022221__endTimestamp 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | ------- Summary: start ------- 05:10:22 INFO - PID 1639 | Number of tests: 6 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6153.05 Median:6390.52 stddev:757.70 (11.9%) stddev-sans-first:732.85 05:10:22 INFO - PID 1639 | Values: 3589.6 3589.6 3610.9 3635.1 3650.3 6076.7 6110.7 6206.9 6220.6 6228.8 6111.7 6168.1 6168.2 6222.6 6283.5 5365.3 5388.3 5396.3 5406.5 5422.2 5428.9 5504.5 5555.7 5571.6 5579.2 5308.8 5420.9 5454.2 5494.9 5511.5 5347.1 5456.9 5489.8 5528.4 5537.7 5374.5 5419.3 5421.6 5440.7 5445.0 4890.9 6034.4 6217.0 6222.2 6239.4 5554.8 6387.1 6475.1 6599.4 6748.0 6818.0 6836.6 6845.2 6855.2 6871.2 6239.6 6374.6 6375.2 6403.6 6403.9 6636.4 6720.6 6995.8 7007.2 7023.9 6531.9 6613.3 6631.6 6652.3 6674.2 6808.4 6809.1 6824.5 6831.4 6851.0 6394.8 6654.5 6669.8 6700.1 6744.4 5369.5 6495.5 6693.7 6729.0 6756.1 5342.4 5357.2 5362.5 5380.4 5381.1 4297.9 4706.5 4737.7 4753.8 4764.6 6108.3 6182.1 6318.4 6353.8 6365.1 6772.3 6800.4 6818.3 6820.3 6832.0 6351.8 6364.7 6370.9 6380.0 6381.2 5696.4 5820.7 5830.9 5836.2 5930.1 6880.8 6948.4 6984.5 7018.5 7055.4 6527.3 6795.6 6802.5 6816.5 6845.1 6703.8 6792.0 6936.4 7026.4 7030.5 6436.9 6702.7 6706.8 6721.7 6721.8 6603.1 6680.6 6708.1 6718.2 6788.9 6557.0 6558.8 6568.8 6574.4 6585.8 6531.4 6561.2 6561.6 6561.9 6581.3 5095.8 5568.3 6285.1 6345.7 6390.5 6538.1 6592.1 6593.7 6596.6 6621.1 4735.5 6296.4 6403.4 6403.9 6419.6 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43770.51 Median:326482.50 stddev:74646.53 (22.9%) stddev-sans-first:74785.79 05:10:22 INFO - PID 1639 | Values: 670.8 795.3 826.4 1057.8 1199.6 36804.0 36995.8 37013.3 37146.0 37186.9 30979.4 37759.8 38171.9 38240.0 38306.8 7948.4 8093.8 8412.7 8656.2 8671.8 7350.7 8572.2 8612.0 8630.6 8670.6 8625.5 8706.6 8707.0 8714.2 8715.2 8628.3 8651.2 8686.8 8696.6 8699.9 8494.7 8541.0 8552.8 8567.4 8569.7 37731.0 37886.2 37978.4 37994.8 38044.2 3585.8 3605.8 3612.7 3623.0 3627.3 30830.2 30880.0 30926.4 30948.0 30960.7 2923.7 3161.7 3172.5 3186.1 3206.1 240513.0 246119.0 277491.0 291373.0 294215.0 47656.8 48086.9 48206.8 48208.0 48272.5 50473.7 50505.2 50746.0 50865.0 50940.0 14304.4 14336.1 14462.8 14467.3 14528.5 11692.4 11711.4 11714.1 11716.6 11721.2 13591.3 13614.4 13615.2 13728.0 13756.2 5247.9 6057.8 6072.9 6095.4 6096.4 1021.9 1030.1 1032.8 1052.6 1069.5 21023.9 23709.2 23713.9 24897.0 24955.5 1130.4 1133.0 1167.8 1169.0 1171.5 12179.1 12688.6 12743.4 12745.4 12796.3 322291.0 325234.0 326454.0 326511.0 327034.4 54500.0 54585.2 54765.9 54836.7 54954.0 1378.4 1419.3 1497.2 1498.6 1515.6 21920.8 22033.7 22401.7 23613.8 24424.4 38448.0 38544.0 38619.2 38640.0 38656.2 251656.7 252826.0 253657.0 254710.5 255869.0 33488.0 34584.7 35016.0 35084.9 35217.3 43360.6 45330.0 45478.0 45550.8 46116.3 22958.4 29811.0 30017.2 30605.6 31325.4 30428.5 30587.4 31250.5 31354.8 31465.5 37388.6 37419.3 37462.6 37485.4 37494.4 29527.1 31142.4 32072.7 32098.0 32214.0 22679.3 24595.8 24731.0 24794.0 25212.9 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:34789.73 Median:12283.20 stddev:89760.16 (730.8%) stddev-sans-first:89974.87 05:10:22 INFO - PID 1639 | Values: 424.3 424.5 430.3 442.3 451.3 19834.5 21550.9 22236.8 22450.9 22477.8 22179.9 23435.0 23502.3 23632.4 23698.4 4988.4 5626.4 6027.2 6088.6 6332.1 5638.2 6064.0 6190.8 6234.1 6235.8 5903.6 5958.7 6120.0 6194.8 6212.3 6121.3 6160.6 6187.7 6194.1 6199.4 4660.9 5324.4 5461.4 5483.1 5541.1 22423.0 25526.1 26895.9 27404.2 27710.8 2172.3 2225.1 2226.8 2228.0 2232.1 17732.6 17857.9 18155.0 18310.5 18598.2 2147.9 2178.6 2212.7 2220.5 2225.7 148809.0 149776.3 150314.0 151407.0 153516.2 12338.2 12845.6 12890.5 12911.8 12945.0 13956.7 16588.7 16757.4 16825.0 16836.3 8913.3 9125.8 9151.5 9254.9 9291.8 8680.3 8692.8 8710.5 8856.5 8866.0 7941.1 8031.4 8086.5 8093.7 8097.8 1885.6 2146.4 2183.2 2198.4 2199.9 1006.4 1008.4 1011.2 1044.9 1046.2 20657.6 21976.3 22047.1 22074.9 22334.3 919.5 1031.4 1031.8 1077.0 1091.1 9236.9 10197.6 11435.4 11470.4 11475.5 478040.0 526020.0 532794.0 548932.0 557118.0 110751.0 123774.1 124533.0 128051.0 128639.4 1205.7 1227.0 1267.3 1270.4 1274.8 22704.4 22945.6 23369.1 23373.0 23379.3 52842.7 55796.9 56212.7 56702.7 57421.0 74519.0 76269.2 77231.2 77959.2 78277.0 7140.8 8678.2 8693.3 8812.4 8827.7 13902.8 13915.9 13945.6 14246.9 14315.2 10043.5 11753.7 11888.9 11911.5 12086.3 10347.7 11052.2 11085.8 11324.7 11340.9 11850.9 11917.9 12130.3 12184.2 12401.9 8794.7 8943.4 8992.3 9062.5 9082.6 10057.3 11814.2 12100.5 12109.1 12190.1 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7117.83 Median:3412.42 stddev:4551.89 (133.4%) stddev-sans-first:4543.25 05:10:22 INFO - PID 1639 | Values: 1242.2 1456.8 1479.3 1485.9 1488.0 11618.5 11794.6 12284.4 12312.6 12420.9 12063.7 12261.6 12293.5 12304.9 12311.2 2531.2 2565.3 2571.1 2577.2 2578.0 2081.6 2544.1 2545.8 2546.8 2547.0 2490.6 2512.8 2521.7 2529.6 2537.5 2468.2 2489.9 2523.0 2524.3 2528.4 2413.2 2508.7 2515.9 2524.0 2528.8 11994.7 12051.2 12066.6 12071.6 12090.8 6617.7 6855.7 6872.8 6888.5 6895.2 3642.0 3982.8 4287.9 4363.2 4389.3 1257.2 1273.8 1286.4 1305.1 1310.5 16316.0 17005.5 17038.6 17202.7 17204.6 5548.9 5660.9 5702.7 5807.7 5829.9 12104.0 12169.4 12176.6 12180.9 12199.8 6648.1 6656.8 6660.4 6675.1 6689.5 5242.8 6018.6 6302.6 6308.4 6312.5 4338.4 4436.1 4481.0 4486.0 4494.5 1280.6 1302.3 1302.3 1315.2 1317.0 785.8 800.9 809.6 810.5 824.8 6182.0 6225.8 6345.7 6415.5 6506.6 544.1 553.7 570.6 584.8 606.5 3182.9 3723.0 3840.8 3877.8 3886.6 13891.2 14059.5 15238.9 15561.9 15580.0 11297.9 11696.4 15119.0 15343.0 15516.5 6442.0 7026.4 8809.6 8852.9 8917.7 6744.5 7229.4 7306.6 7312.4 7375.7 12837.9 13461.8 13605.9 13670.4 13894.2 11437.7 13993.4 14007.2 14089.6 14198.9 7134.3 8452.6 8531.2 8535.3 8557.7 10655.1 10928.0 11004.1 11022.4 11051.6 9359.7 9372.6 9394.0 9554.9 9563.4 9117.3 9176.9 9231.5 9249.6 9251.8 6702.9 8155.3 8177.3 8216.0 8246.0 6096.8 6133.7 6144.5 6157.3 6174.4 6043.2 6044.6 6186.6 6217.4 6330.6 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5228.30 Median:5925.10 stddev:1632.00 (27.5%) stddev-sans-first:1595.01 05:10:22 INFO - PID 1639 | Values: 352.3 387.8 412.8 414.8 416.0 6007.4 6107.2 6196.5 6339.7 6362.7 4833.2 6070.5 6158.8 6190.0 6202.6 4678.9 4690.5 4698.9 4720.3 4729.0 4662.3 4706.7 4719.9 4732.8 4734.0 4660.6 4661.6 4678.2 4681.8 4691.9 3672.5 4070.2 4451.2 4636.9 4723.1 4030.0 4108.3 4162.1 4179.7 4203.3 4379.6 4569.8 4870.7 5136.6 5258.7 5428.2 5577.2 5579.8 5589.9 5637.9 4975.7 5927.2 6529.8 6622.8 6661.9 4670.9 4732.1 4754.2 4761.5 4770.0 5668.5 6836.3 6965.3 7001.3 7005.5 3645.5 4328.4 4345.4 4365.8 4382.8 4438.1 4445.2 4445.6 4462.9 4465.4 4251.9 4593.5 4596.6 5224.8 5317.8 5027.0 6614.4 6615.1 6624.8 6655.7 1387.9 1496.6 1514.3 1515.6 1520.7 765.4 975.7 979.4 989.8 994.3 6196.7 6228.5 6254.3 6261.2 6268.8 5928.0 6720.3 6743.9 6807.0 6822.8 5498.7 6218.9 6237.4 6237.6 6243.7 3049.3 3457.3 3555.5 3573.5 3582.6 5571.0 5890.3 6490.4 6509.0 7032.8 5693.5 5958.0 6396.5 6999.4 6999.4 5923.0 6365.3 6864.6 7008.0 7013.0 5037.6 5304.8 5929.9 5981.4 5985.4 5720.2 6462.3 6625.8 6717.4 6738.5 6467.7 7005.3 7021.9 7057.7 7095.1 3616.8 4165.5 4302.2 4304.5 4342.3 6290.4 6756.4 6815.2 6837.4 6887.4 5969.8 6323.8 6483.5 6548.6 6561.5 5341.4 5999.6 6089.8 6509.5 6509.7 5471.6 6188.3 6276.1 6401.5 6426.5 5626.0 6605.4 6619.1 6625.8 6662.7 5886.7 6351.2 6491.6 6492.5 6527.6 05:10:22 INFO - PID 1639 | 05:10:22 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21357.02 Median:17798.70 stddev:29583.08 (166.2%) stddev-sans-first:29625.80 05:10:22 INFO - PID 1639 | Values: 800.2 813.8 836.8 846.5 869.7 14716.5 16309.1 16823.5 16853.7 19230.8 17581.0 18016.4 18154.8 18161.4 18211.9 1002.9 1028.2 1030.0 1033.0 1033.3 829.3 980.0 1023.7 1025.3 1029.2 1065.4 1070.5 1071.4 1074.1 1074.8 868.7 1062.4 1067.7 1069.4 1071.3 747.2 768.0 791.7 793.3 795.4 15332.0 15594.3 16716.7 16733.2 16856.7 16413.0 16557.4 16970.2 17062.7 17213.7 11185.4 13904.2 13986.2 14005.0 14005.7 3359.7 3541.4 3541.6 3543.6 3557.6 73520.0 115067.4 120303.0 120723.0 126765.0 13476.8 13640.5 13686.9 13728.0 13742.5 24576.0 24904.9 25632.0 26058.5 26221.7 7788.8 7852.7 7926.9 7989.6 7990.3 3937.6 4008.1 4009.2 4015.5 4018.5 4264.6 4322.0 4358.2 4370.3 4384.7 937.4 954.2 956.5 963.7 964.2 624.2 650.1 674.8 675.2 692.0 10799.2 11282.6 11519.7 12089.0 12194.8 657.9 660.5 664.1 664.2 684.7 5307.2 5314.8 5443.9 5467.5 5522.9 89272.0 100557.0 103839.5 104603.0 104909.0 91750.0 98096.5 98255.5 98280.5 99323.5 57478.0 83090.6 85144.0 86109.6 86155.0 10551.5 10715.6 10759.8 11043.8 11085.6 32814.0 33510.8 43251.7 43322.6 43836.8 42749.0 57293.7 57384.7 57690.0 58168.7 14242.9 14413.3 14420.2 16539.6 17395.0 15932.1 18484.7 18796.0 18806.7 18949.9 15374.9 16532.0 16843.4 17250.6 17499.9 16774.5 17112.0 17136.0 17154.8 17475.6 16121.5 16137.0 16813.9 17209.8 17318.0 11527.4 11930.6 12251.0 12266.7 12569.7 13379.3 14013.0 14024.4 14046.3 14117.7 05:10:22 INFO - PID 1639 | -------- Summary: end -------- 05:10:22 INFO - PID 1639 | 05:10:22 INFO - TEST-INFO | 1639: exit 0 05:10:22 INFO - TEST-OK | dromaeo_css | took 1115032ms 05:10:22 INFO - TEST-START | kraken 05:10:22 INFO - operating with platform_type : mac_ 05:10:22 INFO - Initialising browser for kraken test... 05:10:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpMcLS0_/profile http://localhost:49241/getInfo.html) 05:10:25 INFO - PID 1651 | 2017-04-27 05:10:25.746 plugin-container[1653:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x964f, name = 'com.apple.tsm.portname' 05:10:25 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:10:25 INFO - PID 1651 | 2017-04-27 05:10:25.747 plugin-container[1653:10047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 05:10:25 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:10:25 INFO - PID 1651 | 2017-04-27 05:10:25.747 plugin-container[1653:10047] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:10:25 INFO - PID 1651 | __metrics Screen width/height:1600/1200 05:10:25 INFO - PID 1651 | colorDepth:24 05:10:25 INFO - PID 1651 | Browser inner width/height: 1024/689 05:10:25 INFO - PID 1651 | __metrics 05:10:25 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 05:10:26 INFO - TEST-INFO | 1651: exit 0 05:10:26 INFO - Browser initialized. 05:10:26 INFO - Running cycle 1/1 for kraken test... 05:10:26 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpMcLS0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:29 INFO - PID 1654 | 2017-04-27 05:10:29.228 plugin-container[1655:10178] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 05:10:29 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:10:29 INFO - PID 1654 | 2017-04-27 05:10:29.229 plugin-container[1655:10178] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9723, name = 'com.apple.CFPasteboardClient' 05:10:29 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:10:29 INFO - PID 1654 | 2017-04-27 05:10:29.229 plugin-container[1655:10178] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:10:38 INFO - PID 1654 | RSS: Main: 236359680 05:10:38 INFO - PID 1654 | 05:10:41 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:42 INFO - PID 1654 | RSS: Main: 248913920 05:10:42 INFO - PID 1654 | 05:10:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:10:45 INFO - PID 1654 | RSS: Main: 257060864 05:10:45 INFO - PID 1654 | 05:10:49 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:10:49 INFO - PID 1654 | RSS: Main: 259407872 05:10:49 INFO - PID 1654 | 05:10:51 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:10:52 INFO - PID 1654 | RSS: Main: 261660672 05:10:52 INFO - PID 1654 | 05:10:54 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:55 INFO - PID 1654 | RSS: Main: 262201344 05:10:55 INFO - PID 1654 | 05:10:57 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:58 INFO - PID 1654 | RSS: Main: 268115968 05:10:58 INFO - PID 1654 | 05:11:01 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:11:02 INFO - PID 1654 | RSS: Main: 269381632 05:11:02 INFO - PID 1654 | 05:11:04 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:11:05 INFO - PID 1654 | RSS: Main: 268939264 05:11:05 INFO - PID 1654 | 05:11:07 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:11:07 INFO - PID 1654 | RSS: Main: 268214272 05:11:07 INFO - PID 1654 | 05:11:09 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:11:10 INFO - PID 1654 | RSS: Main: 267968512 05:11:10 INFO - PID 1654 | 05:11:12 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:11:12 INFO - PID 1654 | RSS: Main: 267722752 05:11:12 INFO - PID 1654 | 05:11:15 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:16 INFO - PID 1654 | RSS: Main: 267862016 05:11:16 INFO - PID 1654 | 05:11:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:20 INFO - PID 1654 | RSS: Main: 268079104 05:11:20 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:11:22 INFO - PID 1654 | RSS: Main: 269967360 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | __start_tp_report 05:11:22 INFO - PID 1654 | _x_x_mozilla_page_load 05:11:22 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:11:22 INFO - PID 1654 | |i|pagename|runs| 05:11:22 INFO - PID 1654 | |0;ai-astar;102;117;120;114;116;115;115;113;129;170 05:11:22 INFO - PID 1654 | |1;audio-beat-detection;130;110;113;150;109;109;107;115;160;143 05:11:22 INFO - PID 1654 | |2;audio-dft;200;200;198;216;216;222;198;199;201;198 05:11:22 INFO - PID 1654 | |3;audio-fft;80;57;69;110;86;91;63;58;73;60 05:11:22 INFO - PID 1654 | |4;audio-oscillator;79;69;85;107;103;104;92;74;71;87 05:11:22 INFO - PID 1654 | |5;imaging-gaussian-blur;90;90;89;89;89;89;90;101;106;101 05:11:22 INFO - PID 1654 | |6;imaging-darkroom;103;96;96;96;97;95;97;97;105;97 05:11:22 INFO - PID 1654 | |7;imaging-desaturate;92;93;90;92;92;92;88;92;88;91 05:11:22 INFO - PID 1654 | |8;json-parse-financial;51;50;49;50;51;51;50;49;48;57 05:11:22 INFO - PID 1654 | |9;json-stringify-tinderbox;60;63;56;68;65;58;55;58;54;56 05:11:22 INFO - PID 1654 | |10;stanford-crypto-aes;82;83;83;82;84;83;84;82;85;82 05:11:22 INFO - PID 1654 | |11;stanford-crypto-ccm;140;153;117;145;135;164;152;159;185;163 05:11:22 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;187;186;179;183;250;243;171;229;184;185 05:11:22 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;70;67;70;73;92;62;78;97;100;100 05:11:22 INFO - PID 1654 | __end_tp_report 05:11:22 INFO - PID 1654 | __start_cc_report 05:11:22 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1012 05:11:22 INFO - PID 1654 | __end_cc_report 05:11:22 INFO - PID 1654 | __startTimestamp1493295082464__endTimestamp 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | ------- Summary: start ------- 05:11:22 INFO - PID 1654 | Number of tests: 14 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:121.10 Median:116.50 stddev:18.42 (15.8%) stddev-sans-first:18.19 05:11:22 INFO - PID 1654 | Values: 102.0 117.0 120.0 114.0 116.0 115.0 115.0 113.0 129.0 170.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:122.50 stddev:19.73 (16.1%) stddev-sans-first:20.83 05:11:22 INFO - PID 1654 | Values: 130.0 110.0 113.0 150.0 109.0 109.0 107.0 115.0 160.0 143.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:204.80 Median:200.50 stddev:9.31 (4.6%) stddev-sans-first:9.71 05:11:22 INFO - PID 1654 | Values: 200.0 200.0 198.0 216.0 216.0 222.0 198.0 199.0 201.0 198.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:74.70 Median:71.00 stddev:17.15 (24.2%) stddev-sans-first:18.09 05:11:22 INFO - PID 1654 | Values: 80.0 57.0 69.0 110.0 86.0 91.0 63.0 58.0 73.0 60.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:76.50 stddev:14.09 (18.4%) stddev-sans-first:14.64 05:11:22 INFO - PID 1654 | Values: 79.0 69.0 85.0 107.0 103.0 104.0 92.0 74.0 71.0 87.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:89.00 stddev:6.55 (7.4%) stddev-sans-first:6.83 05:11:22 INFO - PID 1654 | Values: 90.0 90.0 89.0 89.0 89.0 89.0 90.0 101.0 106.0 101.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:96.50 stddev:3.31 (3.4%) stddev-sans-first:2.96 05:11:22 INFO - PID 1654 | Values: 103.0 96.0 96.0 96.0 97.0 95.0 97.0 97.0 105.0 97.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:92.00 stddev:1.76 (1.9%) stddev-sans-first:1.83 05:11:22 INFO - PID 1654 | Values: 92.0 93.0 90.0 92.0 92.0 92.0 88.0 92.0 88.0 91.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:2.46 (4.9%) stddev-sans-first:2.60 05:11:22 INFO - PID 1654 | Values: 51.0 50.0 49.0 50.0 51.0 51.0 50.0 49.0 48.0 57.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:4.64 (7.9%) stddev-sans-first:4.92 05:11:22 INFO - PID 1654 | Values: 60.0 63.0 56.0 68.0 65.0 58.0 55.0 58.0 54.0 56.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 05:11:22 INFO - PID 1654 | Values: 82.0 83.0 83.0 82.0 84.0 83.0 84.0 82.0 85.0 82.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:156.00 stddev:18.58 (11.9%) stddev-sans-first:19.25 05:11:22 INFO - PID 1654 | Values: 140.0 153.0 117.0 145.0 135.0 164.0 152.0 159.0 185.0 163.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.70 Median:186.50 stddev:29.07 (15.6%) stddev-sans-first:30.47 05:11:22 INFO - PID 1654 | Values: 187.0 186.0 179.0 183.0 250.0 243.0 171.0 229.0 184.0 185.0 05:11:22 INFO - PID 1654 | 05:11:22 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.90 Median:71.50 stddev:14.80 (20.7%) stddev-sans-first:15.16 05:11:22 INFO - PID 1654 | Values: 70.0 67.0 70.0 73.0 92.0 62.0 78.0 97.0 100.0 100.0 05:11:22 INFO - PID 1654 | -------- Summary: end -------- 05:11:22 INFO - PID 1654 | 05:11:23 INFO - TEST-INFO | 1654: exit 0 05:11:23 INFO - TEST-OK | kraken | took 60821ms 05:11:23 INFO - SUITE-END | took 1175s 05:11:24 INFO - Completed test suite (00:19:36) 05:11:24 INFO - javascript benchmark 05:11:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7858.817095721198, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3589.6230895755943, 3589.641035896411, 3610.9277814443726, 3635.1093981974414, 3650.3064417760625, 6076.656442482733, 6110.694465276735, 6206.875862482753, 6220.595661282014, 6228.84427889303, 6111.713288451782, 6168.105624684418, 6168.228971378578, 6222.5955312904625, 6283.497320214383, 5365.302510673607, 5388.326459192601, 5396.325459317585, 5406.459354064582, 5422.15956526739, 5428.864278393052, 5504.504594586487, 5555.666660000413, 5571.582131340146, 5579.246801681762, 5308.8141915033175, 5420.891582168374, 5454.236406903036, 5494.917576236339, 5511.476409741088, 5347.0909945309395, 5456.91814622781, 5489.752961116719, 5528.419515950807, 5537.667739935577, 5374.48942350476, 5419.295491586068, 5421.647592906448, 5440.700761458118, 5444.972775136139, 4890.902181956377, 6034.426729460738, 6217.0, 6222.160008398853, 6239.37606239377, 5554.777808887639, 6387.105805187278, 6475.093486911836, 6599.4060534551645, 6747.987801829716, 6818.011388348662, 6836.623985680785, 6845.212800527953, 6855.245922948472, 6871.209810871764, 6239.625622462667, 6374.58565193261, 6375.234971803413, 6403.583767055126, 6403.903941440882, 6636.402723754789, 6720.630365329954, 6995.825104372431, 7007.194172670208, 7023.8595228095155, 6531.934680653133, 6613.305602911625, 6631.602103873783, 6652.301508341651, 6674.23246326669, 6808.353206445379, 6809.148856392951, 6824.454043676494, 6831.385175334144, 6851.0, 6394.808155755335, 6654.467642588581, 6669.833254168685, 6700.1308386108685, 6744.42672372844, 5369.4630536946, 6495.512836537278, 6693.732250710014, 6729.0, 6756.0879281297375, 5342.412334643186, 5357.19642053695, 5362.490563396471, 5380.43505431924, 5381.13901775714, 4297.871063868089, 4706.458757242893, 4737.668363214542, 4753.786079626425, 4764.618830493552, 6108.251008765869, 6182.1345011698395, 6318.368163183645, 6353.777617783356, 6365.108884756138, 6772.288909664513, 6800.4219641330055, 6818.28408017151, 6820.283870193657, 6832.043513908056, 6351.841203969845, 6364.745410183634, 6370.904436433457, 6380.0, 6381.1704478417505, 5696.430356964271, 5820.738066787005, 5830.912536311958, 5836.153757705109, 5930.140129681172, 6880.830258856006, 6948.444124470131, 6984.511084224056, 7018.473614479037, 7055.435565154673, 6527.3472652734345, 6795.592264464148, 6802.489813263926, 6816.454683625199, 6845.0759147514445, 6703.765368212089, 6792.01515780219, 6936.375726184668, 7026.402755765817, 7030.543014704028, 6436.903446448214, 6702.664866756741, 6706.798796036127, 6721.663916804238, 6721.798346049626, 6603.108580341785, 6680.63256520896, 6708.094407255153, 6718.193816742022, 6788.898166527605, 6557.049227861838, 6558.770443034471, 6568.817612829736, 6574.408303252539, 6585.80242592723, 6531.444827189742, 6561.179852518435, 6561.639109849004, 6561.901571476336, 6581.276059633532, 5095.821646242363, 5568.303962004749, 6285.088662144055, 6345.7144428499905, 6390.520710946605, 6538.117354157128, 6592.110065141144, 6593.703283352164, 6596.571222870498, 6621.139251897415, 4735.526447355237, 6296.370362963667, 6403.423691867754, 6403.935960640334, 6419.582727122722], "value": 6103.4469351954285, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.8389986403265, 795.2802713544243, 826.4297634632103, 1057.825458799298, 1199.5981346249007, 36804.0, 36995.81502092492, 37013.25973480529, 37146.0, 37186.88439346821, 30979.38041239174, 37759.81120094396, 38171.854844354646, 38240.0, 38306.808465957634, 7948.403869709751, 8093.838123237531, 8412.705555305565, 8656.220940115389, 8671.783205419884, 7350.6692198850915, 8572.22849943505, 8612.0, 8630.568471576396, 8670.566471676391, 8625.525596092213, 8706.564671766419, 8707.0, 8714.172153645393, 8715.172058654418, 8628.309735221168, 8651.178138076873, 8686.782830429227, 8696.608652610585, 8699.869501957475, 8494.74515764528, 8541.0, 8552.786180345542, 8567.357448191411, 8569.657213711444, 37731.0, 37886.24227515434, 37978.430323545166, 37994.81002594969, 38044.23911521754, 3585.784852908808, 3605.8377373018016, 3612.6748592626527, 3622.981885090584, 3627.3289441453153, 30830.22924426885, 30880.0, 30926.381472370653, 30948.0, 30960.690393096233, 2923.72224638659, 3161.7470602351755, 3172.539981702663, 3186.060112266887, 3206.1343437271807, 240513.0, 246119.0, 277491.0, 291373.0, 294215.0, 47656.7617161912, 48086.91261242764, 48206.75896620494, 48208.0, 48272.51727482751, 50473.74763126234, 50505.242421363706, 50746.0, 50864.982700346525, 50940.0, 14304.356303966346, 14336.139831609928, 14462.783058254134, 14467.348969296407, 14528.491502797351, 11692.356920369291, 11711.355875426932, 11714.121440891968, 11716.589919352782, 11721.179517433868, 13591.252481113435, 13614.387352569158, 13615.18308901469, 13728.0, 13756.17462952226, 5247.895042099137, 6057.818265452043, 6072.878542429126, 6095.420935011167, 6096.420840020191, 1021.9489025548842, 1030.1192480429124, 1032.8140934631838, 1052.5579256712047, 1069.5080263078914, 21023.8948805255, 23709.170179043995, 23713.881430592737, 24897.0, 24955.5008899821, 1130.350048721988, 1132.9660110196708, 1167.772284404533, 1168.9590864319707, 1171.5372427890936, 12179.086568507397, 12688.619341419771, 12743.36283185837, 12745.426455809511, 12796.2962037087, 322291.0, 325234.0, 326454.0, 326511.0, 327034.36482817907, 54500.0, 54585.181222281695, 54765.90468190614, 54836.72581637146, 54954.0, 1378.4417310989065, 1419.2903548225886, 1497.2064805653022, 1498.6478177628248, 1515.5680631020107, 21920.780792191876, 22033.669494957267, 22401.663975040712, 23613.763862361156, 24424.389390265387, 38448.0, 38544.03639908913, 38619.22761544809, 38640.0, 38656.22687546177, 251656.74171629024, 252826.0, 253657.0, 254710.45289547608, 255869.0, 33488.0, 34584.65415345915, 35016.0, 35084.947451576496, 35217.295654087284, 43360.566394335656, 45330.0, 45478.0, 45550.77224613856, 46116.30825537552, 22958.42603934848, 29811.0, 30017.232963771385, 30605.56546096593, 31325.373492530478, 30428.543571846883, 30587.388252235276, 31250.531242030935, 31354.843225783727, 31465.528017079305, 37388.626113738515, 37419.251614967005, 37462.625373747, 37485.43771843479, 37494.43758343573, 29527.114186574436, 31142.377152457277, 32072.67927320697, 32098.037058888272, 32214.03357899267, 22679.319620411414, 24595.754042460063, 24731.0, 24794.0, 25212.873935630938], "value": 17500.903784978414, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.27237288050986, 424.4754904346979, 430.33513222071906, 442.29454020836766, 451.334281934147, 19834.504137396572, 21550.89224553877, 22236.77763222367, 22450.88774556127, 22477.775222247772, 22179.889100554476, 23435.0, 23502.29493115205, 23632.409189770264, 23698.40753981147, 4988.42633097193, 5626.437356264381, 6027.246594175728, 6088.634681919088, 6332.081848132018, 5638.182463542784, 6064.0, 6190.81427557174, 6234.127222188898, 6235.7505699771955, 5903.586748927577, 5958.731857066442, 6120.0, 6194.845128871769, 6212.254529456472, 6121.326654068049, 6160.599561028541, 6187.690615469253, 6194.070889366586, 6199.380061993809, 4660.904687398459, 5324.440933701944, 5461.42655021221, 5483.122700367922, 5541.085720856054, 22423.0, 25526.10658626939, 26895.924163033455, 27404.177874663794, 27710.753016114322, 2172.3048624440185, 2225.121077174523, 2226.8441209115367, 2228.019671344603, 2232.0625337358347, 17732.55668608295, 17857.910710446493, 18155.0, 18310.542236444064, 18598.163082661176, 2147.871127732341, 2178.6405243134864, 2212.7123473948445, 2220.544788318391, 2225.655023471348, 148809.0, 149776.2511187437, 150313.97488200918, 151406.97186056327, 153516.2324188383, 12338.198017128858, 12845.614631561068, 12890.484380624857, 12911.806322905164, 12945.0, 13956.720865582834, 16588.66822663564, 16757.41349052777, 16825.0, 16836.326546937984, 8913.331500137516, 9125.81748365029, 9151.496667683208, 9254.907450925404, 9291.814163716688, 8680.30557555394, 8692.826143477096, 8710.47737135774, 8856.468611883307, 8866.024737278894, 7941.061807131283, 8031.437799354106, 8086.5148091114725, 8093.676252949816, 8097.825815256755, 1885.6134492429019, 2146.4097373222176, 2183.2140429445385, 2198.438818776108, 2199.8570092943905, 1006.4062203300089, 1008.4302369161547, 1011.185995273797, 1044.9216308776872, 1046.2205656785743, 20657.58684826325, 21976.34070977873, 22047.11811527553, 22074.896255187177, 22334.329970100924, 919.5402298850574, 1031.4017869635593, 1031.7936412717486, 1076.983845242322, 1091.0725882999545, 9236.8614470783, 10197.572339872424, 11435.371054592077, 11470.426478676032, 11475.475395412996, 478040.0, 526020.0, 532794.0, 548932.0, 557118.0, 110751.0, 123774.14338784925, 124533.0, 128051.0, 128639.35680321539, 1205.6804946689135, 1226.9938650306692, 1267.3283159925254, 1270.371166272701, 1274.7705413025744, 22704.432389190402, 22945.597975738765, 23369.065237390314, 23373.0, 23379.298621041395, 52842.73578632082, 55796.88406231934, 56212.71893640506, 56702.7164864173, 57421.0, 74519.0, 76269.23730762622, 77231.22768772465, 77959.22040779519, 78277.0, 7140.750073747394, 8678.218960293603, 8693.261072808882, 8812.427192232484, 8827.735167944971, 13902.791458128338, 13915.930420347833, 13945.58163255104, 14246.857531424554, 14315.212663303619, 10043.548040338057, 11753.706157345792, 11888.881111189123, 11911.523539058688, 12086.335251561248, 10347.689569312932, 11052.171087168334, 11085.833712494157, 11324.716882078013, 11340.94329528347, 11850.940745296219, 11917.880821191677, 12130.272183669009, 12184.20802647825, 12401.93799030999, 8794.692185773467, 8943.37396382247, 8992.325575581988, 9062.50156241413, 9082.591283392396, 10057.346272492265, 11814.232074915102, 12100.515979360727, 12109.091818113853, 12190.146689731633], "value": 10500.337298067165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.2174030360873, 1456.7741999990005, 1479.319513024009, 1485.8737007354375, 1487.9553613391588, 11618.535258589647, 11794.646160615173, 12284.385780710962, 12312.630621081371, 12420.937895310533, 12063.698407539816, 12261.570845020426, 12293.508259669625, 12304.93847530761, 12311.199772014812, 2531.177367355612, 2565.307367010906, 2571.0744132112422, 2577.1624222127884, 2577.9999999999905, 2081.6149012432675, 2544.096845619806, 2545.809064320174, 2546.770790628843, 2546.961795573068, 2490.6139548369943, 2512.849229046254, 2521.6721826162575, 2529.6458495810602, 2537.5305568469894, 2468.1731619907355, 2489.8630575318352, 2522.962155567668, 2524.2679622909336, 2528.380546766045, 2413.179518963561, 2508.7240403555593, 2515.861627610481, 2524.0, 2528.835625684343, 11994.70013249667, 12051.15641905067, 12066.638000859988, 12071.577494787729, 12090.818637720442, 6617.702203400859, 6855.691493882788, 6872.759453419157, 6888.483363747689, 6895.241523432469, 3641.963580364189, 3982.8406863725418, 4287.892802679927, 4363.170997510463, 4389.31965545341, 1257.2079589858422, 1273.8089286607083, 1286.4468278640181, 1305.073397887501, 1310.4561606933207, 16316.0, 17005.48983530496, 17038.574035649082, 17202.655946881117, 17204.56988575283, 5548.944510554843, 5660.943390566042, 5702.686352250583, 5807.651540907475, 5829.941700583025, 12104.031677465782, 12169.391530423443, 12176.634700958986, 12180.878191218151, 12199.817002744789, 6648.069270302161, 6656.800295991031, 6660.433863121689, 6675.065490831287, 6689.531732778756, 5242.7640756166065, 6018.638881667114, 6302.590331628429, 6308.369163083747, 6312.495000399957, 4338.370936214231, 4436.112777444524, 4480.955190448119, 4485.955140448619, 4494.4606647202545, 1280.5838102616688, 1302.3097758188176, 1302.3423171298434, 1315.2043013976597, 1317.0451422718645, 785.8035491127218, 800.8638531449668, 809.6032943857467, 810.4731924249285, 824.7649419915296, 6181.96909015452, 6225.8132256032395, 6345.682715864188, 6415.486761059197, 6506.642134682638, 544.0750723769528, 553.6567328256507, 570.6119838509853, 584.8245526342081, 606.5178183344252, 3182.8726850925705, 3722.962770372316, 3840.8271627776257, 3877.8254978526033, 3886.591907849692, 13891.235982021086, 14059.507917223053, 15238.933274670888, 15561.910666253254, 15580.0, 11297.943510282395, 11696.35670038156, 15119.035760534005, 15343.0, 15516.534503964898, 6441.967790161113, 7026.367626913602, 8809.647614095493, 8852.8672069919, 8917.73246802584, 6744.494162937897, 7229.421646268181, 7306.59813710251, 7312.41500679955, 7375.741849035473, 12837.871621283668, 13461.798073028716, 13605.931970340085, 13670.384832682752, 13894.235817029756, 11437.656870293904, 13993.440262389391, 14007.229602371968, 14089.647758805702, 14198.858011419754, 7134.286571342825, 8452.619632116692, 8531.189536993976, 8535.274501667427, 8557.700480483154, 10655.147588193082, 10928.01647851697, 11004.064654504456, 11022.448877556251, 11051.613193538187, 9359.719208423758, 9372.578233979624, 9393.966663666855, 9554.85667714971, 9563.426194428357, 9117.270618350649, 9176.862347064933, 9231.538423078684, 9249.583768730557, 9251.76870578214, 6702.899456508254, 8155.306798922158, 8177.264046235868, 8216.0, 8245.95877020611, 6096.847578810565, 6133.662648554372, 6144.539159562962, 6157.26112866441, 6174.413430724074, 6043.153958445909, 6044.607100538451, 6186.597871138361, 6217.440430361289, 6330.556861019869], "value": 5323.261181125598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2567382822245, 387.7867173054819, 412.7853516171589, 414.8236999275307, 415.98336066557323, 6007.369226231248, 6107.175531303273, 6196.473299769519, 6339.714712837922, 6362.6638405934755, 4833.154198015351, 6070.5447091468095, 6158.753649854, 6189.9978510422525, 6202.565820392574, 4678.90642187156, 4690.4605970313505, 4698.91924857283, 4720.33915251865, 4728.952710472903, 4662.3239630253765, 4706.74112923789, 4719.882002949937, 4732.7694799352075, 4734.0, 4660.557247061523, 4661.603763680075, 4678.181318269306, 4681.765911704419, 4691.90616187676, 3672.529459660622, 4070.2063097695664, 4451.176532341495, 4636.86089417318, 4723.149833030053, 4029.9723570489336, 4108.281050816125, 4162.146759914211, 4179.728317659373, 4203.348480985452, 4379.58393952574, 4569.794359253841, 4870.707757534559, 5136.5890728741615, 5258.6581872178185, 5428.212909128154, 5577.191307260425, 5579.832605021856, 5589.888202235973, 5637.8590535236535, 4975.701457912537, 5927.199828023248, 6529.804105876831, 6622.768203112868, 6661.867482527982, 4670.878989042605, 4732.124556956939, 4754.215554433515, 4761.547652972997, 4769.952300476985, 5668.546516278688, 6836.282190370039, 6965.268646792065, 7001.344106169442, 7005.474589405815, 3645.5235629570066, 4328.4074218398655, 4345.3699213613845, 4365.847195348148, 4382.8085957021485, 4438.134563760101, 4445.199864024442, 4445.644348452116, 4462.933056004163, 4465.397171381822, 4251.936220956688, 4593.494715581283, 4596.632269418438, 5224.843254702365, 5317.8404647860625, 5026.969471258383, 6614.371634694697, 6615.073889655452, 6624.7681331154145, 6655.667216639149, 1387.9306034698225, 1496.5510346896106, 1514.2655811931204, 1515.6438237014293, 1520.7262692715196, 765.3571000359725, 975.7121649113528, 979.3829887171179, 989.7822479054596, 994.269212129099, 6196.729670417553, 6228.5017198624, 6254.343293954069, 6261.186045814015, 6268.811935641938, 5927.992241318986, 6720.2943690912725, 6743.853544897379, 6806.965965170241, 6822.761203357958, 5498.697571633518, 6218.875622487525, 6237.407446292595, 6237.625742455467, 6243.687815609202, 3049.3139043714987, 3457.27397246576, 3555.520004799371, 3573.4818451324413, 3582.570091588974, 5570.972145139248, 5890.322612899486, 6490.448311893448, 6509.0, 7032.753853615099, 5693.516051135617, 5958.0, 6396.456301214449, 6999.405050570656, 6999.405050570656, 5922.993091174424, 6365.331640177715, 6864.5881247125335, 7007.964960175268, 7012.964935175393, 5037.596992240685, 5304.840854774363, 5929.911051334319, 5981.371955944737, 5985.40145985398, 5720.170575266647, 6462.321456247027, 6625.840477916249, 6717.429018533284, 6738.528303018742, 6467.741290348334, 7005.264447233171, 7021.929780702128, 7057.70671996003, 7095.148582170173, 3616.764910280823, 4165.4584903962295, 4302.182585308781, 4304.504981927118, 4342.261815491311, 6290.370962903856, 6756.358145976124, 6815.217554257435, 6837.35045170708, 6887.380135787803, 5969.76120955157, 6323.841903952438, 6483.546151769331, 6548.624788794406, 6561.507886908596, 5341.359036915595, 5999.610025348338, 6089.817305480843, 6509.544331896911, 6509.730602532461, 5471.562275018068, 6188.2883468399905, 6276.089966954857, 6401.487880969605, 6426.485881129592, 5626.043572592751, 6605.438537724347, 6619.106420633153, 6625.768098116543, 6662.700178492077, 5886.676232807236, 6351.237851457855, 6491.610503369813, 6492.513061520311, 6527.5757075789925], "value": 4716.338786945266, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.2477670989272, 813.8494378539971, 836.8159005018902, 846.4582667093058, 869.6521391443422, 14716.484923027696, 16309.102999335031, 16823.49529514115, 16853.747193792104, 19230.807691923077, 17581.03304318265, 18016.369427070054, 18154.818451815478, 18161.364352247674, 18211.90894045528, 1002.9097381235688, 1028.239103063735, 1029.958801647937, 1033.0237925160727, 1033.3438266700662, 829.340674164041, 979.9510024498783, 1023.718477418712, 1025.3027941000116, 1029.1766586730623, 1065.4140222877425, 1070.459417993912, 1071.437495314962, 1074.1031238915475, 1074.785042991401, 868.6785889220997, 1062.3572738493178, 1067.738404090995, 1069.395791377869, 1071.2501249125605, 747.178104085507, 768.0092680442223, 791.711025475703, 793.2543409195396, 795.4153697032676, 15332.00341977779, 15594.29825657848, 16716.74924876128, 16733.247003884855, 16856.74714879278, 16413.0, 16557.42049028278, 16970.236339364757, 17062.658746825116, 17213.655726885518, 11185.384803835786, 13904.235267060307, 13986.230757308344, 14005.0, 14005.719885602333, 3359.731221502274, 3541.3979623463815, 3541.628129046439, 3543.6102028776813, 3557.5908770491465, 73520.0, 115067.42466287699, 120303.0, 120723.0, 126765.0, 13476.797848032287, 13640.52258170979, 13686.905047596367, 13728.0, 13742.519011834538, 24576.0, 24904.875475622506, 25632.0, 26058.478830423286, 26221.737782622313, 7788.766337009899, 7852.685892564347, 7926.8810967835525, 7989.560574168477, 7990.280874721187, 3937.6062393760394, 4008.0581063450068, 4009.1781184857036, 4015.457913181683, 4018.457508236351, 4264.573542645772, 4321.956780432219, 4358.193734159191, 4370.2570563004365, 4384.69307148503, 937.4141161773891, 954.2032402943481, 956.5026186383042, 963.6579014449909, 964.2189826240767, 624.2446639566176, 650.1223348479515, 674.7604600366799, 675.2302375292072, 692.0449779304628, 10799.244052916221, 11282.605108821152, 11519.712007199887, 12089.0, 12194.756104877853, 657.9473642108716, 660.4815220052332, 664.0603545982477, 664.1830548425464, 684.7192651013061, 5307.203919412042, 5314.830737237801, 5443.918341224885, 5467.480589344006, 5522.9447705523235, 89272.0, 100556.99443005622, 103839.4808025955, 104602.95397045932, 104909.0, 91750.0, 98096.50951745195, 98255.50872245592, 98280.50859745656, 99323.50338248262, 57478.0, 83090.58454707688, 85144.0, 86109.56945215359, 86154.99999999875, 10551.525181367011, 10715.624953126604, 10759.784804304027, 11043.834342484708, 11085.556577736801, 32814.0, 33510.832445837616, 43251.70244892658, 43322.566774331855, 43836.780816095714, 42749.0, 57293.71353143374, 57384.71307643435, 57690.0, 58168.709156453944, 14242.857571424567, 14413.279336033365, 14420.206888621227, 16539.586510337336, 17395.04327262013, 15932.096636324175, 18484.722729158806, 18796.0, 18806.717899231797, 18949.90525047366, 15374.923125384748, 16532.0, 16843.41048063312, 17250.56607168738, 17499.912500437415, 16774.49676509707, 17112.0, 17135.971841689538, 17154.82845171582, 17475.56311092182, 16121.516354509384, 16137.0, 16813.91593042076, 17209.827901721324, 17318.0, 11527.365994870363, 11930.582429614922, 12251.0, 12266.693332666755, 12569.748605027666, 13379.264140472367, 14013.019088663696, 14024.368903399167, 14046.297685115907, 14117.717645646824], "value": 8365.46496719897, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 117.0, 120.0, 114.0, 116.0, 115.0, 115.0, 113.0, 129.0, 170.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 110.0, 113.0, 150.0, 109.0, 109.0, 107.0, 115.0, 160.0, 143.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 200.0, 198.0, 216.0, 216.0, 222.0, 198.0, 199.0, 201.0, 198.0], "value": 204.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 69.0, 110.0, 86.0, 91.0, 63.0, 58.0, 73.0, 60.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 69.0, 85.0, 107.0, 103.0, 104.0, 92.0, 74.0, 71.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 89.0, 89.0, 89.0, 90.0, 101.0, 106.0, 101.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0, 97.0, 105.0, 97.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 90.0, 92.0, 92.0, 92.0, 88.0, 92.0, 88.0, 91.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 51.0, 51.0, 50.0, 49.0, 48.0, 57.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 56.0, 68.0, 65.0, 58.0, 55.0, 58.0, 54.0, 56.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 84.0, 83.0, 84.0, 82.0, 85.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 153.0, 117.0, 145.0, 135.0, 164.0, 152.0, 159.0, 185.0, 163.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 179.0, 183.0, 250.0, 243.0, 171.0, 229.0, 184.0, 185.0], "value": 199.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 73.0, 92.0, 62.0, 78.0, 97.0, 100.0, 100.0], "value": 80.9, "unit": "score"}]}]} 05:11:24 INFO - Return code: 0 05:11:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:11:24 ERROR - # TBPL SUCCESS # 05:11:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:24 INFO - 2017-04-27 05:11:24.260 screenresolution[1659:10570] starting screenresolution argv=screenresolution get 05:11:24 INFO - 2017-04-27 05:11:24.263 screenresolution[1659:10570] Display 0: 1600x1200x32@60 05:11:24 INFO - 2017-04-27 05:11:24.269 screenresolution[1660:10573] starting screenresolution argv=screenresolution list 05:11:24 INFO - Available Modes on Display 0 05:11:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:24 INFO - Intel Iris: 05:11:24 INFO - Chipset Model: Intel Iris 05:11:24 INFO - Type: GPU 05:11:24 INFO - Bus: Built-In 05:11:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:24 INFO - Vendor: Intel (0x8086) 05:11:24 INFO - Device ID: 0x0a2e 05:11:24 INFO - Revision ID: 0x0009 05:11:24 INFO - Displays: 05:11:24 INFO - Display: 05:11:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:24 INFO - Display Serial Number: 1600x1200 60 05:11:24 INFO - Main Display: Yes 05:11:24 INFO - Mirror: Off 05:11:24 INFO - Online: Yes 05:11:24 INFO - Rotation: Supported 05:11:24 INFO - Return code: 0 05:11:24 INFO - Running post-action listener: _resource_record_post_action 05:11:24 INFO - [mozharness: 2017-04-27 12:11:24.505422Z] Finished run-tests step (success) 05:11:24 INFO - Running post-run listener: _resource_record_post_run 05:11:24 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38369280; Write bytes: 511495680; Read time: 261; Write time: 1632 05:11:24 INFO - TinderboxPrint: CPU usage
54.0% 05:11:24 INFO - TinderboxPrint: I/O read bytes / time
38,369,280 / 261 05:11:24 INFO - TinderboxPrint: I/O write bytes / time
511,495,680 / 1,632 05:11:24 INFO - TinderboxPrint: CPU idle
2,202.9 (46.0%) 05:11:24 INFO - TinderboxPrint: CPU system
959.8 (20.0%) 05:11:24 INFO - TinderboxPrint: CPU user
1,627.0 (34.0%) 05:11:24 INFO - TinderboxPrint: Swap in / out
246,038,528 / 0 05:11:24 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204296704; Write bytes: 205022720; Read time: 16259; Write time: 449 05:11:24 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36386816; Write bytes: 299681792; Read time: 242; Write time: 1156 05:11:25 INFO - Running post-run listener: _upload_blobber_files 05:11:25 INFO - Blob upload gear active. 05:11:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:11:25 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:11:25 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:11:25 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:11:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:26 INFO - (blobuploader) - INFO - Done attempting. 05:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:26 INFO - (blobuploader) - INFO - Done attempting. 05:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:11:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:27 INFO - (blobuploader) - INFO - Done attempting. 05:11:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:11:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:29 INFO - (blobuploader) - INFO - Done attempting. 05:11:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:29 INFO - Return code: 0 05:11:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ff25fb8a5d5de8ee393b9af5ddbdf252119b2f5059fa966dfded19df7375b1bf0ddae43723e49fc96a3f347e63155a777d3a5150b8cf7ff05d289337a376ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4456dc50d3c6bebda62e424bb0802f951736b5f3b967168d15229dd820a9d10c72346c33b8ee7a0ae679064a3c16ceb867f6eadb2f15dcf9c7b7ccd006906b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43b870587da993cedcbe8a2643d47b3c9b40e875b32a198f8dcb4da337d1127f7e91f4c1bad4aa9d9e49bc3d01c42051af586524f9ea9bfea915ff9510e8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3883bb897c77effeba0cb33c686dba8e8f2f3f3901e89f4bb797cd01201af195324d9883c208674dee2d54b4a7931963f68d46f81498d0823099a317ef7ff929"} 05:11:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:29 INFO - Contents: 05:11:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ff25fb8a5d5de8ee393b9af5ddbdf252119b2f5059fa966dfded19df7375b1bf0ddae43723e49fc96a3f347e63155a777d3a5150b8cf7ff05d289337a376ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4456dc50d3c6bebda62e424bb0802f951736b5f3b967168d15229dd820a9d10c72346c33b8ee7a0ae679064a3c16ceb867f6eadb2f15dcf9c7b7ccd006906b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43b870587da993cedcbe8a2643d47b3c9b40e875b32a198f8dcb4da337d1127f7e91f4c1bad4aa9d9e49bc3d01c42051af586524f9ea9bfea915ff9510e8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3883bb897c77effeba0cb33c686dba8e8f2f3f3901e89f4bb797cd01201af195324d9883c208674dee2d54b4a7931963f68d46f81498d0823099a317ef7ff929"} 05:11:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:29 INFO - Copying logs to upload dir... 05:11:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.160712 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 05:11:29.770666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 05:11:29.774599) ========= 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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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/7ff25fb8a5d5de8ee393b9af5ddbdf252119b2f5059fa966dfded19df7375b1bf0ddae43723e49fc96a3f347e63155a777d3a5150b8cf7ff05d289337a376ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4456dc50d3c6bebda62e424bb0802f951736b5f3b967168d15229dd820a9d10c72346c33b8ee7a0ae679064a3c16ceb867f6eadb2f15dcf9c7b7ccd006906b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43b870587da993cedcbe8a2643d47b3c9b40e875b32a198f8dcb4da337d1127f7e91f4c1bad4aa9d9e49bc3d01c42051af586524f9ea9bfea915ff9510e8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3883bb897c77effeba0cb33c686dba8e8f2f3f3901e89f4bb797cd01201af195324d9883c208674dee2d54b4a7931963f68d46f81498d0823099a317ef7ff929"} build_url:https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/MXcZAIOjS9iHUm4Pn-Be1w/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/7ff25fb8a5d5de8ee393b9af5ddbdf252119b2f5059fa966dfded19df7375b1bf0ddae43723e49fc96a3f347e63155a777d3a5150b8cf7ff05d289337a376ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4456dc50d3c6bebda62e424bb0802f951736b5f3b967168d15229dd820a9d10c72346c33b8ee7a0ae679064a3c16ceb867f6eadb2f15dcf9c7b7ccd006906b35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43b870587da993cedcbe8a2643d47b3c9b40e875b32a198f8dcb4da337d1127f7e91f4c1bad4aa9d9e49bc3d01c42051af586524f9ea9bfea915ff9510e8239", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3883bb897c77effeba0cb33c686dba8e8f2f3f3901e89f4bb797cd01201af195324d9883c208674dee2d54b4a7931963f68d46f81498d0823099a317ef7ff929"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 05:11:29.810133) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 05:11:29.810514) ========= 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.Fy9MVwr5dp/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.hURXW7qoBc/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.005351 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 05:11:29.859429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 05:11:29.859793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 05:11:29.860176) ========= ========= Total master_lag: 0.21 =========