builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0135 starttime: 1485102091.02 results: success (0) buildid: 20170122071525 builduid: ee84b0bbef8d4fafa14daf7d95270eeb revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.021998) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.022433) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.022699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.051064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.051336) ========= 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.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-01-22 08:21:31-- 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% 33.8M=0s 2017-01-22 08:21:31 (33.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.506705 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.585212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.585515) ========= 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.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.027775 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:31.633827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 08:21:31.634150) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-01-22 08:21:31,891 truncating revision to first 12 chars 2017-01-22 08:21:31,891 Setting DEBUG logging. 2017-01-22 08:21:31,891 attempt 1/10 2017-01-22 08:21:31,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/24a81d93e07c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-22 08:21:33,027 unpacking tar archive at: mozilla-aurora-24a81d93e07c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385786 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-22 08:21:33.045517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:33.048824) ========= script_repo_revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:33.049220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:33.049488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 08:21:33.069226) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2017-01-22 08:21:33.069501) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:21:33 INFO - MultiFileLogger online at 20170122 08:21:33 in /builds/slave/test 08:21:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:21:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:33 INFO - {'append_to_log': False, 08:21:33 INFO - 'base_work_dir': '/builds/slave/test', 08:21:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:21:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:33 INFO - 'branch': 'Mozilla-Aurora', 08:21:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:33 INFO - 'config_files': ('talos/mac_config.py',), 08:21:33 INFO - 'default_actions': ('clobber', 08:21:33 INFO - 'read-buildbot-config', 08:21:33 INFO - 'download-and-extract', 08:21:33 INFO - 'populate-webroot', 08:21:33 INFO - 'create-virtualenv', 08:21:33 INFO - 'install', 08:21:33 INFO - 'run-tests'), 08:21:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:33 INFO - 'download_minidump_stackwalk': True, 08:21:33 INFO - 'download_symbols': 'ondemand', 08:21:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:33 INFO - 'installer_path': 'installer.exe', 08:21:33 INFO - 'log_level': 'info', 08:21:33 INFO - 'log_name': 'talos', 08:21:33 INFO - 'log_to_console': True, 08:21:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:21:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:21:33 INFO - 'opt_config_files': (), 08:21:33 INFO - 'pip_index': False, 08:21:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:33 INFO - 'cmd': ('bash', 08:21:33 INFO - '-c', 08:21:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:33 INFO - 'enabled': True, 08:21:33 INFO - 'halt_on_failure': False, 08:21:33 INFO - 'name': 'check_screen_resolution'},), 08:21:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:21:33 INFO - 'cmd': ('bash', 08:21:33 INFO - '-c', 08:21:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:21:33 INFO - 'enabled': True, 08:21:33 INFO - 'halt_on_failure': False, 08:21:33 INFO - 'name': 'check_screen_resolution'},), 08:21:33 INFO - 'run_cmd_checks_enabled': True, 08:21:33 INFO - 'sps_profile': False, 08:21:33 INFO - 'sps_profile_interval': 0, 08:21:33 INFO - 'suite': 'dromaeojs-e10s', 08:21:33 INFO - 'system_bits': '32', 08:21:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:33 INFO - 'title': 't-yosemite-r7-0135', 08:21:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:33 INFO - 'use_talos_json': True, 08:21:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:33 INFO - 'work_dir': 'build'} 08:21:33 INFO - [mozharness: 2017-01-22 16:21:33.437175Z] Running clobber step. 08:21:33 INFO - Running pre-action listener: _resource_record_pre_action 08:21:33 INFO - Running main action method: clobber 08:21:33 INFO - rmtree: /builds/slave/test/build 08:21:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:36 INFO - Running post-action listener: _resource_record_post_action 08:21:36 INFO - [mozharness: 2017-01-22 16:21:36.004546Z] Finished clobber step (success) 08:21:36 INFO - [mozharness: 2017-01-22 16:21:36.004707Z] Running read-buildbot-config step. 08:21:36 INFO - Running pre-action listener: _resource_record_pre_action 08:21:36 INFO - Running main action method: read_buildbot_config 08:21:36 INFO - Using buildbot properties: 08:21:36 INFO - { 08:21:36 INFO - "project": "", 08:21:36 INFO - "product": "firefox", 08:21:36 INFO - "script_repo_revision": "production", 08:21:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:21:36 INFO - "repository": "", 08:21:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:21:36 INFO - "buildid": "20170122071525", 08:21:36 INFO - "pgo_build": "False", 08:21:36 INFO - "basedir": "/builds/slave/test", 08:21:36 INFO - "buildnumber": 33, 08:21:36 INFO - "slavename": "t-yosemite-r7-0135", 08:21:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:21:36 INFO - "platform": "yosemite_r7", 08:21:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:21:36 INFO - "branch": "mozilla-aurora", 08:21:36 INFO - "repo_path": "releases/mozilla-aurora", 08:21:36 INFO - "revision": "24a81d93e07cc96300f8e1f5c69034dd4743bd63", 08:21:36 INFO - "stage_platform": "macosx64", 08:21:36 INFO - "builduid": "ee84b0bbef8d4fafa14daf7d95270eeb", 08:21:36 INFO - "slavebuilddir": "test" 08:21:36 INFO - } 08:21:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:21:36 INFO - Running post-action listener: _resource_record_post_action 08:21:36 INFO - [mozharness: 2017-01-22 16:21:36.007901Z] Finished read-buildbot-config step (success) 08:21:36 INFO - [mozharness: 2017-01-22 16:21:36.008008Z] Running download-and-extract step. 08:21:36 INFO - Running pre-action listener: _resource_record_pre_action 08:21:36 INFO - Running main action method: download_and_extract 08:21:36 INFO - mkdir: /builds/slave/test/build/tests 08:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:36 INFO - trying https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:21:36 INFO - Downloading https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:21:37 INFO - Downloaded 1199 bytes. 08:21:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:21:37 INFO - Using the following test package requirements: 08:21:37 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:21:37 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:21:37 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:21:37 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'jsshell-mac.zip'], 08:21:37 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:21:37 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:21:37 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:21:37 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:21:37 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:21:37 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:21:37 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:21:37 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:21:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:21:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:21:37 INFO - Fetch https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:21:37 INFO - Http code: 200 08:21:37 INFO - via: 1.1 6be093c16fa776bbd432bbe9bd03f6af.cloudfront.net (CloudFront) 08:21:37 INFO - x-amz-cf-id: Vt8EByCPkpHZW6ew4G_C-TqXcx_hTB9ojptKpGL9xgE8D-r3iX4t8A== 08:21:37 INFO - x-amz-version-id: FwEAhJrD_FI_ojKIq0.7HpYMguCtslJ1 08:21:38 INFO - Expected file size: 16277513 08:21:38 INFO - Obtained file size: 16277513 08:21:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:21:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:21:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:21:44 INFO - Fetch https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:21:45 INFO - Http code: 200 08:21:45 INFO - via: 1.1 f0ef92e52918ab5129ebd66f2f633cbb.cloudfront.net (CloudFront) 08:21:45 INFO - x-amz-cf-id: cumjxpVyeqYOBOd78LJDUjd5fjOjblUvoE6t3Pp4O8lZJpAd1BSC7g== 08:21:45 INFO - x-amz-version-id: FwEAhJrD_FI_ojKIq0.7HpYMguCtslJ1 08:21:46 INFO - Expected file size: 16277513 08:21:46 INFO - Obtained file size: 16277513 08:21:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:21:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:21:52 INFO - Fetch https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:21:53 INFO - Http code: 200 08:21:53 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 08:21:53 INFO - x-amz-cf-id: 9SNXaItuMTgukqvDajg2KBjH4Pj38mckDyg90zzjcg67J-4IlnJnuQ== 08:21:53 INFO - x-amz-version-id: Vtt.SMCVMqJCpfrUIUt4sjVkfGdN1MQP 08:21:53 INFO - Expected file size: 14402992 08:21:53 INFO - Obtained file size: 14402992 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:54 INFO - trying https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:21:54 INFO - Downloading https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:21:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:22:23 WARNING - URL Error: https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:22:23 INFO - Running command: ['nslookup', 'queue.taskcluster.net'] 08:22:23 INFO - Copy/paste: nslookup queue.taskcluster.net 08:22:23 INFO - Server: 10.26.75.40 08:22:23 INFO - Address: 10.26.75.40#53 08:22:23 INFO - queue.taskcluster.net canonical name = toyama-73636.herokussl.com. 08:22:23 INFO - toyama-73636.herokussl.com canonical name = elb081832-1105536650.us-east-1.elb.amazonaws.com. 08:22:23 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 08:22:23 INFO - Address: 54.225.132.63 08:22:23 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 08:22:23 INFO - Address: 54.225.196.17 08:22:23 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 08:22:23 INFO - Address: 54.225.143.217 08:22:23 INFO - Return code: 0 08:22:23 INFO - retry: attempt #1 caught exception: 08:22:23 INFO - retry: Failed, sleeping 30 seconds before retrying 08:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #2 08:22:57 INFO - Downloaded 110603269 bytes. 08:22:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:22:57 INFO - mkdir: /builds/slave/test/properties 08:22:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:22:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:22:57 INFO - Contents: 08:22:57 INFO - build_url:https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:22:58 INFO - Running post-action listener: _resource_record_post_action 08:22:58 INFO - Running post-action listener: set_extra_try_arguments 08:22:58 INFO - [mozharness: 2017-01-22 16:22:58.381773Z] Finished download-and-extract step (success) 08:22:58 INFO - [mozharness: 2017-01-22 16:22:58.381899Z] Running populate-webroot step. 08:22:58 INFO - Running pre-action listener: _resource_record_pre_action 08:22:58 INFO - Running main action method: populate_webroot 08:22:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:22:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:22:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:22:58 INFO - '--tppagecycles', 08:22:58 INFO - '7'], 08:22:58 INFO - 'tests': ['tsvgm']}}, 08:22:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:22:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:22:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:22:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:22:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:22:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['damp', 'tps']}, 08:22:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'tests': ['damp', 'tps']}, 08:22:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['dromaeo_dom']}, 08:22:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:22:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['basic_compositor_video']}, 08:22:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:22:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['a11yr', 08:22:58 INFO - 'ts_paint', 08:22:58 INFO - 'tpaint', 08:22:58 INFO - 'sessionrestore', 08:22:58 INFO - 'sessionrestore_no_auto_restore', 08:22:58 INFO - 'tabpaint']}, 08:22:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['tsvgx', 08:22:58 INFO - 'tsvgr_opacity', 08:22:58 INFO - 'tart', 08:22:58 INFO - 'tscrollx', 08:22:58 INFO - 'cart']}, 08:22:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:22:58 INFO - 'tsvgr_opacity', 08:22:58 INFO - 'tart', 08:22:58 INFO - 'tscrollx', 08:22:58 INFO - 'cart']}, 08:22:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'talos_options': ['--disable-e10s'], 08:22:58 INFO - 'tests': ['tp5o']}, 08:22:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'tests': ['tp5o']}, 08:22:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'talos_options': ['--disable-e10s', 08:22:58 INFO - '--xperf_path', 08:22:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:58 INFO - 'tests': ['tp5n']}, 08:22:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:22:58 INFO - 'talos_options': ['--xperf_path', 08:22:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:22:58 INFO - 'tests': ['tp5n']}}, 08:22:58 INFO - 'talos.zip': {'path': '', 08:22:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:22:58 INFO - Running post-action listener: _resource_record_post_action 08:22:58 INFO - [mozharness: 2017-01-22 16:22:58.401138Z] Finished populate-webroot step (success) 08:22:58 INFO - [mozharness: 2017-01-22 16:22:58.401271Z] Running create-virtualenv step. 08:22:58 INFO - Running pre-action listener: _resource_record_pre_action 08:22:58 INFO - Running main action method: create_virtualenv 08:22:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:22:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:22:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:22:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:22:58 INFO - Using real prefix '/tools/python27' 08:22:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:22:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:23:02 INFO - Installing pip.................done. 08:23:02 INFO - Return code: 0 08:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:23:02 INFO - Reading from file tmpfile_stdout 08:23:02 INFO - Output received: 08:23:02 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) 08:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:23: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')]} 08:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23: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')]} 08:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:23:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:02 INFO - 'HOME': '/Users/cltbld', 08:23:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:02 INFO - 'LOGNAME': 'cltbld', 08:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:02 INFO - 'MOZ_NO_REMOTE': '1', 08:23:02 INFO - 'NO_EM_RESTART': '1', 08:23:02 INFO - 'PAGER': '/bin/cat', 08:23:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:02 INFO - 'PWD': '/builds/slave/test', 08:23:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:02 INFO - 'SHELL': '/bin/bash', 08:23:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:02 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:02 INFO - 'USER': 'cltbld', 08:23:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:02 INFO - 'XPC_FLAGS': '0x0', 08:23:02 INFO - 'XPC_SERVICE_NAME': '0', 08:23:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:23:03 INFO - Cleaning up... 08:23:03 INFO - Return code: 0 08:23:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:03 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:23:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:03 INFO - 'HOME': '/Users/cltbld', 08:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:03 INFO - 'LOGNAME': 'cltbld', 08:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:03 INFO - 'MOZ_NO_REMOTE': '1', 08:23:03 INFO - 'NO_EM_RESTART': '1', 08:23:03 INFO - 'PAGER': '/bin/cat', 08:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:03 INFO - 'PWD': '/builds/slave/test', 08:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:03 INFO - 'SHELL': '/bin/bash', 08:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:03 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:03 INFO - 'USER': 'cltbld', 08:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:03 INFO - 'XPC_FLAGS': '0x0', 08:23:03 INFO - 'XPC_SERVICE_NAME': '0', 08:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:03 INFO - Downloading/unpacking psutil>=3.1.1 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:23:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:07 INFO - Installing collected packages: psutil 08:23:07 INFO - Running setup.py install for psutil 08:23:07 INFO - building 'psutil._psutil_osx' extension 08:23:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:23:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:23:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:23:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:23:08 INFO - building 'psutil._psutil_posix' extension 08:23:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:23:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:23:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:23:08 INFO - ^ 08:23:08 INFO - 1 warning generated. 08:23:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:23:08 INFO - Successfully installed psutil 08:23:08 INFO - Cleaning up... 08:23:08 INFO - Return code: 0 08:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:08 INFO - 'HOME': '/Users/cltbld', 08:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:08 INFO - 'LOGNAME': 'cltbld', 08:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:08 INFO - 'MOZ_NO_REMOTE': '1', 08:23:08 INFO - 'NO_EM_RESTART': '1', 08:23:08 INFO - 'PAGER': '/bin/cat', 08:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:08 INFO - 'PWD': '/builds/slave/test', 08:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:08 INFO - 'SHELL': '/bin/bash', 08:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:08 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:08 INFO - 'USER': 'cltbld', 08:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:08 INFO - 'XPC_FLAGS': '0x0', 08:23:08 INFO - 'XPC_SERVICE_NAME': '0', 08:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:23:11 INFO - Installing collected packages: mozsystemmonitor 08:23:11 INFO - Running setup.py install for mozsystemmonitor 08:23:11 INFO - Successfully installed mozsystemmonitor 08:23:11 INFO - Cleaning up... 08:23:11 INFO - Return code: 0 08:23:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:11 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:23:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:11 INFO - 'HOME': '/Users/cltbld', 08:23:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:11 INFO - 'LOGNAME': 'cltbld', 08:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:11 INFO - 'MOZ_NO_REMOTE': '1', 08:23:11 INFO - 'NO_EM_RESTART': '1', 08:23:11 INFO - 'PAGER': '/bin/cat', 08:23:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:11 INFO - 'PWD': '/builds/slave/test', 08:23:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:11 INFO - 'SHELL': '/bin/bash', 08:23:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:11 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:11 INFO - 'USER': 'cltbld', 08:23:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:11 INFO - 'XPC_FLAGS': '0x0', 08:23:11 INFO - 'XPC_SERVICE_NAME': '0', 08:23:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:12 INFO - Downloading/unpacking jsonschema==2.5.1 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:23:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23: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 08:23:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:23:15 INFO - warning: no files found matching '*.txt' 08:23:15 INFO - no previously-included directories found matching 'build' 08:23:15 INFO - no previously-included directories found matching 'dist' 08:23:15 INFO - no previously-included directories found matching '.git*' 08:23:15 INFO - Installing collected packages: jsonschema, functools32 08:23:15 INFO - Running setup.py install for functools32 08:23:15 INFO - warning: no files found matching '*.txt' 08:23:15 INFO - no previously-included directories found matching 'build' 08:23:15 INFO - no previously-included directories found matching 'dist' 08:23:15 INFO - no previously-included directories found matching '.git*' 08:23:15 INFO - Successfully installed jsonschema functools32 08:23:15 INFO - Cleaning up... 08:23:15 INFO - Return code: 0 08:23:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:15 INFO - 'HOME': '/Users/cltbld', 08:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:15 INFO - 'LOGNAME': 'cltbld', 08:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:15 INFO - 'MOZ_NO_REMOTE': '1', 08:23:15 INFO - 'NO_EM_RESTART': '1', 08:23:15 INFO - 'PAGER': '/bin/cat', 08:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:15 INFO - 'PWD': '/builds/slave/test', 08:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:15 INFO - 'SHELL': '/bin/bash', 08:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:15 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:15 INFO - 'USER': 'cltbld', 08:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:15 INFO - 'XPC_FLAGS': '0x0', 08:23:15 INFO - 'XPC_SERVICE_NAME': '0', 08:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:23:15 INFO - Cleaning up... 08:23:15 INFO - Return code: 0 08:23:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:15 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:23:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:15 INFO - 'HOME': '/Users/cltbld', 08:23:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:15 INFO - 'LOGNAME': 'cltbld', 08:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:15 INFO - 'MOZ_NO_REMOTE': '1', 08:23:15 INFO - 'NO_EM_RESTART': '1', 08:23:15 INFO - 'PAGER': '/bin/cat', 08:23:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:15 INFO - 'PWD': '/builds/slave/test', 08:23:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:15 INFO - 'SHELL': '/bin/bash', 08:23:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:15 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:15 INFO - 'USER': 'cltbld', 08:23:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:15 INFO - 'XPC_FLAGS': '0x0', 08:23:15 INFO - 'XPC_SERVICE_NAME': '0', 08:23:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:16 INFO - Downloading/unpacking blobuploader==1.2.4 08:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:23:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:19 INFO - Downloading docopt-0.6.1.tar.gz 08:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 08:23:20 INFO - Running setup.py install for blobuploader 08:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:23:20 INFO - Running setup.py install for requests 08:23:20 INFO - Running setup.py install for docopt 08:23:20 INFO - Successfully installed blobuploader requests docopt 08:23:20 INFO - Cleaning up... 08:23:20 INFO - Return code: 0 08:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:21 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:21 INFO - 'HOME': '/Users/cltbld', 08:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:21 INFO - 'LOGNAME': 'cltbld', 08:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:21 INFO - 'MOZ_NO_REMOTE': '1', 08:23:21 INFO - 'NO_EM_RESTART': '1', 08:23:21 INFO - 'PAGER': '/bin/cat', 08:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:21 INFO - 'PWD': '/builds/slave/test', 08:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:21 INFO - 'SHELL': '/bin/bash', 08:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:21 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:21 INFO - 'USER': 'cltbld', 08:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:21 INFO - 'XPC_FLAGS': '0x0', 08:23:21 INFO - 'XPC_SERVICE_NAME': '0', 08:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-dwaBSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-dw5sbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8STR3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-H_iWBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hBguCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-HWtqfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:21 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Nz8viV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Wyk4iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-yrSNCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ZCSz1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-wIA0cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BBVSA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-93jUsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-mefcwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-jQ9QKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-zB4XIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:22 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-UEVejf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:23:23 INFO - Running setup.py install for manifestparser 08:23:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozcrash 08:23:23 INFO - Running setup.py install for mozdebug 08:23:23 INFO - Running setup.py install for mozdevice 08:23:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozfile 08:23:23 INFO - Running setup.py install for mozhttpd 08:23:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:23:23 INFO - Running setup.py install for mozinfo 08:23:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Running setup.py install for mozInstall 08:23:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Running setup.py install for mozleak 08:23:24 INFO - Running setup.py install for mozlog 08:23:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Running setup.py install for moznetwork 08:23:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:23:24 INFO - Running setup.py install for mozprocess 08:23:24 INFO - Running setup.py install for mozprofile 08:23:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:23:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:23:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:23:25 INFO - Running setup.py install for mozrunner 08:23:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:23:25 INFO - Running setup.py install for mozscreenshot 08:23:25 INFO - Running setup.py install for moztest 08:23:25 INFO - Running setup.py install for mozversion 08:23:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:23:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:23:25 INFO - Cleaning up... 08:23:25 INFO - Return code: 0 08:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:25 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:25 INFO - 'HOME': '/Users/cltbld', 08:23:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:25 INFO - 'LOGNAME': 'cltbld', 08:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:25 INFO - 'MOZ_NO_REMOTE': '1', 08:23:25 INFO - 'NO_EM_RESTART': '1', 08:23:25 INFO - 'PAGER': '/bin/cat', 08:23:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:25 INFO - 'PWD': '/builds/slave/test', 08:23:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:25 INFO - 'SHELL': '/bin/bash', 08:23:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:25 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:25 INFO - 'USER': 'cltbld', 08:23:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:25 INFO - 'XPC_FLAGS': '0x0', 08:23:25 INFO - 'XPC_SERVICE_NAME': '0', 08:23:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:23:25 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4N4QRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kOTAEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:23:26 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)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-47l8nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-LGtZOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-YOEjEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-2I98i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FN5v4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-y60olU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8Ew6go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:23:26 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FW1E7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:23:26 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)) 08:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-taOKnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-cjL_vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-X6aTVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-WFRULy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:23:27 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)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-3w9sBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-rEIlFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:23:27 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)) 08:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:23:27 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Sq9LVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:23:27 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)) 08:23:27 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)) 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:23:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:23:30 INFO - Downloading blessings-1.6.tar.gz 08:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:23:30 INFO - Installing collected packages: blessings 08:23:30 INFO - Running setup.py install for blessings 08:23:30 INFO - Successfully installed blessings 08:23:30 INFO - Cleaning up... 08:23:30 INFO - Return code: 0 08:23:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:31 INFO - Reading from file tmpfile_stdout 08:23:31 INFO - Current package versions: 08:23:31 INFO - blessings == 1.6 08:23:31 INFO - blobuploader == 1.2.4 08:23:31 INFO - docopt == 0.6.1 08:23:31 INFO - functools32 == 3.2.3-2 08:23:31 INFO - jsonschema == 2.5.1 08:23:31 INFO - manifestparser == 1.1 08:23:31 INFO - mozInstall == 1.12 08:23:31 INFO - mozcrash == 1.0 08:23:31 INFO - mozdebug == 0.1 08:23:31 INFO - mozdevice == 0.48 08:23:31 INFO - mozfile == 1.2 08:23:31 INFO - mozhttpd == 0.7 08:23:31 INFO - mozinfo == 0.9 08:23:31 INFO - mozleak == 0.1 08:23:31 INFO - mozlog == 3.4 08:23:31 INFO - moznetwork == 0.27 08:23:31 INFO - mozprocess == 0.23 08:23:31 INFO - mozprofile == 0.28 08:23:31 INFO - mozrunner == 6.13 08:23:31 INFO - mozscreenshot == 0.1 08:23:31 INFO - mozsystemmonitor == 0.3 08:23:31 INFO - moztest == 0.8 08:23:31 INFO - mozversion == 1.4 08:23:31 INFO - psutil == 3.1.1 08:23:31 INFO - requests == 1.2.3 08:23:31 INFO - wsgiref == 0.1.2 08:23:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:31 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:31 INFO - 'HOME': '/Users/cltbld', 08:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:31 INFO - 'LOGNAME': 'cltbld', 08:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:31 INFO - 'MOZ_NO_REMOTE': '1', 08:23:31 INFO - 'NO_EM_RESTART': '1', 08:23:31 INFO - 'PAGER': '/bin/cat', 08:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:31 INFO - 'PWD': '/builds/slave/test', 08:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:31 INFO - 'SHELL': '/bin/bash', 08:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:31 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:31 INFO - 'USER': 'cltbld', 08:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:31 INFO - 'XPC_FLAGS': '0x0', 08:23:31 INFO - 'XPC_SERVICE_NAME': '0', 08:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:23:31 INFO - Cleaning up... 08:23:31 INFO - Return code: 0 08:23:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:23:31 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 0x10af63490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aed9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee5bd709e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, '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.50fT1cdjeu/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.bcPjQmhUTf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:23:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:23:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:23:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:23:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:23:31 INFO - 'HOME': '/Users/cltbld', 08:23:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:23:31 INFO - 'LOGNAME': 'cltbld', 08:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:23:31 INFO - 'MOZ_NO_REMOTE': '1', 08:23:31 INFO - 'NO_EM_RESTART': '1', 08:23:31 INFO - 'PAGER': '/bin/cat', 08:23:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:23:31 INFO - 'PWD': '/builds/slave/test', 08:23:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:23:31 INFO - 'SHELL': '/bin/bash', 08:23:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:23:31 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:23:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:23:31 INFO - 'USER': 'cltbld', 08:23:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:23:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:23:31 INFO - 'XPC_FLAGS': '0x0', 08:23:31 INFO - 'XPC_SERVICE_NAME': '0', 08:23:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:23:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:23:31 INFO - Cleaning up... 08:23:31 INFO - Return code: 0 08:23:31 INFO - Running post-action listener: _resource_record_post_action 08:23:31 INFO - Running post-action listener: _start_resource_monitoring 08:23:31 INFO - Starting resource monitoring. 08:23:31 INFO - [mozharness: 2017-01-22 16:23:31.639429Z] Finished create-virtualenv step (success) 08:23:31 INFO - [mozharness: 2017-01-22 16:23:31.640398Z] Running install step. 08:23:31 INFO - Running pre-action listener: _resource_record_pre_action 08:23:31 INFO - Running main action method: install 08:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:23:31 INFO - Reading from file tmpfile_stdout 08:23:31 INFO - Detecting whether we're running mozinstall >=1.0... 08:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:23:32 INFO - Reading from file tmpfile_stdout 08:23:32 INFO - Output received: 08:23:32 INFO - Usage: mozinstall [options] installer 08:23:32 INFO - Options: 08:23:32 INFO - -h, --help show this help message and exit 08:23:32 INFO - -d DEST, --destination=DEST 08:23:32 INFO - Directory to install application into. [default: 08:23:32 INFO - "/builds/slave/test"] 08:23:32 INFO - --app=APP Application being installed. [default: firefox] 08:23:32 INFO - mkdir: /builds/slave/test/build/application 08:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:24:03 INFO - Reading from file tmpfile_stdout 08:24:03 INFO - Output received: 08:24:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:24:03 INFO - Running post-action listener: _resource_record_post_action 08:24:03 INFO - [mozharness: 2017-01-22 16:24:03.814965Z] Finished install step (success) 08:24:03 INFO - [mozharness: 2017-01-22 16:24:03.815094Z] Running run-tests step. 08:24:03 INFO - Running pre-action listener: _resource_record_pre_action 08:24:03 INFO - Running main action method: run_tests 08:24:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:24:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:24:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:24:03 INFO - 2017-01-22 08:24:03.829 screenresolution[1641:13130] starting screenresolution argv=screenresolution get 08:24:03 INFO - 2017-01-22 08:24:03.832 screenresolution[1641:13130] Display 0: 1600x1200x32@60 08:24:03 INFO - 2017-01-22 08:24:03.839 screenresolution[1642:13132] starting screenresolution argv=screenresolution list 08:24:03 INFO - Available Modes on Display 0 08:24:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:24:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:24:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:24:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:24:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:24:04 INFO - Intel Iris: 08:24:04 INFO - Chipset Model: Intel Iris 08:24:04 INFO - Type: GPU 08:24:04 INFO - Bus: Built-In 08:24:04 INFO - VRAM (Dynamic, Max): 1536 MB 08:24:04 INFO - Vendor: Intel (0x8086) 08:24:04 INFO - Device ID: 0x0a2e 08:24:04 INFO - Revision ID: 0x0009 08:24:04 INFO - Displays: 08:24:04 INFO - Display: 08:24:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:24:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:24:04 INFO - Display Serial Number: 1600x1200 60 08:24:04 INFO - Main Display: Yes 08:24:04 INFO - Mirror: Off 08:24:04 INFO - Online: Yes 08:24:04 INFO - Rotation: Supported 08:24:04 INFO - Return code: 0 08:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:24:04 INFO - Python 2.7.3 08:24:04 INFO - Return code: 0 08:24:04 INFO - grabbing minidump binary from tooltool 08:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad77d30>, '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 0x10abdddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad6fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:24:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:24:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:24:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:24:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:24:04 INFO - Return code: 0 08:24:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:24:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:24:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:24:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:24:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50fT1cdjeu/Render', 08:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:24:04 INFO - 'HOME': '/Users/cltbld', 08:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:24:04 INFO - 'LOGNAME': 'cltbld', 08:24:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:24:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:04 INFO - 'MOZ_NO_REMOTE': '1', 08:24:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:24:04 INFO - 'NO_EM_RESTART': '1', 08:24:04 INFO - 'PAGER': '/bin/cat', 08:24:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:04 INFO - 'PWD': '/builds/slave/test', 08:24:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:24:04 INFO - 'SHELL': '/bin/bash', 08:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcPjQmhUTf/Listeners', 08:24:04 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 08:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:24:04 INFO - 'USER': 'cltbld', 08:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:04 INFO - 'XPC_FLAGS': '0x0', 08:24:04 INFO - 'XPC_SERVICE_NAME': '0', 08:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:24:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:24:04 INFO - mozversion application_buildid: 20170122071525 08:24:04 INFO - mozversion application_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 08:24:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:24:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:24:04 INFO - mozversion application_name: Firefox 08:24:04 INFO - mozversion application_remotingname: firefox-dev 08:24:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:04 INFO - mozversion application_vendor: Mozilla 08:24:04 INFO - mozversion application_version: 52.0a2 08:24:04 INFO - mozversion platform_buildid: 20170122071525 08:24:04 INFO - mozversion platform_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 08:24:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:24:04 INFO - mozversion platform_version: 52.0a2 08:24:04 INFO - using testdate: 1485102244 08:24:04 INFO - actual date: 1485102244 08:24:04 INFO - starting webserver on 'localhost:49243' 08:24:04 INFO - SUITE-START | Running 2 tests 08:24:04 INFO - TEST-START | dromaeo_css 08:24:04 INFO - operating with platform_type : mac_ 08:24:04 INFO - Initialising browser for dromaeo_css test... 08:24:04 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpsm8HyA/profile http://localhost:49243/getInfo.html) 08:24:07 INFO - PROCESS | 1652 | 2017-01-22 08:24:07.669 plugin-container[1654:13323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 08:24:07 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:07 INFO - PROCESS | 1652 | 2017-01-22 08:24:07.675 plugin-container[1654:13323] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 08:24:07 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:07 INFO - PROCESS | 1652 | 2017-01-22 08:24:07.675 plugin-container[1654:13323] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:24:07 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:24:07 INFO - PROCESS | 1652 | colorDepth:24 08:24:07 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:24:07 INFO - PROCESS | 1652 | __metrics 08:24:07 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:24:08 INFO - TEST-INFO | 1652: exit 0 08:24:08 INFO - Browser initialized. 08:24:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:24:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpsm8HyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:11 INFO - PROCESS | 1656 | 2017-01-22 08:24:11.560 plugin-container[1657:13458] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 08:24:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:11 INFO - PROCESS | 1656 | 2017-01-22 08:24:11.561 plugin-container[1657:13458] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:24:11 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:24:11 INFO - PROCESS | 1656 | 2017-01-22 08:24:11.561 plugin-container[1657:13458] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:24:21 INFO - PROCESS | 1656 | RSS: Main: 228499456 08:24:21 INFO - PROCESS | 1656 | 08:27:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:27:25 INFO - PROCESS | 1656 | RSS: Main: 233656320 08:27:25 INFO - PROCESS | 1656 | 08:30:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:30:28 INFO - PROCESS | 1656 | RSS: Main: 241676288 08:30:28 INFO - PROCESS | 1656 | 08:33:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:33:30 INFO - PROCESS | 1656 | RSS: Main: 249503744 08:33:30 INFO - PROCESS | 1656 | 08:36:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:36:33 INFO - PROCESS | 1656 | RSS: Main: 248877056 08:36:33 INFO - PROCESS | 1656 | 08:39:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:39:36 INFO - PROCESS | 1656 | RSS: Main: 253452288 08:39:36 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:42:39 INFO - PROCESS | 1656 | RSS: Main: 255721472 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | __start_tp_report 08:42:39 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 08:42:39 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 08:42:39 INFO - PROCESS | 1656 | |i|pagename|runs| 08:42:39 INFO - PROCESS | 1656 | |0;dojo.html;3295.5386245925574;3296.1430028192667;3313.7183339416156;3319.468884978404;3341.79949203048;5385.21914322423;5489.588280878935;5557.444255574441;5562.276904002484;5589.636673616212;5572.637778544392;5631.915521267184;5659.462351076651;5681.119426488891;5717.285339332583;5115.514026167518;5124.461931497195;5205.791768329281;5245.816396426126;5251.396089449705;5213.296205012312;5233.476652334755;5241.8427447176455;5254.500822421864;5276.525112739852;5058.468860769622;5066.620003499734;5208.817691380802;5224.033553792541;5260.132078207092;5117.385913690362;5139.12634852076;5190.24741412493;5222.738863056832;5285.7885684572575;5069.695818250917;5134.306868572732;5146.279520867081;5174.327337446146;5257.185136303879;5375.247465354853;5602.075657516505;5612.186232996192;5648.519875810561;5677.9495793278375;5930.8813823723285;5998.640081595075;6002.519798416116;6034.155218269446;6050.062240352752;6116;6127.877442451126;6156.78451254204;6211.099390588384;6231.532635052389;5712.8000519982015;5717.571182161355;5725.227094342211;5736.569757268222;5752;6088.056351265473;6133.977404287646;6138.38839838597;6168.259808822881;6206.844828879314;4963.950360496421;5209.6874187548865;5981.013132833121;5995.130706047598;6018.518518518508;6112.816615501542;6152.630842149485;6167.599106058092;6173.197484327009;6190.226221722285;5918.319393269829;5928.199693041471;6043.2748070231855;6081.75672973085;6096.146539484475;6140.478059365004;6154.9384506154365;6182.6599537024995;6184.938150618526;6202.968985155136;4881.487443818419;4883.853484395474;4885.389326334208;4886.657933944661;4907.9263811042865;4241.448611680462;4249.6387807036745;4293.613574778285;4308.719933204332;4392.604665580113;4988.6507944444265;5502.504774570228;5670.716464176775;5677.034904066319;5711.971440142773;6067.24159480065;6118.265808103056;6136.29432615255;6153.7230824613;6161;5509.173623956439;5616.943830561724;5649.152627105967;5663.603547751618;5665.461781130786;5264.289320941624;5282.841514754564;5298.523132917979;5305.920411193835;5311.973440132774;6209.813705588839;6219.502439804804;6226.750929962751;6227.875442491034;6247.094171345129;4933.58064564516;5956.463918247378;5994.820155395345;6016.187814644967;6160.722767475385;6164.845878853064;6207.782727604512;6208.50331973432;6226.59527130735;6228.5951413158;5960.5827592068135;5988.311344195473;5996.968609150035;5999.010163323177;6019.608725432833;5998.160257564032;6088.360722124113;6090.086487026982;6104.4505994460715;6105.297890742621;5764.682942438206;5822.243108395882;5894.440028197314;5935.169076329231;5956.523478121827;5947.91078133837;5951.464368206882;5965.2245208124405;5969.194158788681;5970.194023806731;5697.4302569742695;5821.330546987151;5872.060470324727;5874.823755287348;5906.497947674496;5818.796342128006;5848.4151584841175;5904.380040095728;5938.168656388023;6017.3681763414215;5852.356240813592;5855.38518455556;5891.410858914246;5899.439553242435;5901.911471327848 08:42:39 INFO - PROCESS | 1656 | |1;ext.html;469.87548299700563;511.1974200505207;533.8318429694648;541.7404534457388;561.3460318728681;38861.80569097154;40922;40978.59021409785;43342.56657433425;43497.565024349744;36275.09312267188;36477.27045459089;36541.81729091351;36593.81703091481;36712.449313260324;9270.860937085932;9403.858942115874;9417.387869788476;9440.433573985549;9454.763630909214;9118;9188.402753821014;9219;9247.44515329079;9263.444193348387;8250.422470427073;9103.135202155785;9237.538123093853;9243.861342079874;9256.398334108295;7971.481853679521;7986.4010199235;9213.81572368549;9236.72289831306;9260.166585007382;8554.05905350411;8805.471671699719;9325.813483730288;9338.719838404792;9364.859527107099;40146.39780403296;40214.79355619336;40603.7969810152;40636.79681601573;40704.38943415851;3310.735141188723;3334.583177102862;3337.4493208620547;3436.570428696413;3509.7192224621967;28717;28809;29463.410731785458;29910.102696919126;30029.69970300291;3045.710657487535;3150.5116706910467;3160.8577614007195;3162.810231386124;3165.398574270904;504790;506622;509593;511667.44166279305;511752;62846;63285;63858.72282554323;63866.68066659637;64020.35979640237;65768;65776.34223657798;66713;66890;66940.6652966732;16373.83626163723;16567.917160414363;16581.91709041447;16587.668246635;16651.83437159387;12535.686607834878;12633.98928085751;12641.936790316173;12643.051771117203;12654;17685.801210256937;19010.71483927742;19096.140673669717;19126.043697815054;19211.655184136976;7638;7680;7867.763967080997;7892.447528672938;7899.985503696521;846.585173265108;963.7494251494662;998.236349192868;1036.5750042482546;1063.5639387850945;29932.85033574862;30388.639686253966;30424;30842.383152336828;31131.533027004614;968.3463662028103;1013.7581462708271;1023.4677967457029;1036.18659352408;1057.281048886749;12401.13192076564;15281.235938203044;15634.3746250151;15861.52415427539;16046.919765401099;665185;671549;672055;673137;674523;58892.82214355689;59676;59825.10262346068;59843.40156598378;59911.70044149838;1330.1420583723639;1343.879050885425;1365.6244532753572;1366.3100134432248;1370.6436326555167;25818.354541135872;29344.853275733483;30161.849190753906;30517.542236866022;30741.077767667004;52330.47669523256;52691.41925742234;52759.94480110453;52918;52956.205656914404;466905;467391;470319;470606;470648;26810.731892680822;26813.597796033464;26954.73045269522;27281.59077613877;27332.043378481656;46537.30194047024;46954.35659751892;47696.523034770595;47851;48523.27215091847;38209;39426;39570.60429395669;40712.18575628412;40848.38727419032;38753.612463875;38929.80535097307;39213;40083.59916400799;40095.3985690209;38128.809355953046;38363.80818096003;39112.6088739109;39172.21655566816;40857.38713919234;32010.879619213214;34705.65294347024;34906.6037358513;35236.47145292874;35258.471122932664;24852.130175443774;25699.972001119746;25890.61164082578;25907.352316192246;26549 08:42:39 INFO - PROCESS | 1656 | |2;jquery.html;315.45111505979594;356.1186064490385;365.04540626262315;379.645031895178;383.2641328648997;17304.56738581536;18177.81822181778;18676.159572819222;19099.71350429741;19611.11749971253;18869.339573114943;19052.523686907833;19141.521461963424;19623.920684362354;19691.818490890557;5705.172749951254;5922.615030023035;5934.732937017845;5941.138534912435;5941.465268125868;4943.184374578191;5633.239512665799;5753.942460575383;5771.81677756059;5833.533317334603;5745.683987380692;5770.105633626774;5774.2782152230975;5784.363719990798;5786.247787787603;5503.7798488060425;5626.015447296707;5708.20085188074;5771.249737534094;5780.219670344512;4329.372241025065;4823.686460380064;5085.720285384303;5087.669301495391;5094.592432605383;24253.636195457082;24342.904569294424;24561;24735.876320618463;24810.627840582405;2198.6372248579123;2229.687843701883;2278.7493375728654;2316.4324740438533;2963.5774828082426;14465.059771114844;14552.345144468525;14961.925190374088;15137.470188543459;15858.444954426655;1676.639522502668;1769.1331247688668;1772.5480002599384;1811.1397086383995;1865.1327132883139;100176.49911750467;120704;120914;122414.38792805979;123104.76895231112;10442.738931526772;10661.520231589597;11184.552617895193;11268.661940141808;11300.604478843201;13721.039527233197;13732.038757286895;13755.587332380044;13758.93120534391;13766.105203161762;8202.630881610341;8410.705625303084;8464.111268316861;8542.871856922151;8603.31173506118;6806.523543351917;7651.234876512415;7863.37093032556;8474;8585;5515.917261241085;5936.762529498858;6234.127222188898;6501.804945851537;6596.977468492295;1583.2716950203035;1641.5239580521754;1744.5115367697065;1849.8057703940892;1888.773347198345;755.920628334028;798.3652995868299;823.3289868756943;858.1890113842359;934.6448349627099;18397.804142730678;18803.811961880205;19494.537909656832;19646.017699114986;20184.394468165978;920.1626519866888;943.7829299261208;968.375397868385;987.2398253345028;1003.3327836988321;11118.444077796077;11569.595064172714;11612.825807612893;11644.010259128068;11656.650300491;520627;552408.8851834264;608743;619721;624305;77310.61344693354;78172.43655126865;109055.45472272587;113686;115295;922.1792604581927;941.764558860285;988.3526290279734;990.0248255468358;993.7118235711707;17256.741148882527;18691.345802896834;19013.23947042158;19020.714689279393;19089.427317180507;56963;58227;58398.54003649943;59710.40289597222;59746.40253597582;78086.6095669518;79934;80857;83490;89648.5517572408;6548.8035358939305;7836.451448398558;7893.17121702236;8058.3150432213915;8323.750287491384;11773.117016223989;12410.937945310578;12887.226766394046;13039.934800325938;13094.738105237651;11056.944715276371;11071.5571377144;11114.666560003212;11465;11573.363465009505;10770.299930504492;10847.783044339227;11221.943890280496;11236.606718765132;11238.831417528907;9561.760955976157;11424.771504570028;11540.596079137189;11909.047276217709;11968.581099661471;7078.1860086090755;7479.214682458482;7497.137829149499;7652.502587331805;8201.876971845546;9730.464824434725;11335.546578136782;11368.658940231806;11613.245139065933;11637.941810290895 08:42:39 INFO - PROCESS | 1656 | |3;mootools.html;1430.9284535773209;1462.4004158295102;1467.3323637744825;1631.7144499712547;1862.1620270878109;7584.507007044538;7859.410544209179;8114.55369954653;8527.44571602847;8564.657413703451;7962.880556791652;8269.21442462965;8276.296514796235;8386.664533418656;8425.199606037417;2293.449572102696;2329.3477826208605;2332.24202134307;2332.323626148415;2339.087755775249;2315.7452680205247;2343.5078633486987;2364.6334818103137;2374.76252374762;2380.9166679166233;2303.8617682938993;2310.09906136606;2335.369450248432;2337.3689103941924;2338.462153704649;2263.7283525976823;2269.5914735347633;2295.2900089433397;2299.471121642015;2313.9190128345426;1979.990100049505;2281.8060464860505;2347.1550241912896;2350.0364850411247;2353.9411514712097;8475.449095808754;8520.914790852074;8528.488290702579;8537.231649151607;8585.141485851365;4255.468066491689;5055.545000949895;5189.091908915924;5207.192885102815;5216.321878155815;2803.8457884816326;2962.481565725989;3015.3969206158636;3030.530267808493;3290.391277613649;1045.864037675105;1065.4779158212498;1076;1085.8642669666292;1098.1434481104752;10995.725106872313;11074.557017719282;11109;11156.386398748065;11209.775804483865;4494.52807455219;4569.177548041384;4656.3946686930485;4663.300504924221;4730.385049943486;9383.906160938302;9452.338336316392;9453.952730236442;9461.432314061178;9471.952640236756;5181.06740786662;5196.4803519648485;5197.714125723046;5198.792048318101;5257.76340064698;4030.5364883038824;4163.375493675912;4601.67788254819;4714.57568818808;4776.426828780499;3776.4146557283666;3806.143617686054;3871.845126194977;3889.0471834400755;3922.5685174630767;1268.0679700420185;1268.6891711530734;1271.5740227023866;1282.5254655777421;1287.4528325461642;777.3742137579189;849.8130411309502;870.2960498505587;880.0847118996172;881.0088650268448;5318.547923426475;5544.306961629796;5546.584006199551;5558.027345214571;5569.331680198402;439.97924814430854;442.6547293111378;447.1548772819374;447.89698369374577;456.3178048816973;3392.7964322140256;3613.584437789688;3644.927101457956;3685.5208822852856;3737.5328083989502;9939.602415903428;10161.847572286422;10311.432871192006;10323.896761032443;10345.586176552853;10266.897331026594;10276.486175691185;10293.639722609672;10315.020073093045;10318.845217321747;7480.8877866832045;7779.844403111906;7884.566348850868;7918.168592297841;7962.6416811243635;5511.696856672921;5582.190582365615;5716.228309178374;5735.97132014354;5773.3072031356505;9220.077992200726;9344.813103737752;9347.813043738952;9415.05849415053;9428.905710942803;9506.762330941505;9534.570944307385;9540;9624.66313679018;9628.229741620793;6536.444402225864;6770.830729231809;7038.542494737826;7207.099112610924;7320.267973202637;7832.981712377355;8021.558814265271;8040.3969702273735;8061.717839875576;8085.272325490734;7101.2898710128575;7227.747028853965;7245.818854528468;7268.890966635399;7318.890216646861;5957.880842383041;7000.964995174992;7090.858182836418;7203.423726102004;7253.891191632235;6639.136912201383;6650.900236496554;6729.831754206184;6730.966345168243;6739.393454589111;4786.282057691375;4796.688215265996;4844.346013288161;4870.683405578626;4890.290907818276;4702.952970470252;4783.330333753208;4852.878678033077;4881.731504767272;4904.542297680198 08:42:39 INFO - PROCESS | 1656 | |4;prototype.html;298.06259314456037;301.2709243630415;307.8568465663467;308.4355629198567;312.32070247212306;4823.903521929564;4988.725620090893;5234.555062819665;5359.839204823852;5561.6106872518885;4050.6151915567975;4635.327877457767;5035.697858128515;5319.760610772515;5359.919601205976;3397.6432474590183;4088.9795551022203;4117.044403908149;4133.3386658134705;4153.262064142266;3413.692767650911;3491.8603255869734;3507.6492350764975;4142.565030671782;4148.361397248101;3428.982855085721;3448.4482482802755;3536.982315088421;3820.369639009574;4084.5915408459214;4050.8605830481465;4063.8984025399304;4069.064115253508;4085.4484644573195;4103.322951712964;3538;3559.715222782171;3571.4285714285847;3590.9281814363567;3592.209713862946;4684.8287928018;4925.064237794808;5179.741012949337;5281.234221037967;5311.840644780663;4217.8523751668545;4324.308110702304;4624.075184963021;4626.699264547828;4641.327007583882;5678.716064196815;5686.857828554278;5693.829185124453;5707.429257074301;5725.713714314309;3190.7766456348063;3489.040513858684;3791.279656865187;3828.2726282006606;3864.623256697111;5571.331440227158;5858.209141765849;5941.673207973559;6041.395860413967;6053.364396738323;4082.4896887889013;4085.8774236772942;4097.815598298083;4098.774567398762;4106.3429851224255;3226.467632840555;4065.5527891931865;4119.7940102994735;4138.048248902769;4168.312228482328;4718.787654555554;4724.645651576146;4730.455997560324;4741.668083234141;4753.6452111148155;5269;5704.286964129484;5758.280214973129;5786.594938354359;5804.709764511757;1100;1236.9300555020022;1310.737852429518;1326.9336533173303;1330.813686083949;824.8432797768405;921.9167478213207;923.1122354784482;926.1109335038304;931.9207867331218;4548.636109111263;4904.411470623548;5004.574611158092;5049.26785616091;5067.493250674903;5240.764165612557;5460.6177567569885;5485.094959331665;5496.450354964471;5514.283143191359;4015.0966032643005;4239.703220774578;4669.859904202879;5045.779856862969;5066.113430149783;2678.383971686484;2820.8871645134377;2908.5055540558155;2912.956305655417;2923.912282631482;5687.066397424813;5698.205065404384;5730.7421166047625;5743.4543718346695;5749.9425005750245;4917.852464426073;5332.786688532493;5607.383187849333;5635.6618602883955;5642.943570564324;4956.628252880976;5070.366204224472;5656.745446455002;5686.3744988051285;5714;4679.081576553596;4949.57928576075;5445.59158063139;5487.588430867621;5500.257465242141;4482.798274077609;5355.97322013403;5435.619506634655;5859.384764599656;5863;6154.415330543591;6181.412765787243;6188.658124612839;6191.25704915413;6203.689815509297;3597.226596281812;3774.9811250944667;3933.3116704577155;3945.033466800652;3950.2099580083523;4736.4316282046375;5604.290691339181;5868.823935281948;5881.617694849821;5897.292324920865;5599.524040456444;5626.88746225065;5765.654060756368;5793;5831.8833623326445;4996.850094497171;5336.279602253646;5756.68338241384;5785.016547187072;5830.941690583039;5095.77069031887;5132.871678208075;5437;5572.387037425799;5680.829575112753;4768.690035147843;5706.372299047019;5732.627379220337;5759.078547432391;5762.971185144047;4867.853964381075;5570.749316280696;5576.944230557805;5598.3282006159525;5634.605577609528 08:42:39 INFO - PROCESS | 1656 | |5;yui.html;688.0985908459918;741.9814504637384;751.4814777803311;755.4032314471568;777.8677624803785;13939.512117075905;14636.41454341825;14665.413383464675;14668;14805.629859253524;11397.658070257905;12707.872921270784;13096;13253.271070091141;13271.867281327184;796.5181065455403;799.8520273749375;831.5925196653626;836.5900708652747;842.2630198576246;808.7856717969743;811.6834434570522;812.46377390922;812.8374325134997;813.1340122769261;842.0442797424936;852.6759831264111;854.8845905802699;858.0432817408607;859.4886042804521;849.2229609906927;849.8342823149488;851.5614458553849;853.2960307746104;854.4318028511033;629.908663243827;630.5397060146073;631.2551189596275;631.4096319940824;631.472720278568;14205;14224.715505689932;14254.92872535641;14288.071275367069;14300.928495357457;13223.140495867834;13440.731185376335;13459.12515686487;13461.596152115451;13597.660058498517;11253.493592788343;11330.830037549444;11486.023687986448;11516.94241528787;11714.765704685859;3582.4805403216387;3611.1874828163454;3613.4941108244866;3620.149264922741;3698.537682789651;92935.07064929332;93236;93696.53151734266;94679;96005.51997240039;10095.04097110788;10346.741331466774;10391.688249352532;10420;10437.478126093816;19045.428637140907;19708.40874773759;19850;19998.300059497848;20020.69968950467;7707.961460192775;7780.533168009937;7887.566183859943;7887.921120788834;7940.404469664682;4199.517055538591;4339.826406943687;4430.401895744098;4452.109578084396;4457.264551349056;3415.18035671442;3476.704480119168;3523.2777280657406;3533.911652208664;3538.575370955502;645.4578154350369;651.4495251512465;657.4805903336311;668.2982867988593;673.3703986772383;502.48244308362445;532.8135152696602;578.8625351184942;606.58145879344;634.3149398649448;8908.554572271361;9024.323175761843;9147.108703977232;9173.862392064124;9311.208547273422;560.9298837645294;604.2024527623582;626.5457543281176;648.3548868875499;672.9158855143107;4382.715123516961;4481.731096134243;4503.684742068024;4511.70673906195;4622.2835460503;109393;118437;119179;120575;122150;84931.57534212412;85273.57363213268;95264.0473595269;97962.51018744861;100906.4954675222;82018.58990705128;82715.17284827195;85289;88423.67364489537;91209;6988.720451181895;7632.618369081635;8031.277185053374;8720.43317184381;8846.646134154562;55636.609084773205;55790.884182316935;56790.432095678516;56860;58151.70924145352;67228.32771672221;69169.30830691628;72822.63588682022;73158;76517.61741191258;11644.825327620261;12391.132620716464;12444.440000199831;12571.685707857378;12880.935595322338;13574.728505430034;13846.446142154202;13877.583672489842;14237.786433203302;14263.64340891486;11355.659330220107;12247.938760306142;13249.271290079138;13255.403506842022;13617.387217575431;13034.08761386694;13056.608301750963;13101.017423693453;13280.003999699868;13346.933265333611;11175.38535380562;11593.594224202112;12537.310447925453;12998;13056.543020994219;10310.896891031294;11081.058110060412;11158.107351411705;11244.550217991517;11511.712207194887;9230.538473076454;9697.709068727949;10045.69862904114;10186.625580875285;10223.233257505866 08:42:39 INFO - PROCESS | 1656 | __end_tp_report 08:42:39 INFO - PROCESS | 1656 | __start_cc_report 08:42:39 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,364 08:42:39 INFO - PROCESS | 1656 | __end_cc_report 08:42:39 INFO - PROCESS | 1656 | __startTimestamp1485103359758__endTimestamp 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | ------- Summary: start ------- 08:42:39 INFO - PROCESS | 1656 | Number of tests: 6 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5622.59 Median:5822.24 stddev:615.98 (10.6%) stddev-sans-first:590.20 08:42:39 INFO - PROCESS | 1656 | Values: 3295.5 3296.1 3313.7 3319.5 3341.8 5385.2 5489.6 5557.4 5562.3 5589.6 5572.6 5631.9 5659.5 5681.1 5717.3 5115.5 5124.5 5205.8 5245.8 5251.4 5213.3 5233.5 5241.8 5254.5 5276.5 5058.5 5066.6 5208.8 5224.0 5260.1 5117.4 5139.1 5190.2 5222.7 5285.8 5069.7 5134.3 5146.3 5174.3 5257.2 5375.2 5602.1 5612.2 5648.5 5677.9 5930.9 5998.6 6002.5 6034.2 6050.1 6116.0 6127.9 6156.8 6211.1 6231.5 5712.8 5717.6 5725.2 5736.6 5752.0 6088.1 6134.0 6138.4 6168.3 6206.8 4964.0 5209.7 5981.0 5995.1 6018.5 6112.8 6152.6 6167.6 6173.2 6190.2 5918.3 5928.2 6043.3 6081.8 6096.1 6140.5 6154.9 6182.7 6184.9 6203.0 4881.5 4883.9 4885.4 4886.7 4907.9 4241.4 4249.6 4293.6 4308.7 4392.6 4988.7 5502.5 5670.7 5677.0 5712.0 6067.2 6118.3 6136.3 6153.7 6161.0 5509.2 5616.9 5649.2 5663.6 5665.5 5264.3 5282.8 5298.5 5305.9 5312.0 6209.8 6219.5 6226.8 6227.9 6247.1 4933.6 5956.5 5994.8 6016.2 6160.7 6164.8 6207.8 6208.5 6226.6 6228.6 5960.6 5988.3 5997.0 5999.0 6019.6 5998.2 6088.4 6090.1 6104.5 6105.3 5764.7 5822.2 5894.4 5935.2 5956.5 5947.9 5951.5 5965.2 5969.2 5970.2 5697.4 5821.3 5872.1 5874.8 5906.5 5818.8 5848.4 5904.4 5938.2 6017.4 5852.4 5855.4 5891.4 5899.4 5901.9 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:68866.10 Median:40409.30 stddev:148754.46 (368.1%) stddev-sans-first:149083.12 08:42:39 INFO - PROCESS | 1656 | Values: 469.9 511.2 533.8 541.7 561.3 38861.8 40922.0 40978.6 43342.6 43497.6 36275.1 36477.3 36541.8 36593.8 36712.4 9270.9 9403.9 9417.4 9440.4 9454.8 9118.0 9188.4 9219.0 9247.4 9263.4 8250.4 9103.1 9237.5 9243.9 9256.4 7971.5 7986.4 9213.8 9236.7 9260.2 8554.1 8805.5 9325.8 9338.7 9364.9 40146.4 40214.8 40603.8 40636.8 40704.4 3310.7 3334.6 3337.4 3436.6 3509.7 28717.0 28809.0 29463.4 29910.1 30029.7 3045.7 3150.5 3160.9 3162.8 3165.4 504790.0 506622.0 509593.0 511667.4 511752.0 62846.0 63285.0 63858.7 63866.7 64020.4 65768.0 65776.3 66713.0 66890.0 66940.7 16373.8 16567.9 16581.9 16587.7 16651.8 12535.7 12634.0 12641.9 12643.1 12654.0 17685.8 19010.7 19096.1 19126.0 19211.7 7638.0 7680.0 7867.8 7892.4 7900.0 846.6 963.7 998.2 1036.6 1063.6 29932.9 30388.6 30424.0 30842.4 31131.5 968.3 1013.8 1023.5 1036.2 1057.3 12401.1 15281.2 15634.4 15861.5 16046.9 665185.0 671549.0 672055.0 673137.0 674523.0 58892.8 59676.0 59825.1 59843.4 59911.7 1330.1 1343.9 1365.6 1366.3 1370.6 25818.4 29344.9 30161.8 30517.5 30741.1 52330.5 52691.4 52759.9 52918.0 52956.2 466905.0 467391.0 470319.0 470606.0 470648.0 26810.7 26813.6 26954.7 27281.6 27332.0 46537.3 46954.4 47696.5 47851.0 48523.3 38209.0 39426.0 39570.6 40712.2 40848.4 38753.6 38929.8 39213.0 40083.6 40095.4 38128.8 38363.8 39112.6 39172.2 40857.4 32010.9 34705.7 34906.6 35236.5 35258.5 24852.1 25700.0 25890.6 25907.4 26549.0 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34053.01 Median:13887.10 stddev:97504.54 (702.1%) stddev-sans-first:97745.16 08:42:39 INFO - PROCESS | 1656 | Values: 315.5 356.1 365.0 379.6 383.3 17304.6 18177.8 18676.2 19099.7 19611.1 18869.3 19052.5 19141.5 19623.9 19691.8 5705.2 5922.6 5934.7 5941.1 5941.5 4943.2 5633.2 5753.9 5771.8 5833.5 5745.7 5770.1 5774.3 5784.4 5786.2 5503.8 5626.0 5708.2 5771.2 5780.2 4329.4 4823.7 5085.7 5087.7 5094.6 24253.6 24342.9 24561.0 24735.9 24810.6 2198.6 2229.7 2278.7 2316.4 2963.6 14465.1 14552.3 14961.9 15137.5 15858.4 1676.6 1769.1 1772.5 1811.1 1865.1 100176.5 120704.0 120914.0 122414.4 123104.8 10442.7 10661.5 11184.6 11268.7 11300.6 13721.0 13732.0 13755.6 13758.9 13766.1 8202.6 8410.7 8464.1 8542.9 8603.3 6806.5 7651.2 7863.4 8474.0 8585.0 5515.9 5936.8 6234.1 6501.8 6597.0 1583.3 1641.5 1744.5 1849.8 1888.8 755.9 798.4 823.3 858.2 934.6 18397.8 18803.8 19494.5 19646.0 20184.4 920.2 943.8 968.4 987.2 1003.3 11118.4 11569.6 11612.8 11644.0 11656.7 520627.0 552408.9 608743.0 619721.0 624305.0 77310.6 78172.4 109055.5 113686.0 115295.0 922.2 941.8 988.4 990.0 993.7 17256.7 18691.3 19013.2 19020.7 19089.4 56963.0 58227.0 58398.5 59710.4 59746.4 78086.6 79934.0 80857.0 83490.0 89648.6 6548.8 7836.5 7893.2 8058.3 8323.8 11773.1 12410.9 12887.2 13039.9 13094.7 11056.9 11071.6 11114.7 11465.0 11573.4 10770.3 10847.8 11221.9 11236.6 11238.8 9561.8 11424.8 11540.6 11909.0 11968.6 7078.2 7479.2 7497.1 7652.5 8201.9 9730.5 11335.5 11368.7 11613.2 11637.9 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5441.58 Median:4861.78 stddev:3057.78 (62.9%) stddev-sans-first:3051.51 08:42:39 INFO - PROCESS | 1656 | Values: 1430.9 1462.4 1467.3 1631.7 1862.2 7584.5 7859.4 8114.6 8527.4 8564.7 7962.9 8269.2 8276.3 8386.7 8425.2 2293.4 2329.3 2332.2 2332.3 2339.1 2315.7 2343.5 2364.6 2374.8 2380.9 2303.9 2310.1 2335.4 2337.4 2338.5 2263.7 2269.6 2295.3 2299.5 2313.9 1980.0 2281.8 2347.2 2350.0 2353.9 8475.4 8520.9 8528.5 8537.2 8585.1 4255.5 5055.5 5189.1 5207.2 5216.3 2803.8 2962.5 3015.4 3030.5 3290.4 1045.9 1065.5 1076.0 1085.9 1098.1 10995.7 11074.6 11109.0 11156.4 11209.8 4494.5 4569.2 4656.4 4663.3 4730.4 9383.9 9452.3 9454.0 9461.4 9472.0 5181.1 5196.5 5197.7 5198.8 5257.8 4030.5 4163.4 4601.7 4714.6 4776.4 3776.4 3806.1 3871.8 3889.0 3922.6 1268.1 1268.7 1271.6 1282.5 1287.5 777.4 849.8 870.3 880.1 881.0 5318.5 5544.3 5546.6 5558.0 5569.3 440.0 442.7 447.2 447.9 456.3 3392.8 3613.6 3644.9 3685.5 3737.5 9939.6 10161.8 10311.4 10323.9 10345.6 10266.9 10276.5 10293.6 10315.0 10318.8 7480.9 7779.8 7884.6 7918.2 7962.6 5511.7 5582.2 5716.2 5736.0 5773.3 9220.1 9344.8 9347.8 9415.1 9428.9 9506.8 9534.6 9540.0 9624.7 9628.2 6536.4 6770.8 7038.5 7207.1 7320.3 7833.0 8021.6 8040.4 8061.7 8085.3 7101.3 7227.7 7245.8 7268.9 7318.9 5957.9 7001.0 7090.9 7203.4 7253.9 6639.1 6650.9 6729.8 6731.0 6739.4 4786.3 4796.7 4844.3 4870.7 4890.3 4703.0 4783.3 4852.9 4881.7 4904.5 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4529.23 Median:5020.14 stddev:1408.47 (28.1%) stddev-sans-first:1376.15 08:42:39 INFO - PROCESS | 1656 | Values: 298.1 301.3 307.9 308.4 312.3 4823.9 4988.7 5234.6 5359.8 5561.6 4050.6 4635.3 5035.7 5319.8 5359.9 3397.6 4089.0 4117.0 4133.3 4153.3 3413.7 3491.9 3507.6 4142.6 4148.4 3429.0 3448.4 3537.0 3820.4 4084.6 4050.9 4063.9 4069.1 4085.4 4103.3 3538.0 3559.7 3571.4 3590.9 3592.2 4684.8 4925.1 5179.7 5281.2 5311.8 4217.9 4324.3 4624.1 4626.7 4641.3 5678.7 5686.9 5693.8 5707.4 5725.7 3190.8 3489.0 3791.3 3828.3 3864.6 5571.3 5858.2 5941.7 6041.4 6053.4 4082.5 4085.9 4097.8 4098.8 4106.3 3226.5 4065.6 4119.8 4138.0 4168.3 4718.8 4724.6 4730.5 4741.7 4753.6 5269.0 5704.3 5758.3 5786.6 5804.7 1100.0 1236.9 1310.7 1326.9 1330.8 824.8 921.9 923.1 926.1 931.9 4548.6 4904.4 5004.6 5049.3 5067.5 5240.8 5460.6 5485.1 5496.5 5514.3 4015.1 4239.7 4669.9 5045.8 5066.1 2678.4 2820.9 2908.5 2913.0 2923.9 5687.1 5698.2 5730.7 5743.5 5749.9 4917.9 5332.8 5607.4 5635.7 5642.9 4956.6 5070.4 5656.7 5686.4 5714.0 4679.1 4949.6 5445.6 5487.6 5500.3 4482.8 5356.0 5435.6 5859.4 5863.0 6154.4 6181.4 6188.7 6191.3 6203.7 3597.2 3775.0 3933.3 3945.0 3950.2 4736.4 5604.3 5868.8 5881.6 5897.3 5599.5 5626.9 5765.7 5793.0 5831.9 4996.9 5336.3 5756.7 5785.0 5830.9 5095.8 5132.9 5437.0 5572.4 5680.8 4768.7 5706.4 5732.6 5759.1 5763.0 4867.9 5570.7 5576.9 5598.3 5634.6 08:42:39 INFO - PROCESS | 1656 | 08:42:39 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20800.31 Median:4492.71 stddev:30985.56 (689.7%) stddev-sans-first:31035.69 08:42:39 INFO - PROCESS | 1656 | Values: 688.1 742.0 751.5 755.4 777.9 13939.5 14636.4 14665.4 14668.0 14805.6 11397.7 12707.9 13096.0 13253.3 13271.9 796.5 799.9 831.6 836.6 842.3 808.8 811.7 812.5 812.8 813.1 842.0 852.7 854.9 858.0 859.5 849.2 849.8 851.6 853.3 854.4 629.9 630.5 631.3 631.4 631.5 14205.0 14224.7 14254.9 14288.1 14300.9 13223.1 13440.7 13459.1 13461.6 13597.7 11253.5 11330.8 11486.0 11516.9 11714.8 3582.5 3611.2 3613.5 3620.1 3698.5 92935.1 93236.0 93696.5 94679.0 96005.5 10095.0 10346.7 10391.7 10420.0 10437.5 19045.4 19708.4 19850.0 19998.3 20020.7 7708.0 7780.5 7887.6 7887.9 7940.4 4199.5 4339.8 4430.4 4452.1 4457.3 3415.2 3476.7 3523.3 3533.9 3538.6 645.5 651.4 657.5 668.3 673.4 502.5 532.8 578.9 606.6 634.3 8908.6 9024.3 9147.1 9173.9 9311.2 560.9 604.2 626.5 648.4 672.9 4382.7 4481.7 4503.7 4511.7 4622.3 109393.0 118437.0 119179.0 120575.0 122150.0 84931.6 85273.6 95264.0 97962.5 100906.5 82018.6 82715.2 85289.0 88423.7 91209.0 6988.7 7632.6 8031.3 8720.4 8846.6 55636.6 55790.9 56790.4 56860.0 58151.7 67228.3 69169.3 72822.6 73158.0 76517.6 11644.8 12391.1 12444.4 12571.7 12880.9 13574.7 13846.4 13877.6 14237.8 14263.6 11355.7 12247.9 13249.3 13255.4 13617.4 13034.1 13056.6 13101.0 13280.0 13346.9 11175.4 11593.6 12537.3 12998.0 13056.5 10310.9 11081.1 11158.1 11244.6 11511.7 9230.5 9697.7 10045.7 10186.6 10223.2 08:42:39 INFO - PROCESS | 1656 | -------- Summary: end -------- 08:42:39 INFO - PROCESS | 1656 | 08:42:40 INFO - TEST-INFO | 1656: exit 0 08:42:40 INFO - TEST-OK | dromaeo_css | took 1115956ms 08:42:40 INFO - TEST-START | kraken 08:42:40 INFO - operating with platform_type : mac_ 08:42:40 INFO - Initialising browser for kraken test... 08:42:40 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp7nScp8/profile http://localhost:49243/getInfo.html) 08:42:43 INFO - PROCESS | 1665 | 2017-01-22 08:42:43.605 plugin-container[1666:15712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 08:42:43 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:43 INFO - PROCESS | 1665 | 2017-01-22 08:42:43.609 plugin-container[1666:15712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 08:42:43 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:43 INFO - PROCESS | 1665 | 2017-01-22 08:42:43.610 plugin-container[1666:15712] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:42:43 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 08:42:43 INFO - PROCESS | 1665 | colorDepth:24 08:42:43 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 08:42:43 INFO - PROCESS | 1665 | __metrics 08:42:43 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:42:44 INFO - TEST-INFO | 1665: exit 0 08:42:44 INFO - Browser initialized. 08:42:44 INFO - Running cycle 1/1 for kraken test... 08:42:44 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmp7nScp8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:47 INFO - PROCESS | 1667 | 2017-01-22 08:42:47.391 plugin-container[1668:15836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 08:42:47 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:47 INFO - PROCESS | 1667 | 2017-01-22 08:42:47.392 plugin-container[1668:15836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 08:42:47 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:47 INFO - PROCESS | 1667 | 2017-01-22 08:42:47.392 plugin-container[1668:15836] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:42:57 INFO - PROCESS | 1667 | RSS: Main: 229052416 08:42:57 INFO - PROCESS | 1667 | 08:43:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:43:00 INFO - PROCESS | 1667 | RSS: Main: 241164288 08:43:00 INFO - PROCESS | 1667 | 08:43:03 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:43:04 INFO - PROCESS | 1667 | RSS: Main: 249237504 08:43:04 INFO - PROCESS | 1667 | 08:43:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:43:07 INFO - PROCESS | 1667 | RSS: Main: 252948480 08:43:07 INFO - PROCESS | 1667 | 08:43:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:43:10 INFO - PROCESS | 1667 | RSS: Main: 253521920 08:43:10 INFO - PROCESS | 1667 | 08:43:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:43:13 INFO - PROCESS | 1667 | RSS: Main: 253407232 08:43:13 INFO - PROCESS | 1667 | 08:43:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:43:16 INFO - PROCESS | 1667 | RSS: Main: 258392064 08:43:16 INFO - PROCESS | 1667 | 08:43:19 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:43:20 INFO - PROCESS | 1667 | RSS: Main: 258113536 08:43:20 INFO - PROCESS | 1667 | 08:43:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:43:24 INFO - PROCESS | 1667 | RSS: Main: 258318336 08:43:24 INFO - PROCESS | 1667 | 08:43:25 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:43:26 INFO - PROCESS | 1667 | RSS: Main: 257306624 08:43:26 INFO - PROCESS | 1667 | 08:43:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:43:28 INFO - PROCESS | 1667 | RSS: Main: 257708032 08:43:28 INFO - PROCESS | 1667 | 08:43:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:43:31 INFO - PROCESS | 1667 | RSS: Main: 257327104 08:43:31 INFO - PROCESS | 1667 | 08:43:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:43:35 INFO - PROCESS | 1667 | RSS: Main: 257462272 08:43:35 INFO - PROCESS | 1667 | 08:43:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:43:39 INFO - PROCESS | 1667 | RSS: Main: 257605632 08:43:39 INFO - PROCESS | 1667 | 08:43:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:43:41 INFO - PROCESS | 1667 | RSS: Main: 259416064 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | __start_tp_report 08:43:41 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 08:43:41 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 08:43:41 INFO - PROCESS | 1667 | |i|pagename|runs| 08:43:41 INFO - PROCESS | 1667 | |0;ai-astar;106;118;119;121;117;119;121;118;119;121 08:43:41 INFO - PROCESS | 1667 | |1;audio-beat-detection;134;111;108;140;114;111;126;113;136;114 08:43:41 INFO - PROCESS | 1667 | |2;audio-dft;192;205;199;202;200;198;194;200;195;196 08:43:41 INFO - PROCESS | 1667 | |3;audio-fft;80;59;53;81;58;54;54;84;105;57 08:43:41 INFO - PROCESS | 1667 | |4;audio-oscillator;86;71;91;73;70;71;86;72;94;79 08:43:41 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;91;89;91;87;91;109;105;129;135;88 08:43:41 INFO - PROCESS | 1667 | |6;imaging-darkroom;100;101;100;100;138;145;167;169;171;102 08:43:41 INFO - PROCESS | 1667 | |7;imaging-desaturate;107;118;94;87;89;89;91;87;133;140 08:43:41 INFO - PROCESS | 1667 | |8;json-parse-financial;57;57;57;60;60;60;58;60;60;59 08:43:41 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;69;72;74;76;77;76;73;73;71;78 08:43:41 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;86;88;84;87;85;83;87;88;93;96 08:43:41 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;143;154;158;158;143;144;164;135;200;150 08:43:41 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;182;166;168;167;178;155;147;212;235;201 08:43:41 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;68;73;74;66;64;65;71;90;79;62 08:43:41 INFO - PROCESS | 1667 | __end_tp_report 08:43:41 INFO - PROCESS | 1667 | __start_cc_report 08:43:41 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,968 08:43:41 INFO - PROCESS | 1667 | __end_cc_report 08:43:41 INFO - PROCESS | 1667 | __startTimestamp1485103421030__endTimestamp 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | ------- Summary: start ------- 08:43:41 INFO - PROCESS | 1667 | Number of tests: 14 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:117.90 Median:119.00 stddev:4.41 (3.7%) stddev-sans-first:1.48 08:43:41 INFO - PROCESS | 1667 | Values: 106.0 118.0 119.0 121.0 117.0 119.0 121.0 118.0 119.0 121.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:120.00 stddev:12.07 (10.1%) stddev-sans-first:11.80 08:43:41 INFO - PROCESS | 1667 | Values: 134.0 111.0 108.0 140.0 114.0 111.0 126.0 113.0 136.0 114.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:198.10 Median:199.50 stddev:3.93 (2.0%) stddev-sans-first:3.49 08:43:41 INFO - PROCESS | 1667 | Values: 192.0 205.0 199.0 202.0 200.0 198.0 194.0 200.0 195.0 196.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:68.50 Median:58.50 stddev:17.81 (30.4%) stddev-sans-first:18.40 08:43:41 INFO - PROCESS | 1667 | Values: 80.0 59.0 53.0 81.0 58.0 54.0 54.0 84.0 105.0 57.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:82.50 stddev:9.19 (11.1%) stddev-sans-first:9.42 08:43:41 INFO - PROCESS | 1667 | Values: 86.0 71.0 91.0 73.0 70.0 71.0 86.0 72.0 94.0 79.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:88.50 stddev:17.72 (20.0%) stddev-sans-first:18.38 08:43:41 INFO - PROCESS | 1667 | Values: 91.0 89.0 91.0 87.0 91.0 109.0 105.0 129.0 135.0 88.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:129.30 Median:141.50 stddev:31.94 (22.6%) stddev-sans-first:32.07 08:43:41 INFO - PROCESS | 1667 | Values: 100.0 101.0 100.0 100.0 138.0 145.0 167.0 169.0 171.0 102.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:103.50 Median:88.00 stddev:20.10 (22.8%) stddev-sans-first:21.28 08:43:41 INFO - PROCESS | 1667 | Values: 107.0 118.0 94.0 87.0 89.0 89.0 91.0 87.0 133.0 140.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:60.00 stddev:1.40 (2.3%) stddev-sans-first:1.32 08:43:41 INFO - PROCESS | 1667 | Values: 57.0 57.0 57.0 60.0 60.0 60.0 58.0 60.0 60.0 59.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:75.00 stddev:2.85 (3.8%) stddev-sans-first:2.40 08:43:41 INFO - PROCESS | 1667 | Values: 69.0 72.0 74.0 76.0 77.0 76.0 73.0 73.0 71.0 78.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.50 stddev:4.00 (4.6%) stddev-sans-first:4.20 08:43:41 INFO - PROCESS | 1667 | Values: 86.0 88.0 84.0 87.0 85.0 83.0 87.0 88.0 93.0 96.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:154.90 Median:156.00 stddev:18.13 (11.6%) stddev-sans-first:18.71 08:43:41 INFO - PROCESS | 1667 | Values: 143.0 154.0 158.0 158.0 143.0 144.0 164.0 135.0 200.0 150.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:180.00 stddev:27.30 (15.2%) stddev-sans-first:28.96 08:43:41 INFO - PROCESS | 1667 | Values: 182.0 166.0 168.0 167.0 178.0 155.0 147.0 212.0 235.0 201.0 08:43:41 INFO - PROCESS | 1667 | 08:43:41 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:72.00 stddev:8.42 (11.7%) stddev-sans-first:8.85 08:43:41 INFO - PROCESS | 1667 | Values: 68.0 73.0 74.0 66.0 64.0 65.0 71.0 90.0 79.0 62.0 08:43:41 INFO - PROCESS | 1667 | -------- Summary: end -------- 08:43:41 INFO - PROCESS | 1667 | 08:43:42 INFO - TEST-INFO | 1667: exit 0 08:43:42 INFO - TEST-OK | kraken | took 61695ms 08:43:42 INFO - SUITE-END | took 1177s 08:43:42 INFO - Completed test suite (00:19:37) 08:43:42 INFO - javascript benchmark 08:43:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7152.275671612357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.5386245925574, 3296.1430028192667, 3313.7183339416156, 3319.468884978404, 3341.79949203048, 5385.21914322423, 5489.588280878935, 5557.444255574441, 5562.276904002484, 5589.636673616212, 5572.637778544392, 5631.915521267184, 5659.462351076651, 5681.119426488891, 5717.285339332583, 5115.514026167518, 5124.461931497195, 5205.791768329281, 5245.816396426126, 5251.396089449705, 5213.296205012312, 5233.476652334755, 5241.8427447176455, 5254.500822421864, 5276.525112739852, 5058.468860769622, 5066.620003499734, 5208.817691380802, 5224.033553792541, 5260.132078207092, 5117.385913690362, 5139.12634852076, 5190.24741412493, 5222.738863056832, 5285.7885684572575, 5069.695818250917, 5134.306868572732, 5146.279520867081, 5174.327337446146, 5257.185136303879, 5375.247465354853, 5602.075657516505, 5612.186232996192, 5648.519875810561, 5677.9495793278375, 5930.8813823723285, 5998.640081595075, 6002.519798416116, 6034.155218269446, 6050.062240352752, 6116.0, 6127.877442451126, 6156.78451254204, 6211.099390588384, 6231.532635052389, 5712.8000519982015, 5717.571182161355, 5725.227094342211, 5736.569757268222, 5752.0, 6088.056351265473, 6133.977404287646, 6138.38839838597, 6168.259808822881, 6206.844828879314, 4963.950360496421, 5209.6874187548865, 5981.013132833121, 5995.130706047598, 6018.518518518508, 6112.816615501542, 6152.630842149485, 6167.599106058092, 6173.197484327009, 6190.226221722285, 5918.319393269829, 5928.199693041471, 6043.2748070231855, 6081.75672973085, 6096.146539484475, 6140.478059365004, 6154.9384506154365, 6182.6599537024995, 6184.938150618526, 6202.968985155136, 4881.487443818419, 4883.853484395474, 4885.389326334208, 4886.657933944661, 4907.9263811042865, 4241.448611680462, 4249.6387807036745, 4293.613574778285, 4308.719933204332, 4392.604665580113, 4988.6507944444265, 5502.504774570228, 5670.716464176775, 5677.034904066319, 5711.971440142773, 6067.24159480065, 6118.265808103056, 6136.29432615255, 6153.7230824613, 6161.0, 5509.173623956439, 5616.943830561724, 5649.152627105967, 5663.603547751618, 5665.461781130786, 5264.289320941624, 5282.841514754564, 5298.523132917979, 5305.920411193835, 5311.973440132774, 6209.813705588839, 6219.502439804804, 6226.750929962751, 6227.875442491034, 6247.094171345129, 4933.58064564516, 5956.463918247378, 5994.820155395345, 6016.187814644967, 6160.722767475385, 6164.845878853064, 6207.782727604512, 6208.50331973432, 6226.59527130735, 6228.5951413158, 5960.5827592068135, 5988.311344195473, 5996.968609150035, 5999.010163323177, 6019.608725432833, 5998.160257564032, 6088.360722124113, 6090.086487026982, 6104.4505994460715, 6105.297890742621, 5764.682942438206, 5822.243108395882, 5894.440028197314, 5935.169076329231, 5956.523478121827, 5947.91078133837, 5951.464368206882, 5965.2245208124405, 5969.194158788681, 5970.194023806731, 5697.4302569742695, 5821.330546987151, 5872.060470324727, 5874.823755287348, 5906.497947674496, 5818.796342128006, 5848.4151584841175, 5904.380040095728, 5938.168656388023, 6017.3681763414215, 5852.356240813592, 5855.38518455556, 5891.410858914246, 5899.439553242435, 5901.911471327848], "value": 5584.19600195747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.87548299700563, 511.1974200505207, 533.8318429694648, 541.7404534457388, 561.3460318728681, 38861.80569097154, 40922.0, 40978.59021409785, 43342.56657433425, 43497.565024349744, 36275.09312267188, 36477.27045459089, 36541.81729091351, 36593.81703091481, 36712.449313260324, 9270.860937085932, 9403.858942115874, 9417.387869788476, 9440.433573985549, 9454.763630909214, 9118.0, 9188.402753821014, 9219.0, 9247.44515329079, 9263.444193348387, 8250.422470427073, 9103.135202155785, 9237.538123093853, 9243.861342079874, 9256.398334108295, 7971.481853679521, 7986.4010199235, 9213.81572368549, 9236.72289831306, 9260.166585007382, 8554.05905350411, 8805.471671699719, 9325.813483730288, 9338.719838404792, 9364.859527107099, 40146.39780403296, 40214.79355619336, 40603.7969810152, 40636.79681601573, 40704.38943415851, 3310.735141188723, 3334.583177102862, 3337.4493208620547, 3436.570428696413, 3509.7192224621967, 28717.0, 28809.0, 29463.410731785458, 29910.102696919126, 30029.69970300291, 3045.710657487535, 3150.5116706910467, 3160.8577614007195, 3162.810231386124, 3165.398574270904, 504790.0, 506622.0, 509593.0, 511667.44166279305, 511752.0, 62846.0, 63285.0, 63858.72282554323, 63866.68066659637, 64020.35979640237, 65768.0, 65776.34223657798, 66713.0, 66890.0, 66940.6652966732, 16373.83626163723, 16567.917160414363, 16581.91709041447, 16587.668246635, 16651.83437159387, 12535.686607834878, 12633.98928085751, 12641.936790316173, 12643.051771117203, 12654.0, 17685.801210256937, 19010.71483927742, 19096.140673669717, 19126.043697815054, 19211.655184136976, 7638.0, 7680.0, 7867.763967080997, 7892.447528672938, 7899.985503696521, 846.585173265108, 963.7494251494662, 998.236349192868, 1036.5750042482546, 1063.5639387850945, 29932.85033574862, 30388.639686253966, 30424.0, 30842.383152336828, 31131.533027004614, 968.3463662028103, 1013.7581462708271, 1023.4677967457029, 1036.18659352408, 1057.281048886749, 12401.13192076564, 15281.235938203044, 15634.3746250151, 15861.52415427539, 16046.919765401099, 665185.0, 671549.0, 672055.0, 673137.0, 674523.0, 58892.82214355689, 59676.0, 59825.10262346068, 59843.40156598378, 59911.70044149838, 1330.1420583723639, 1343.879050885425, 1365.6244532753572, 1366.3100134432248, 1370.6436326555167, 25818.354541135872, 29344.853275733483, 30161.849190753906, 30517.542236866022, 30741.077767667004, 52330.47669523256, 52691.41925742234, 52759.94480110453, 52918.0, 52956.205656914404, 466905.0, 467391.0, 470319.0, 470606.0, 470648.0, 26810.731892680822, 26813.597796033464, 26954.73045269522, 27281.59077613877, 27332.043378481656, 46537.30194047024, 46954.35659751892, 47696.523034770595, 47851.0, 48523.27215091847, 38209.0, 39426.0, 39570.60429395669, 40712.18575628412, 40848.38727419032, 38753.612463875, 38929.80535097307, 39213.0, 40083.59916400799, 40095.3985690209, 38128.809355953046, 38363.80818096003, 39112.6088739109, 39172.21655566816, 40857.38713919234, 32010.879619213214, 34705.65294347024, 34906.6037358513, 35236.47145292874, 35258.471122932664, 24852.130175443774, 25699.972001119746, 25890.61164082578, 25907.352316192246, 26549.0], "value": 19845.31813225393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.45111505979594, 356.1186064490385, 365.04540626262315, 379.645031895178, 383.2641328648997, 17304.56738581536, 18177.81822181778, 18676.159572819222, 19099.71350429741, 19611.11749971253, 18869.339573114943, 19052.523686907833, 19141.521461963424, 19623.920684362354, 19691.818490890557, 5705.172749951254, 5922.615030023035, 5934.732937017845, 5941.138534912435, 5941.465268125868, 4943.184374578191, 5633.239512665799, 5753.942460575383, 5771.81677756059, 5833.533317334603, 5745.683987380692, 5770.105633626774, 5774.2782152230975, 5784.363719990798, 5786.247787787603, 5503.7798488060425, 5626.015447296707, 5708.20085188074, 5771.249737534094, 5780.219670344512, 4329.372241025065, 4823.686460380064, 5085.720285384303, 5087.669301495391, 5094.592432605383, 24253.636195457082, 24342.904569294424, 24561.0, 24735.876320618463, 24810.627840582405, 2198.6372248579123, 2229.687843701883, 2278.7493375728654, 2316.4324740438533, 2963.5774828082426, 14465.059771114844, 14552.345144468525, 14961.925190374088, 15137.470188543459, 15858.444954426655, 1676.639522502668, 1769.1331247688668, 1772.5480002599384, 1811.1397086383995, 1865.1327132883139, 100176.49911750467, 120704.0, 120914.0, 122414.38792805979, 123104.76895231112, 10442.738931526772, 10661.520231589597, 11184.552617895193, 11268.661940141808, 11300.604478843201, 13721.039527233197, 13732.038757286895, 13755.587332380044, 13758.93120534391, 13766.105203161762, 8202.630881610341, 8410.705625303084, 8464.111268316861, 8542.871856922151, 8603.31173506118, 6806.523543351917, 7651.234876512415, 7863.37093032556, 8474.0, 8585.0, 5515.917261241085, 5936.762529498858, 6234.127222188898, 6501.804945851537, 6596.977468492295, 1583.2716950203035, 1641.5239580521754, 1744.5115367697065, 1849.8057703940892, 1888.773347198345, 755.920628334028, 798.3652995868299, 823.3289868756943, 858.1890113842359, 934.6448349627099, 18397.804142730678, 18803.811961880205, 19494.537909656832, 19646.017699114986, 20184.394468165978, 920.1626519866888, 943.7829299261208, 968.375397868385, 987.2398253345028, 1003.3327836988321, 11118.444077796077, 11569.595064172714, 11612.825807612893, 11644.010259128068, 11656.650300491, 520627.0, 552408.8851834264, 608743.0, 619721.0, 624305.0, 77310.61344693354, 78172.43655126865, 109055.45472272587, 113686.0, 115295.0, 922.1792604581927, 941.764558860285, 988.3526290279734, 990.0248255468358, 993.7118235711707, 17256.741148882527, 18691.345802896834, 19013.23947042158, 19020.714689279393, 19089.427317180507, 56963.0, 58227.0, 58398.54003649943, 59710.40289597222, 59746.40253597582, 78086.6095669518, 79934.0, 80857.0, 83490.0, 89648.5517572408, 6548.8035358939305, 7836.451448398558, 7893.17121702236, 8058.3150432213915, 8323.750287491384, 11773.117016223989, 12410.937945310578, 12887.226766394046, 13039.934800325938, 13094.738105237651, 11056.944715276371, 11071.5571377144, 11114.666560003212, 11465.0, 11573.363465009505, 10770.299930504492, 10847.783044339227, 11221.943890280496, 11236.606718765132, 11238.831417528907, 9561.760955976157, 11424.771504570028, 11540.596079137189, 11909.047276217709, 11968.581099661471, 7078.1860086090755, 7479.214682458482, 7497.137829149499, 7652.502587331805, 8201.876971845546, 9730.464824434725, 11335.546578136782, 11368.658940231806, 11613.245139065933, 11637.941810290895], "value": 9470.599368342204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.9284535773209, 1462.4004158295102, 1467.3323637744825, 1631.7144499712547, 1862.1620270878109, 7584.507007044538, 7859.410544209179, 8114.55369954653, 8527.44571602847, 8564.657413703451, 7962.880556791652, 8269.21442462965, 8276.296514796235, 8386.664533418656, 8425.199606037417, 2293.449572102696, 2329.3477826208605, 2332.24202134307, 2332.323626148415, 2339.087755775249, 2315.7452680205247, 2343.5078633486987, 2364.6334818103137, 2374.76252374762, 2380.9166679166233, 2303.8617682938993, 2310.09906136606, 2335.369450248432, 2337.3689103941924, 2338.462153704649, 2263.7283525976823, 2269.5914735347633, 2295.2900089433397, 2299.471121642015, 2313.9190128345426, 1979.990100049505, 2281.8060464860505, 2347.1550241912896, 2350.0364850411247, 2353.9411514712097, 8475.449095808754, 8520.914790852074, 8528.488290702579, 8537.231649151607, 8585.141485851365, 4255.468066491689, 5055.545000949895, 5189.091908915924, 5207.192885102815, 5216.321878155815, 2803.8457884816326, 2962.481565725989, 3015.3969206158636, 3030.530267808493, 3290.391277613649, 1045.864037675105, 1065.4779158212498, 1076.0, 1085.8642669666292, 1098.1434481104752, 10995.725106872313, 11074.557017719282, 11109.0, 11156.386398748065, 11209.775804483865, 4494.52807455219, 4569.177548041384, 4656.3946686930485, 4663.300504924221, 4730.385049943486, 9383.906160938302, 9452.338336316392, 9453.952730236442, 9461.432314061178, 9471.952640236756, 5181.06740786662, 5196.4803519648485, 5197.714125723046, 5198.792048318101, 5257.76340064698, 4030.5364883038824, 4163.375493675912, 4601.67788254819, 4714.57568818808, 4776.426828780499, 3776.4146557283666, 3806.143617686054, 3871.845126194977, 3889.0471834400755, 3922.5685174630767, 1268.0679700420185, 1268.6891711530734, 1271.5740227023866, 1282.5254655777421, 1287.4528325461642, 777.3742137579189, 849.8130411309502, 870.2960498505587, 880.0847118996172, 881.0088650268448, 5318.547923426475, 5544.306961629796, 5546.584006199551, 5558.027345214571, 5569.331680198402, 439.97924814430854, 442.6547293111378, 447.1548772819374, 447.89698369374577, 456.3178048816973, 3392.7964322140256, 3613.584437789688, 3644.927101457956, 3685.5208822852856, 3737.5328083989502, 9939.602415903428, 10161.847572286422, 10311.432871192006, 10323.896761032443, 10345.586176552853, 10266.897331026594, 10276.486175691185, 10293.639722609672, 10315.020073093045, 10318.845217321747, 7480.8877866832045, 7779.844403111906, 7884.566348850868, 7918.168592297841, 7962.6416811243635, 5511.696856672921, 5582.190582365615, 5716.228309178374, 5735.97132014354, 5773.3072031356505, 9220.077992200726, 9344.813103737752, 9347.813043738952, 9415.05849415053, 9428.905710942803, 9506.762330941505, 9534.570944307385, 9540.0, 9624.66313679018, 9628.229741620793, 6536.444402225864, 6770.830729231809, 7038.542494737826, 7207.099112610924, 7320.267973202637, 7832.981712377355, 8021.558814265271, 8040.3969702273735, 8061.717839875576, 8085.272325490734, 7101.2898710128575, 7227.747028853965, 7245.818854528468, 7268.890966635399, 7318.890216646861, 5957.880842383041, 7000.964995174992, 7090.858182836418, 7203.423726102004, 7253.891191632235, 6639.136912201383, 6650.900236496554, 6729.831754206184, 6730.966345168243, 6739.393454589111, 4786.282057691375, 4796.688215265996, 4844.346013288161, 4870.683405578626, 4890.290907818276, 4702.952970470252, 4783.330333753208, 4852.878678033077, 4881.731504767272, 4904.542297680198], "value": 4316.53454247512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.06259314456037, 301.2709243630415, 307.8568465663467, 308.4355629198567, 312.32070247212306, 4823.903521929564, 4988.725620090893, 5234.555062819665, 5359.839204823852, 5561.6106872518885, 4050.6151915567975, 4635.327877457767, 5035.697858128515, 5319.760610772515, 5359.919601205976, 3397.6432474590183, 4088.9795551022203, 4117.044403908149, 4133.3386658134705, 4153.262064142266, 3413.692767650911, 3491.8603255869734, 3507.6492350764975, 4142.565030671782, 4148.361397248101, 3428.982855085721, 3448.4482482802755, 3536.982315088421, 3820.369639009574, 4084.5915408459214, 4050.8605830481465, 4063.8984025399304, 4069.064115253508, 4085.4484644573195, 4103.322951712964, 3538.0, 3559.715222782171, 3571.4285714285847, 3590.9281814363567, 3592.209713862946, 4684.8287928018, 4925.064237794808, 5179.741012949337, 5281.234221037967, 5311.840644780663, 4217.8523751668545, 4324.308110702304, 4624.075184963021, 4626.699264547828, 4641.327007583882, 5678.716064196815, 5686.857828554278, 5693.829185124453, 5707.429257074301, 5725.713714314309, 3190.7766456348063, 3489.040513858684, 3791.279656865187, 3828.2726282006606, 3864.623256697111, 5571.331440227158, 5858.209141765849, 5941.673207973559, 6041.395860413967, 6053.364396738323, 4082.4896887889013, 4085.8774236772942, 4097.815598298083, 4098.774567398762, 4106.3429851224255, 3226.467632840555, 4065.5527891931865, 4119.7940102994735, 4138.048248902769, 4168.312228482328, 4718.787654555554, 4724.645651576146, 4730.455997560324, 4741.668083234141, 4753.6452111148155, 5269.0, 5704.286964129484, 5758.280214973129, 5786.594938354359, 5804.709764511757, 1100.0, 1236.9300555020022, 1310.737852429518, 1326.9336533173303, 1330.813686083949, 824.8432797768405, 921.9167478213207, 923.1122354784482, 926.1109335038304, 931.9207867331218, 4548.636109111263, 4904.411470623548, 5004.574611158092, 5049.26785616091, 5067.493250674903, 5240.764165612557, 5460.6177567569885, 5485.094959331665, 5496.450354964471, 5514.283143191359, 4015.0966032643005, 4239.703220774578, 4669.859904202879, 5045.779856862969, 5066.113430149783, 2678.383971686484, 2820.8871645134377, 2908.5055540558155, 2912.956305655417, 2923.912282631482, 5687.066397424813, 5698.205065404384, 5730.7421166047625, 5743.4543718346695, 5749.9425005750245, 4917.852464426073, 5332.786688532493, 5607.383187849333, 5635.6618602883955, 5642.943570564324, 4956.628252880976, 5070.366204224472, 5656.745446455002, 5686.3744988051285, 5714.0, 4679.081576553596, 4949.57928576075, 5445.59158063139, 5487.588430867621, 5500.257465242141, 4482.798274077609, 5355.97322013403, 5435.619506634655, 5859.384764599656, 5863.0, 6154.415330543591, 6181.412765787243, 6188.658124612839, 6191.25704915413, 6203.689815509297, 3597.226596281812, 3774.9811250944667, 3933.3116704577155, 3945.033466800652, 3950.2099580083523, 4736.4316282046375, 5604.290691339181, 5868.823935281948, 5881.617694849821, 5897.292324920865, 5599.524040456444, 5626.88746225065, 5765.654060756368, 5793.0, 5831.8833623326445, 4996.850094497171, 5336.279602253646, 5756.68338241384, 5785.016547187072, 5830.941690583039, 5095.77069031887, 5132.871678208075, 5437.0, 5572.387037425799, 5680.829575112753, 4768.690035147843, 5706.372299047019, 5732.627379220337, 5759.078547432391, 5762.971185144047, 4867.853964381075, 5570.749316280696, 5576.944230557805, 5598.3282006159525, 5634.605577609528], "value": 4080.228344982982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.0985908459918, 741.9814504637384, 751.4814777803311, 755.4032314471568, 777.8677624803785, 13939.512117075905, 14636.41454341825, 14665.413383464675, 14668.0, 14805.629859253524, 11397.658070257905, 12707.872921270784, 13096.0, 13253.271070091141, 13271.867281327184, 796.5181065455403, 799.8520273749375, 831.5925196653626, 836.5900708652747, 842.2630198576246, 808.7856717969743, 811.6834434570522, 812.46377390922, 812.8374325134997, 813.1340122769261, 842.0442797424936, 852.6759831264111, 854.8845905802699, 858.0432817408607, 859.4886042804521, 849.2229609906927, 849.8342823149488, 851.5614458553849, 853.2960307746104, 854.4318028511033, 629.908663243827, 630.5397060146073, 631.2551189596275, 631.4096319940824, 631.472720278568, 14205.0, 14224.715505689932, 14254.92872535641, 14288.071275367069, 14300.928495357457, 13223.140495867834, 13440.731185376335, 13459.12515686487, 13461.596152115451, 13597.660058498517, 11253.493592788343, 11330.830037549444, 11486.023687986448, 11516.94241528787, 11714.765704685859, 3582.4805403216387, 3611.1874828163454, 3613.4941108244866, 3620.149264922741, 3698.537682789651, 92935.07064929332, 93236.0, 93696.53151734266, 94679.0, 96005.51997240039, 10095.04097110788, 10346.741331466774, 10391.688249352532, 10420.0, 10437.478126093816, 19045.428637140907, 19708.40874773759, 19850.0, 19998.300059497848, 20020.69968950467, 7707.961460192775, 7780.533168009937, 7887.566183859943, 7887.921120788834, 7940.404469664682, 4199.517055538591, 4339.826406943687, 4430.401895744098, 4452.109578084396, 4457.264551349056, 3415.18035671442, 3476.704480119168, 3523.2777280657406, 3533.911652208664, 3538.575370955502, 645.4578154350369, 651.4495251512465, 657.4805903336311, 668.2982867988593, 673.3703986772383, 502.48244308362445, 532.8135152696602, 578.8625351184942, 606.58145879344, 634.3149398649448, 8908.554572271361, 9024.323175761843, 9147.108703977232, 9173.862392064124, 9311.208547273422, 560.9298837645294, 604.2024527623582, 626.5457543281176, 648.3548868875499, 672.9158855143107, 4382.715123516961, 4481.731096134243, 4503.684742068024, 4511.70673906195, 4622.2835460503, 109393.0, 118437.0, 119179.0, 120575.0, 122150.0, 84931.57534212412, 85273.57363213268, 95264.0473595269, 97962.51018744861, 100906.4954675222, 82018.58990705128, 82715.17284827195, 85289.0, 88423.67364489537, 91209.0, 6988.720451181895, 7632.618369081635, 8031.277185053374, 8720.43317184381, 8846.646134154562, 55636.609084773205, 55790.884182316935, 56790.432095678516, 56860.0, 58151.70924145352, 67228.32771672221, 69169.30830691628, 72822.63588682022, 73158.0, 76517.61741191258, 11644.825327620261, 12391.132620716464, 12444.440000199831, 12571.685707857378, 12880.935595322338, 13574.728505430034, 13846.446142154202, 13877.583672489842, 14237.786433203302, 14263.64340891486, 11355.659330220107, 12247.938760306142, 13249.271290079138, 13255.403506842022, 13617.387217575431, 13034.08761386694, 13056.608301750963, 13101.017423693453, 13280.003999699868, 13346.933265333611, 11175.38535380562, 11593.594224202112, 12537.310447925453, 12998.0, 13056.543020994219, 10310.896891031294, 11081.058110060412, 11158.107351411705, 11244.550217991517, 11511.712207194887, 9230.538473076454, 9697.709068727949, 10045.69862904114, 10186.625580875285, 10223.233257505866], "value": 7241.047526723516, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 119.0, 121.0, 117.0, 119.0, 121.0, 118.0, 119.0, 121.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 111.0, 108.0, 140.0, 114.0, 111.0, 126.0, 113.0, 136.0, 114.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 205.0, 199.0, 202.0, 200.0, 198.0, 194.0, 200.0, 195.0, 196.0], "value": 198.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 53.0, 81.0, 58.0, 54.0, 54.0, 84.0, 105.0, 57.0], "value": 68.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 91.0, 73.0, 70.0, 71.0, 86.0, 72.0, 94.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 87.0, 91.0, 109.0, 105.0, 129.0, 135.0, 88.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 100.0, 100.0, 138.0, 145.0, 167.0, 169.0, 171.0, 102.0], "value": 129.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 94.0, 87.0, 89.0, 89.0, 91.0, 87.0, 133.0, 140.0], "value": 103.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 60.0, 60.0, 60.0, 58.0, 60.0, 60.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 74.0, 76.0, 77.0, 76.0, 73.0, 73.0, 71.0, 78.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 84.0, 87.0, 85.0, 83.0, 87.0, 88.0, 93.0, 96.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 154.0, 158.0, 158.0, 143.0, 144.0, 164.0, 135.0, 200.0, 150.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 166.0, 168.0, 167.0, 178.0, 155.0, 147.0, 212.0, 235.0, 201.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 74.0, 66.0, 64.0, 65.0, 71.0, 90.0, 79.0, 62.0], "value": 71.2, "unit": "score"}]}]} 08:43:42 INFO - Return code: 0 08:43:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:43:42 ERROR - # TBPL SUCCESS # 08:43:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:42 INFO - 2017-01-22 08:43:42.378 screenresolution[1672:16222] starting screenresolution argv=screenresolution get 08:43:42 INFO - 2017-01-22 08:43:42.381 screenresolution[1672:16222] Display 0: 1600x1200x32@60 08:43:42 INFO - 2017-01-22 08:43:42.388 screenresolution[1673:16225] starting screenresolution argv=screenresolution list 08:43:42 INFO - Available Modes on Display 0 08:43:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:42 INFO - Intel Iris: 08:43:42 INFO - Chipset Model: Intel Iris 08:43:42 INFO - Type: GPU 08:43:42 INFO - Bus: Built-In 08:43:42 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:42 INFO - Vendor: Intel (0x8086) 08:43:42 INFO - Device ID: 0x0a2e 08:43:42 INFO - Revision ID: 0x0009 08:43:42 INFO - Displays: 08:43:42 INFO - Display: 08:43:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:42 INFO - Display Serial Number: 1600x1200 60 08:43:42 INFO - Main Display: Yes 08:43:42 INFO - Mirror: Off 08:43:42 INFO - Online: Yes 08:43:42 INFO - Rotation: Supported 08:43:42 INFO - Return code: 0 08:43:42 INFO - Running post-action listener: _resource_record_post_action 08:43:42 INFO - [mozharness: 2017-01-22 16:43:42.630257Z] Finished run-tests step (success) 08:43:42 INFO - Running post-run listener: _resource_record_post_run 08:43:42 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 34415104; Write bytes: 667017216; Read time: 321; Write time: 2087 08:43:42 INFO - TinderboxPrint: CPU usage
54.4% 08:43:42 INFO - TinderboxPrint: I/O read bytes / time
34,415,104 / 321 08:43:42 INFO - TinderboxPrint: I/O write bytes / time
667,017,216 / 2,087 08:43:42 INFO - TinderboxPrint: CPU idle
2,205.6 (45.6%) 08:43:42 INFO - TinderboxPrint: CPU system
979.1 (20.2%) 08:43:42 INFO - TinderboxPrint: CPU user
1,657.0 (34.2%) 08:43:42 INFO - TinderboxPrint: Swap in / out
382,279,680 / 0 08:43:42 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 351083008; Write bytes: 347617280; Read time: 27200; Write time: 667 08:43:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30061056; Write bytes: 312072192; Read time: 287; Write time: 1391 08:43:43 INFO - Running post-run listener: _upload_blobber_files 08:43:43 INFO - Blob upload gear active. 08:43:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:43:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:43:43 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:43:43 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:43:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:43:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:43:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:44 INFO - (blobuploader) - INFO - Done attempting. 08:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:45 INFO - (blobuploader) - INFO - Done attempting. 08:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:43:47 INFO - (blobuploader) - INFO - Done attempting. 08:43:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:43:47 INFO - Return code: 0 08:43:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:43:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:43:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0a6074db8f7fb6c1b0c2476bf4b55a353293e4e7eacfd2bf2e121c34cf6c6154efccab683dc10c28e514bc4dfd7be4d16161b0df91914c295dde1ca750a6d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfb82b95643037cd6933c1c13cdbfebb8f75f2a1b2db06eca6d420fbe452ee922a6804b9147e3150688cff330b602d825cf0631f170dd1f5651c57c091566a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757077384a2cd674e1caded500b0fe9054e98bde9f70de61821fdcfcbc5efee6ef146609bf19c2f74915656e74fd79d3286e47737d3ff208f1d5a29aa8c950"} 08:43:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:43:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:43:47 INFO - Contents: 08:43:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0a6074db8f7fb6c1b0c2476bf4b55a353293e4e7eacfd2bf2e121c34cf6c6154efccab683dc10c28e514bc4dfd7be4d16161b0df91914c295dde1ca750a6d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfb82b95643037cd6933c1c13cdbfebb8f75f2a1b2db06eca6d420fbe452ee922a6804b9147e3150688cff330b602d825cf0631f170dd1f5651c57c091566a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757077384a2cd674e1caded500b0fe9054e98bde9f70de61821fdcfcbc5efee6ef146609bf19c2f74915656e74fd79d3286e47737d3ff208f1d5a29aa8c950"} 08:43:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:43:47 INFO - Copying logs to upload dir... 08:43:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:43:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.411273 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2017-01-22 08:43:47.692814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 08:43:47.696071) ========= 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.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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/Mozilla-Aurora/sha512/f0a6074db8f7fb6c1b0c2476bf4b55a353293e4e7eacfd2bf2e121c34cf6c6154efccab683dc10c28e514bc4dfd7be4d16161b0df91914c295dde1ca750a6d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfb82b95643037cd6933c1c13cdbfebb8f75f2a1b2db06eca6d420fbe452ee922a6804b9147e3150688cff330b602d825cf0631f170dd1f5651c57c091566a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757077384a2cd674e1caded500b0fe9054e98bde9f70de61821fdcfcbc5efee6ef146609bf19c2f74915656e74fd79d3286e47737d3ff208f1d5a29aa8c950"} build_url:https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/evSNjfPRTQeOWyJ5q01F_A/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0a6074db8f7fb6c1b0c2476bf4b55a353293e4e7eacfd2bf2e121c34cf6c6154efccab683dc10c28e514bc4dfd7be4d16161b0df91914c295dde1ca750a6d32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cfb82b95643037cd6933c1c13cdbfebb8f75f2a1b2db06eca6d420fbe452ee922a6804b9147e3150688cff330b602d825cf0631f170dd1f5651c57c091566a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d757077384a2cd674e1caded500b0fe9054e98bde9f70de61821fdcfcbc5efee6ef146609bf19c2f74915656e74fd79d3286e47737d3ff208f1d5a29aa8c950"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 08:43:47.737255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:43:47.737631) ========= 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.50fT1cdjeu/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.bcPjQmhUTf/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005309 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 08:43:47.789584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 08:43:47.789938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 08:43:47.790299) ========= ========= Total master_lag: 0.36 =========