builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0352 starttime: 1485246037.36 results: success (0) buildid: 20170123213845 builduid: 36854ff7c20b40b89cba9e3d0f263bf4 revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.359021) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.359552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.359843) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.400211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.400827) ========= 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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-24 00:20:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-01-24 00:20:37 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134847 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.607257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:37.607568) ========= 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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.025434 ========= master_lag: 0.69 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:38.327858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 00:20:38.328206) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --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-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-24 00:20:38,428 truncating revision to first 12 chars 2017-01-24 00:20:38,429 Setting DEBUG logging. 2017-01-24 00:20:38,429 attempt 1/10 2017-01-24 00:20:38,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7443e9844412?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 00:20:40,450 unpacking tar archive at: mozilla-beta-7443e9844412/testing/mozharness/ program finished with exit code 0 elapsedTime=2.290641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-24 00:20:40.640821) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:40.641126) ========= script_repo_revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:40.641505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:40.641782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 00:20:40.660789) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-24 00:20:40.661155) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:20:40 INFO - MultiFileLogger online at 20170124 00:20:40 in /builds/slave/test 00:20:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:20:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:20:40 INFO - {'append_to_log': False, 00:20:40 INFO - 'base_work_dir': '/builds/slave/test', 00:20:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:20:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:20:40 INFO - 'branch': 'Mozilla-Beta', 00:20:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:20:40 INFO - 'config_files': ('talos/mac_config.py',), 00:20:40 INFO - 'default_actions': ('clobber', 00:20:40 INFO - 'read-buildbot-config', 00:20:40 INFO - 'download-and-extract', 00:20:40 INFO - 'populate-webroot', 00:20:40 INFO - 'create-virtualenv', 00:20:40 INFO - 'install', 00:20:40 INFO - 'run-tests'), 00:20:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:20:40 INFO - 'download_minidump_stackwalk': True, 00:20:40 INFO - 'download_symbols': 'ondemand', 00:20:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:20:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:20:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:20:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:20:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:20:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:20:40 INFO - 'installer_path': 'installer.exe', 00:20:40 INFO - 'log_level': 'info', 00:20:40 INFO - 'log_name': 'talos', 00:20:40 INFO - 'log_to_console': True, 00:20:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:20:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:20:40 INFO - 'opt_config_files': (), 00:20:40 INFO - 'pip_index': False, 00:20:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:20:40 INFO - 'cmd': ('bash', 00:20:40 INFO - '-c', 00:20:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:20:40 INFO - 'enabled': True, 00:20:40 INFO - 'halt_on_failure': False, 00:20:40 INFO - 'name': 'check_screen_resolution'},), 00:20:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:20:40 INFO - 'cmd': ('bash', 00:20:40 INFO - '-c', 00:20:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:20:40 INFO - 'enabled': True, 00:20:40 INFO - 'halt_on_failure': False, 00:20:40 INFO - 'name': 'check_screen_resolution'},), 00:20:40 INFO - 'run_cmd_checks_enabled': True, 00:20:40 INFO - 'sps_profile': False, 00:20:40 INFO - 'sps_profile_interval': 0, 00:20:40 INFO - 'suite': 'dromaeojs-e10s', 00:20:40 INFO - 'system_bits': '32', 00:20:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:20:40 INFO - 'title': 't-yosemite-r7-0352', 00:20:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:20:40 INFO - 'use_talos_json': True, 00:20:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:20:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:20:40 INFO - 'work_dir': 'build'} 00:20:40 INFO - [mozharness: 2017-01-24 08:20:40.853033Z] Running clobber step. 00:20:40 INFO - Running pre-action listener: _resource_record_pre_action 00:20:40 INFO - Running main action method: clobber 00:20:40 INFO - rmtree: /builds/slave/test/build 00:20:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:20:43 INFO - Running post-action listener: _resource_record_post_action 00:20:43 INFO - [mozharness: 2017-01-24 08:20:43.356737Z] Finished clobber step (success) 00:20:43 INFO - [mozharness: 2017-01-24 08:20:43.356924Z] Running read-buildbot-config step. 00:20:43 INFO - Running pre-action listener: _resource_record_pre_action 00:20:43 INFO - Running main action method: read_buildbot_config 00:20:43 INFO - Using buildbot properties: 00:20:43 INFO - { 00:20:43 INFO - "project": "", 00:20:43 INFO - "product": "firefox", 00:20:43 INFO - "script_repo_revision": "production", 00:20:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 00:20:43 INFO - "repository": "", 00:20:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 00:20:43 INFO - "buildid": "20170123213845", 00:20:43 INFO - "pgo_build": "False", 00:20:43 INFO - "basedir": "/builds/slave/test", 00:20:43 INFO - "buildnumber": 6, 00:20:43 INFO - "slavename": "t-yosemite-r7-0352", 00:20:43 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 00:20:43 INFO - "platform": "yosemite_r7", 00:20:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:20:43 INFO - "branch": "mozilla-beta", 00:20:43 INFO - "repo_path": "releases/mozilla-beta", 00:20:43 INFO - "revision": "7443e9844412b8645aafbc9654a6da7adc65cb30", 00:20:43 INFO - "stage_platform": "macosx64", 00:20:43 INFO - "builduid": "36854ff7c20b40b89cba9e3d0f263bf4", 00:20:43 INFO - "slavebuilddir": "test" 00:20:43 INFO - } 00:20:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 00:20:43 INFO - Running post-action listener: _resource_record_post_action 00:20:43 INFO - [mozharness: 2017-01-24 08:20:43.360482Z] Finished read-buildbot-config step (success) 00:20:43 INFO - [mozharness: 2017-01-24 08:20:43.360554Z] Running download-and-extract step. 00:20:43 INFO - Running pre-action listener: _resource_record_pre_action 00:20:43 INFO - Running main action method: download_and_extract 00:20:43 INFO - mkdir: /builds/slave/test/build/tests 00:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:20:43 INFO - trying https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 00:20:43 INFO - Downloading https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 00:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 00:20:44 INFO - Downloaded 1165 bytes. 00:20:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 00:20:44 INFO - Using the following test package requirements: 00:20:44 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 00:20:44 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 00:20:44 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 00:20:44 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:20:44 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 00:20:44 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 00:20:44 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 00:20:44 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 00:20:44 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 00:20:44 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 00:20:44 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 00:20:44 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 00:20:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 00:20:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 00:20:44 INFO - Fetch https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 00:20:45 INFO - Http code: 200 00:20:45 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 00:20:45 INFO - x-amz-cf-id: qh8gQXActukor07fyT3som2TCS10tOqynynapU8LfeK9cmQSHuwICA== 00:20:45 INFO - x-amz-version-id: oPlpKtDOkH5pSFFXHniwA51boA32WMCj 00:20:45 INFO - Expected file size: 16086063 00:20:45 INFO - Obtained file size: 16086063 00:20:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:20:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 00:20:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 00:20:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 00:20:52 INFO - Http code: 200 00:20:52 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 00:20:52 INFO - x-amz-cf-id: S48rXakEE8QtzScXCDacqdQzSiABGCEebAjhko1tnjbysLYPnm25XA== 00:20:52 INFO - x-amz-version-id: oPlpKtDOkH5pSFFXHniwA51boA32WMCj 00:20:52 INFO - Expected file size: 16086063 00:20:52 INFO - Obtained file size: 16086063 00:20:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 00:20:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 00:20:59 INFO - Fetch https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 00:20:59 INFO - Http code: 200 00:20:59 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 00:20:59 INFO - x-amz-cf-id: NLQEBGZuvRUvhKkyfw5AaokhwebOZkG8fGDJ9_QSmQWPPrg1-TCNig== 00:20:59 INFO - x-amz-version-id: fTeexyhMfYGtLaGjrvC8Y2PFbtV4.8Qj 00:21:00 INFO - Expected file size: 14402992 00:21:00 INFO - Obtained file size: 14402992 00:21:00 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')]} 00:21:00 INFO - trying https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 00:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 00:21:02 INFO - Downloaded 82105494 bytes. 00:21:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:21:02 INFO - mkdir: /builds/slave/test/properties 00:21:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:21:02 INFO - Writing to file /builds/slave/test/properties/build_url 00:21:02 INFO - Contents: 00:21:02 INFO - build_url:https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 00:21:03 INFO - Running post-action listener: _resource_record_post_action 00:21:03 INFO - Running post-action listener: set_extra_try_arguments 00:21:03 INFO - [mozharness: 2017-01-24 08:21:03.290576Z] Finished download-and-extract step (success) 00:21:03 INFO - [mozharness: 2017-01-24 08:21:03.290694Z] Running populate-webroot step. 00:21:03 INFO - Running pre-action listener: _resource_record_pre_action 00:21:03 INFO - Running main action method: populate_webroot 00:21:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:21:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:21:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:21:03 INFO - '--tppagecycles', 00:21:03 INFO - '7'], 00:21:03 INFO - 'tests': ['tsvgm']}}, 00:21:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:21:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:21:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:21:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:21:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:21:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:21:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['damp', 'tps']}, 00:21:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'tests': ['damp', 'tps']}, 00:21:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['dromaeo_dom']}, 00:21:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:21:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['basic_compositor_video']}, 00:21:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:21:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'other-e10s': {'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['a11yr', 00:21:03 INFO - 'ts_paint', 00:21:03 INFO - 'tpaint', 00:21:03 INFO - 'sessionrestore', 00:21:03 INFO - 'sessionrestore_no_auto_restore', 00:21:03 INFO - 'tabpaint']}, 00:21:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['tsvgx', 00:21:03 INFO - 'tsvgr_opacity', 00:21:03 INFO - 'tart', 00:21:03 INFO - 'tscrollx', 00:21:03 INFO - 'cart']}, 00:21:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:21:03 INFO - 'tsvgr_opacity', 00:21:03 INFO - 'tart', 00:21:03 INFO - 'tscrollx', 00:21:03 INFO - 'cart']}, 00:21:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'talos_options': ['--disable-e10s'], 00:21:03 INFO - 'tests': ['tp5o']}, 00:21:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'tests': ['tp5o']}, 00:21:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'talos_options': ['--disable-e10s', 00:21:03 INFO - '--xperf_path', 00:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:21:03 INFO - 'tests': ['tp5n']}, 00:21:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:21:03 INFO - 'talos_options': ['--xperf_path', 00:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:21:03 INFO - 'tests': ['tp5n']}}, 00:21:03 INFO - 'talos.zip': {'path': '', 00:21:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:21:03 INFO - Running post-action listener: _resource_record_post_action 00:21:03 INFO - [mozharness: 2017-01-24 08:21:03.310163Z] Finished populate-webroot step (success) 00:21:03 INFO - [mozharness: 2017-01-24 08:21:03.310296Z] Running create-virtualenv step. 00:21:03 INFO - Running pre-action listener: _resource_record_pre_action 00:21:03 INFO - Running main action method: create_virtualenv 00:21:03 INFO - Creating virtualenv /builds/slave/test/build/venv 00:21:03 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 00:21:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:21:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:21:03 INFO - Using real prefix '/tools/python27' 00:21:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:21:04 INFO - Installing distribute.............................................................................................................................................................................................done. 00:21:07 INFO - Installing pip.................done. 00:21:07 INFO - Return code: 0 00:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:21:07 INFO - Reading from file tmpfile_stdout 00:21:07 INFO - Output received: 00:21:07 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) 00:21:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:21:07 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')]} 00:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:07 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')]} 00:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:07 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:07 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 00:21:07 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 00:21:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:07 INFO - 'HOME': '/Users/cltbld', 00:21:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:07 INFO - 'LOGNAME': 'cltbld', 00:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:07 INFO - 'MOZ_NO_REMOTE': '1', 00:21:07 INFO - 'NO_EM_RESTART': '1', 00:21:07 INFO - 'PAGER': '/bin/cat', 00:21:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:07 INFO - 'PWD': '/builds/slave/test', 00:21:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:07 INFO - 'SHELL': '/bin/bash', 00:21:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:07 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:07 INFO - 'USER': 'cltbld', 00:21:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:07 INFO - 'XPC_FLAGS': '0x0', 00:21:07 INFO - 'XPC_SERVICE_NAME': '0', 00:21:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:07 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 00:21:07 INFO - Cleaning up... 00:21:07 INFO - Return code: 0 00:21:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:21:07 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')]} 00:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:07 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')]} 00:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:07 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:07 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 00:21:07 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 00:21:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:07 INFO - 'HOME': '/Users/cltbld', 00:21:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:07 INFO - 'LOGNAME': 'cltbld', 00:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:07 INFO - 'MOZ_NO_REMOTE': '1', 00:21:07 INFO - 'NO_EM_RESTART': '1', 00:21:07 INFO - 'PAGER': '/bin/cat', 00:21:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:07 INFO - 'PWD': '/builds/slave/test', 00:21:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:07 INFO - 'SHELL': '/bin/bash', 00:21:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:07 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:07 INFO - 'USER': 'cltbld', 00:21:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:07 INFO - 'XPC_FLAGS': '0x0', 00:21:07 INFO - 'XPC_SERVICE_NAME': '0', 00:21:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:07 INFO - Downloading/unpacking psutil>=3.1.1 00:21:07 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 00:21:07 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 00:21:07 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 00:21:07 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 00:21:07 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 00:21:07 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 00:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:21:11 INFO - Installing collected packages: psutil 00:21:11 INFO - Running setup.py install for psutil 00:21:11 INFO - building 'psutil._psutil_osx' extension 00:21:11 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 00:21:11 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 00:21:12 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 00:21:12 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 00:21:12 INFO - building 'psutil._psutil_posix' extension 00:21:12 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 00:21:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:21:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:21:12 INFO - ^ 00:21:12 INFO - 1 warning generated. 00:21:12 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 00:21:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:21:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:21:12 INFO - Successfully installed psutil 00:21:12 INFO - Cleaning up... 00:21:12 INFO - Return code: 0 00:21:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:21:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:12 INFO - 'HOME': '/Users/cltbld', 00:21:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:12 INFO - 'LOGNAME': 'cltbld', 00:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:12 INFO - 'MOZ_NO_REMOTE': '1', 00:21:12 INFO - 'NO_EM_RESTART': '1', 00:21:12 INFO - 'PAGER': '/bin/cat', 00:21:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:12 INFO - 'PWD': '/builds/slave/test', 00:21:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:12 INFO - 'SHELL': '/bin/bash', 00:21:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:12 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:12 INFO - 'USER': 'cltbld', 00:21:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:12 INFO - 'XPC_FLAGS': '0x0', 00:21:12 INFO - 'XPC_SERVICE_NAME': '0', 00:21:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:21:15 INFO - Installing collected packages: mozsystemmonitor 00:21:15 INFO - Running setup.py install for mozsystemmonitor 00:21:15 INFO - Successfully installed mozsystemmonitor 00:21:15 INFO - Cleaning up... 00:21:15 INFO - Return code: 0 00:21:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:21: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')]} 00:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21: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')]} 00:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21: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', '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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:21: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 jsonschema==2.5.1 00:21:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:15 INFO - 'HOME': '/Users/cltbld', 00:21:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:15 INFO - 'LOGNAME': 'cltbld', 00:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:15 INFO - 'MOZ_NO_REMOTE': '1', 00:21:15 INFO - 'NO_EM_RESTART': '1', 00:21:15 INFO - 'PAGER': '/bin/cat', 00:21:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:15 INFO - 'PWD': '/builds/slave/test', 00:21:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:15 INFO - 'SHELL': '/bin/bash', 00:21:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:15 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:15 INFO - 'USER': 'cltbld', 00:21:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:15 INFO - 'XPC_FLAGS': '0x0', 00:21:15 INFO - 'XPC_SERVICE_NAME': '0', 00:21:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:16 INFO - Downloading/unpacking jsonschema==2.5.1 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:21:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21:19 INFO - Downloading functools32-3.2.3-2.tar.gz 00:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:21:19 INFO - warning: no files found matching '*.txt' 00:21:19 INFO - no previously-included directories found matching 'build' 00:21:19 INFO - no previously-included directories found matching 'dist' 00:21:19 INFO - no previously-included directories found matching '.git*' 00:21:19 INFO - Installing collected packages: jsonschema, functools32 00:21:19 INFO - Running setup.py install for functools32 00:21:19 INFO - warning: no files found matching '*.txt' 00:21:19 INFO - no previously-included directories found matching 'build' 00:21:19 INFO - no previously-included directories found matching 'dist' 00:21:19 INFO - no previously-included directories found matching '.git*' 00:21:19 INFO - Successfully installed jsonschema functools32 00:21:19 INFO - Cleaning up... 00:21:19 INFO - Return code: 0 00:21:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:21:19 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')]} 00:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:19 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')]} 00:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:19 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:19 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 00:21:19 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 00:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:19 INFO - 'HOME': '/Users/cltbld', 00:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:19 INFO - 'LOGNAME': 'cltbld', 00:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:19 INFO - 'MOZ_NO_REMOTE': '1', 00:21:19 INFO - 'NO_EM_RESTART': '1', 00:21:19 INFO - 'PAGER': '/bin/cat', 00:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:19 INFO - 'PWD': '/builds/slave/test', 00:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:19 INFO - 'SHELL': '/bin/bash', 00:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:19 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:19 INFO - 'USER': 'cltbld', 00:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:19 INFO - 'XPC_FLAGS': '0x0', 00:21:19 INFO - 'XPC_SERVICE_NAME': '0', 00:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:21:19 INFO - Cleaning up... 00:21:19 INFO - Return code: 0 00:21:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:21:19 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')]} 00:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:19 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')]} 00:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:19 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:19 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 00:21:19 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 00:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:19 INFO - 'HOME': '/Users/cltbld', 00:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:19 INFO - 'LOGNAME': 'cltbld', 00:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:19 INFO - 'MOZ_NO_REMOTE': '1', 00:21:19 INFO - 'NO_EM_RESTART': '1', 00:21:19 INFO - 'PAGER': '/bin/cat', 00:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:19 INFO - 'PWD': '/builds/slave/test', 00:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:19 INFO - 'SHELL': '/bin/bash', 00:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:19 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:19 INFO - 'USER': 'cltbld', 00:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:19 INFO - 'XPC_FLAGS': '0x0', 00:21:19 INFO - 'XPC_SERVICE_NAME': '0', 00:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:19 INFO - Downloading/unpacking blobuploader==1.2.4 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21: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 00:21:22 INFO - Downloading blobuploader-1.2.4.tar.gz 00:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:21:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:21:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:21:23 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 00:21:23 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 00:21:23 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 00:21:23 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 00:21:23 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 00:21:23 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 00:21:23 INFO - Downloading docopt-0.6.1.tar.gz 00:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:21:23 INFO - Installing collected packages: blobuploader, requests, docopt 00:21:23 INFO - Running setup.py install for blobuploader 00:21:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:21:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:21:24 INFO - Running setup.py install for requests 00:21:24 INFO - Running setup.py install for docopt 00:21:24 INFO - Successfully installed blobuploader requests docopt 00:21:24 INFO - Cleaning up... 00:21:24 INFO - Return code: 0 00:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:24 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')]} 00:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:24 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')]} 00:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:24 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:24 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 00:21:24 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 00:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:24 INFO - 'HOME': '/Users/cltbld', 00:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:24 INFO - 'LOGNAME': 'cltbld', 00:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:24 INFO - 'MOZ_NO_REMOTE': '1', 00:21:24 INFO - 'NO_EM_RESTART': '1', 00:21:24 INFO - 'PAGER': '/bin/cat', 00:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:24 INFO - 'PWD': '/builds/slave/test', 00:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:24 INFO - 'SHELL': '/bin/bash', 00:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:24 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:24 INFO - 'USER': 'cltbld', 00:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:24 INFO - 'XPC_FLAGS': '0x0', 00:21:24 INFO - 'XPC_SERVICE_NAME': '0', 00:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-qXvfZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-_wY3Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-5CzMG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-IwYjU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-SA4FzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-eJgztv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-zge0aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-74QlTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:21:25 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-EFHeBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-pQM7rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-EILyR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-krQlyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-zlxEaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-uoxj1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-RSo6zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-rZjkfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:21:26 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-srjA9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:21:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:21:26 INFO - Running setup.py install for manifestparser 00:21:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:21:27 INFO - Running setup.py install for mozcrash 00:21:27 INFO - Running setup.py install for mozdebug 00:21:27 INFO - Running setup.py install for mozdevice 00:21:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:21:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:21:27 INFO - Running setup.py install for mozfile 00:21:27 INFO - Running setup.py install for mozhttpd 00:21:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:21:27 INFO - Running setup.py install for mozinfo 00:21:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:21:27 INFO - Running setup.py install for mozInstall 00:21:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Running setup.py install for mozleak 00:21:28 INFO - Running setup.py install for mozlog 00:21:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Running setup.py install for moznetwork 00:21:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Running setup.py install for mozprocess 00:21:28 INFO - Running setup.py install for mozprofile 00:21:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:21:28 INFO - Running setup.py install for mozrunner 00:21:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:21:29 INFO - Running setup.py install for mozscreenshot 00:21:29 INFO - Running setup.py install for moztest 00:21:29 INFO - Running setup.py install for mozversion 00:21:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:21:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:21:29 INFO - Cleaning up... 00:21:29 INFO - Return code: 0 00:21:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:29 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:29 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 00:21:29 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 00:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:29 INFO - 'HOME': '/Users/cltbld', 00:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:29 INFO - 'LOGNAME': 'cltbld', 00:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:29 INFO - 'MOZ_NO_REMOTE': '1', 00:21:29 INFO - 'NO_EM_RESTART': '1', 00:21:29 INFO - 'PAGER': '/bin/cat', 00:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:29 INFO - 'PWD': '/builds/slave/test', 00:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:29 INFO - 'SHELL': '/bin/bash', 00:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:29 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:29 INFO - 'USER': 'cltbld', 00:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:29 INFO - 'XPC_FLAGS': '0x0', 00:21:29 INFO - 'XPC_SERVICE_NAME': '0', 00:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:21:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-40u_Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:21:29 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)) 00:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:21:29 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-DtReHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-omBVMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-2dmITW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-z6qSYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-mHs3U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-TgM4cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-co3v3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-IHzOFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-TuKFdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-hLKbOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:21:30 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)) 00:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:21:30 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-n9LTwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:21:31 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)) 00:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:21:31 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-BGc6CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:21:31 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)) 00:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:21:31 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-hp__1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:21:31 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)) 00:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:31 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-b72ox4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:21:31 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)) 00:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:21:31 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-UC8U6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:21:31 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)) 00:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:21:31 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-IYmRHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:21:31 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)) 00:21:31 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)) 00:21:31 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)) 00:21:31 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)) 00:21:31 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)) 00:21:31 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)) 00:21:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:21:31 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 00:21:31 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 00:21:31 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 00:21:31 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 00:21:31 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 00:21:31 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 00:21:34 INFO - Downloading blessings-1.6.tar.gz 00:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:21:34 INFO - Installing collected packages: blessings 00:21:34 INFO - Running setup.py install for blessings 00:21:34 INFO - Successfully installed blessings 00:21:34 INFO - Cleaning up... 00:21:35 INFO - Return code: 0 00:21:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:21:35 INFO - Reading from file tmpfile_stdout 00:21:35 INFO - Current package versions: 00:21:35 INFO - blessings == 1.6 00:21:35 INFO - blobuploader == 1.2.4 00:21:35 INFO - docopt == 0.6.1 00:21:35 INFO - functools32 == 3.2.3-2 00:21:35 INFO - jsonschema == 2.5.1 00:21:35 INFO - manifestparser == 1.1 00:21:35 INFO - mozInstall == 1.12 00:21:35 INFO - mozcrash == 1.0 00:21:35 INFO - mozdebug == 0.1 00:21:35 INFO - mozdevice == 0.48 00:21:35 INFO - mozfile == 1.2 00:21:35 INFO - mozhttpd == 0.7 00:21:35 INFO - mozinfo == 0.9 00:21:35 INFO - mozleak == 0.1 00:21:35 INFO - mozlog == 3.4 00:21:35 INFO - moznetwork == 0.27 00:21:35 INFO - mozprocess == 0.23 00:21:35 INFO - mozprofile == 0.28 00:21:35 INFO - mozrunner == 6.13 00:21:35 INFO - mozscreenshot == 0.1 00:21:35 INFO - mozsystemmonitor == 0.3 00:21:35 INFO - moztest == 0.8 00:21:35 INFO - mozversion == 1.4 00:21:35 INFO - psutil == 3.1.1 00:21:35 INFO - requests == 1.2.3 00:21:35 INFO - wsgiref == 0.1.2 00:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:21:35 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')]} 00:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:35 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')]} 00:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:35 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:35 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 00:21:35 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 00:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:35 INFO - 'HOME': '/Users/cltbld', 00:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:35 INFO - 'LOGNAME': 'cltbld', 00:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:35 INFO - 'MOZ_NO_REMOTE': '1', 00:21:35 INFO - 'NO_EM_RESTART': '1', 00:21:35 INFO - 'PAGER': '/bin/cat', 00:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:35 INFO - 'PWD': '/builds/slave/test', 00:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:35 INFO - 'SHELL': '/bin/bash', 00:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:35 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:35 INFO - 'USER': 'cltbld', 00:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:35 INFO - 'XPC_FLAGS': '0x0', 00:21:35 INFO - 'XPC_SERVICE_NAME': '0', 00:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 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)) 00:21:35 INFO - Cleaning up... 00:21:35 INFO - Return code: 0 00:21:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:21:35 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')]} 00:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:35 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')]} 00:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:21:35 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 0x105166490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050dc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca63c9b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, '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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 00:21:35 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 00:21:35 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 00:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:36 INFO - 'HOME': '/Users/cltbld', 00:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:36 INFO - 'LOGNAME': 'cltbld', 00:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:36 INFO - 'MOZ_NO_REMOTE': '1', 00:21:36 INFO - 'NO_EM_RESTART': '1', 00:21:36 INFO - 'PAGER': '/bin/cat', 00:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:36 INFO - 'PWD': '/builds/slave/test', 00:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:36 INFO - 'SHELL': '/bin/bash', 00:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:36 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:36 INFO - 'USER': 'cltbld', 00:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:36 INFO - 'XPC_FLAGS': '0x0', 00:21:36 INFO - 'XPC_SERVICE_NAME': '0', 00:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:21:36 INFO - Cleaning up... 00:21:36 INFO - Return code: 0 00:21:36 INFO - Running post-action listener: _resource_record_post_action 00:21:36 INFO - Running post-action listener: _start_resource_monitoring 00:21:36 INFO - Starting resource monitoring. 00:21:36 INFO - [mozharness: 2017-01-24 08:21:36.290128Z] Finished create-virtualenv step (success) 00:21:36 INFO - [mozharness: 2017-01-24 08:21:36.291184Z] Running install step. 00:21:36 INFO - Running pre-action listener: _resource_record_pre_action 00:21:36 INFO - Running main action method: install 00:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:21:36 INFO - Reading from file tmpfile_stdout 00:21:36 INFO - Detecting whether we're running mozinstall >=1.0... 00:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:21:36 INFO - Reading from file tmpfile_stdout 00:21:36 INFO - Output received: 00:21:36 INFO - Usage: mozinstall [options] installer 00:21:36 INFO - Options: 00:21:36 INFO - -h, --help show this help message and exit 00:21:36 INFO - -d DEST, --destination=DEST 00:21:36 INFO - Directory to install application into. [default: 00:21:36 INFO - "/builds/slave/test"] 00:21:36 INFO - --app=APP Application being installed. [default: firefox] 00:21:36 INFO - mkdir: /builds/slave/test/build/application 00:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:21:57 INFO - Reading from file tmpfile_stdout 00:21:57 INFO - Output received: 00:21:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:21:57 INFO - Running post-action listener: _resource_record_post_action 00:21:57 INFO - [mozharness: 2017-01-24 08:21:57.856116Z] Finished install step (success) 00:21:57 INFO - [mozharness: 2017-01-24 08:21:57.856222Z] Running run-tests step. 00:21:57 INFO - Running pre-action listener: _resource_record_pre_action 00:21:57 INFO - Running main action method: run_tests 00:21:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:21:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:21:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:21:57 INFO - 2017-01-24 00:21:57.870 screenresolution[1627:7348] starting screenresolution argv=screenresolution get 00:21:57 INFO - 2017-01-24 00:21:57.873 screenresolution[1627:7348] Display 0: 1600x1200x32@60 00:21:57 INFO - 2017-01-24 00:21:57.879 screenresolution[1628:7350] starting screenresolution argv=screenresolution list 00:21:57 INFO - Available Modes on Display 0 00:21:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:21:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:21:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:21:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:21:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:21:58 INFO - Intel Iris: 00:21:58 INFO - Chipset Model: Intel Iris 00:21:58 INFO - Type: GPU 00:21:58 INFO - Bus: Built-In 00:21:58 INFO - VRAM (Dynamic, Max): 1536 MB 00:21:58 INFO - Vendor: Intel (0x8086) 00:21:58 INFO - Device ID: 0x0a2e 00:21:58 INFO - Revision ID: 0x0009 00:21:58 INFO - Displays: 00:21:58 INFO - Display: 00:21:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:21:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:21:58 INFO - Display Serial Number: 1600x1200 60 00:21:58 INFO - Main Display: Yes 00:21:58 INFO - Mirror: Off 00:21:58 INFO - Online: Yes 00:21:58 INFO - Rotation: Supported 00:21:58 INFO - Return code: 0 00:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:21:58 INFO - Python 2.7.3 00:21:58 INFO - Return code: 0 00:21:58 INFO - grabbing minidump binary from tooltool 00:21:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:21:58 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 0x104f7ad30>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f72b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:21:58 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 00:21:58 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 00:21:58 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 00:21:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:21:58 INFO - Return code: 0 00:21:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:21:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:21:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:21:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:21:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 00:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --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 00:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QiuNSfd8Pn/Render', 00:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:21:58 INFO - 'HOME': '/Users/cltbld', 00:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:21:58 INFO - 'LOGNAME': 'cltbld', 00:21:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:21:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:21:58 INFO - 'MOZ_NO_REMOTE': '1', 00:21:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:21:58 INFO - 'NO_EM_RESTART': '1', 00:21:58 INFO - 'PAGER': '/bin/cat', 00:21:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:21:58 INFO - 'PWD': '/builds/slave/test', 00:21:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:21:58 INFO - 'SHELL': '/bin/bash', 00:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X33Y4eGqdR/Listeners', 00:21:58 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 00:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:21:58 INFO - 'USER': 'cltbld', 00:21:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:21:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:21:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:21:58 INFO - 'XPC_FLAGS': '0x0', 00:21:58 INFO - 'XPC_SERVICE_NAME': '0', 00:21:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:21:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 00:21:58 INFO - mozversion application_buildid: 20170123213845 00:21:58 INFO - mozversion application_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 00:21:58 INFO - mozversion application_display_name: Firefox 00:21:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:21:58 INFO - mozversion application_name: Firefox 00:21:58 INFO - mozversion application_remotingname: firefox 00:21:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:21:58 INFO - mozversion application_vendor: Mozilla 00:21:58 INFO - mozversion application_version: 52.0 00:21:58 INFO - mozversion platform_buildid: 20170123213845 00:21:58 INFO - mozversion platform_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 00:21:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:21:58 INFO - mozversion platform_version: 52.0 00:21:58 INFO - using testdate: 1485246118 00:21:58 INFO - actual date: 1485246118 00:21:58 INFO - starting webserver on 'localhost:49248' 00:21:58 INFO - SUITE-START | Running 2 tests 00:21:58 INFO - TEST-START | dromaeo_css 00:21:58 INFO - operating with platform_type : mac_ 00:21:58 INFO - Initialising browser for dromaeo_css test... 00:21:58 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpQdy0AJ/profile http://localhost:49248/getInfo.html) 00:22:01 INFO - PROCESS | 1638 | 2017-01-24 00:22:01.535 plugin-container[1641:7531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c3b, name = 'com.apple.tsm.portname' 00:22:01 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:22:01 INFO - PROCESS | 1638 | 2017-01-24 00:22:01.535 plugin-container[1641:7531] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 00:22:01 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:22:01 INFO - PROCESS | 1638 | 2017-01-24 00:22:01.535 plugin-container[1641:7531] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:22:01 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 00:22:01 INFO - PROCESS | 1638 | colorDepth:24 00:22:01 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 00:22:01 INFO - PROCESS | 1638 | __metrics 00:22:01 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 00:22:02 INFO - TEST-INFO | 1638: exit 0 00:22:02 INFO - Browser initialized. 00:22:02 INFO - Running cycle 1/1 for dromaeo_css test... 00:22:02 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpQdy0AJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:22:04 INFO - PROCESS | 1642 | 2017-01-24 00:22:04.763 plugin-container[1643:7660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 00:22:04 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:22:04 INFO - PROCESS | 1642 | 2017-01-24 00:22:04.763 plugin-container[1643:7660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x450f, name = 'com.apple.CFPasteboardClient' 00:22:04 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:22:04 INFO - PROCESS | 1642 | 2017-01-24 00:22:04.763 plugin-container[1643:7660] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:22:14 INFO - PROCESS | 1642 | RSS: Main: 178700288 00:22:14 INFO - PROCESS | 1642 | 00:25:16 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 00:25:18 INFO - PROCESS | 1642 | RSS: Main: 181858304 00:25:18 INFO - PROCESS | 1642 | 00:28:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 00:28:21 INFO - PROCESS | 1642 | RSS: Main: 193871872 00:28:21 INFO - PROCESS | 1642 | 00:31:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 00:31:23 INFO - PROCESS | 1642 | RSS: Main: 195235840 00:31:23 INFO - PROCESS | 1642 | 00:34:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 00:34:26 INFO - PROCESS | 1642 | RSS: Main: 198684672 00:34:26 INFO - PROCESS | 1642 | 00:37:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 00:37:29 INFO - PROCESS | 1642 | RSS: Main: 203198464 00:37:29 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 00:40:32 INFO - PROCESS | 1642 | RSS: Main: 201486336 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | __start_tp_report 00:40:32 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 00:40:32 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 00:40:32 INFO - PROCESS | 1642 | |i|pagename|runs| 00:40:32 INFO - PROCESS | 1642 | |0;dojo.html;2949.380630067687;3575.213453040331;3598.4962105305253;3610.1335679436943;3613.2231570212416;5860.5311575074;5911.408859114086;5945.910811337833;5955.642661440311;5972.372900845414;5672.347680016799;5946.740238709284;5979.641221526712;5986.820395388135;6016.909746353808;5146.2023386374985;5310.62825602208;5331.520163185312;5401.135818269077;5408.621396502246;5388.892222155555;5402.081646120169;5412.134058550632;5418.620696551243;5422.91865622016;5250.212468129773;5292.894142117156;5387.89462701103;5401.540869026137;5440.863978400552;5296.443873393277;5336.38631557372;5363.007843548917;5408.783648654049;5455.18172274162;4482.462104547442;5235.58115350771;5300.443453437372;5343.519083282523;5344.652597581145;4752.7623618818925;5733.254676891977;5965.254343207099;5992.610480318765;6092.695365231765;6182.196314479134;6200.87598248037;6216.502679785652;6229.563930524865;6248.250209974832;4966.602671786249;6276.592021518587;6329.810105696836;6375.234971803413;6396.168498095218;6075.878482430327;6082.422169893853;6092.573519853612;6100.389961003864;6111.724972376165;6193.225846769154;6229.688515574203;6387.329330420332;6406.8718625627225;6425.839354016093;6268.216472940882;6287.654179020106;6290.150829638032;6291.402316779899;6323.336049714806;6268;6311.400416960381;6317.368263173646;6330.968345158337;6331.430171284606;6158.107074474176;6179.783707570214;6202.875942481125;6234.251889773256;6239.719212635442;5650.491455768918;5985.610935289193;6278.748850046039;6290.905636415458;6294.339094395023;5054.721990290495;5092.541671249605;5115.130427827278;5127.974360128175;5128.512791284822;4486.327050942385;4489.820407183742;4558.749268790182;4568.588827005586;4633.397658304399;5954.821355359346;6154.292256390483;6182.474489668429;6198.907016394758;6201.96899015502;6301.243850737941;6308.337624549356;6341.365863413714;6353.68231588428;6393.808185754435;6037.366076561985;6097.3292937776805;6102.420270074336;6127.617148554337;6128.26460824695;5592.937341905025;5627.6904770237215;5640.802571909963;5651.26533550644;5651.660900345993;6591.209054913441;6596.967015164893;6607.933920660732;6611.305812889674;6622.8344291393105;5713.685747283773;6089.51283897296;6202.379762023762;6233.688315584112;6363.713632886624;6548.148740663683;6561.442277406283;6566.573172743756;6566.737330506726;6593.967030164818;6224.37756224374;6264.404881536247;6274.247090349188;6284.402981716729;6292.653904035322;6184.257889053342;6184.752609895734;6200.255969283715;6257.68711564429;6350.110984462087;6154.169187159676;6212.9068063978175;6254.749810007549;6255.124282600531;6264.091706702594;6236;6255.218097737783;6259.467945224706;6282.465990390868;6288.24541055058;5965.821025369246;6031.849203769941;6038.8188354347685;6166.414190651881;6177.876442471215;6182.752689892533;6201.410865967726;6201.6899155041165;6285.214348206474;6305.274893387135;6156.138140660221;6156.969215153896;6196.752129914753;6202.751889924352;6217.222847144107 00:40:32 INFO - PROCESS | 1642 | |1;ext.html;513.4326569141099;519.2859817750593;534.8475684429937;573.7360814025546;574.6322353693639;32941.50587741186;37539.24921501572;38283;40564.39153412701;40606.7969660152;32822;41678;41832.37251441231;42125;42193.57806421935;8142;9707.980662030492;9710.757231069209;9720.805583888317;9732.708018759413;9502.762430939212;9574.664886728966;9580.80838383232;9596.95201523995;9622.566984485715;9575.712728618153;9583.28125390595;9635.325527213097;9675.371100878421;9710.465924374157;8097.9595102024405;9466.148046675798;9629.614815407445;9631.422114673142;9668.70993870185;9577.377470464398;9615.51922403877;9617.951910240405;9621;9676.467794271312;38897.41653875194;39195;39720.404193937116;39752.40371394432;39861.60138398608;3293.950590741141;3463.7748546344405;3521.7006554442905;3715.6284371562897;4192.685548583838;30276.091717248517;30309.393812123635;30727.231819204477;30845.537316940263;30852.611632476594;3215.2283451971593;3276.2464633134273;3322.7009569138895;3333.3666603345287;3430.5025771263026;457961;462705;463792;465647;466413.9999999966;59447.70276148592;59509.702451487465;59622;59954.700226498586;60015.39984600098;60590;61350.77298454006;61614.38385616176;61895.524179032334;61955.690221548604;16661.416850410176;16732.996020238825;16847.494575162764;16969.406070787463;16985.660286794442;12848.229106253655;13155.539556115682;13250.403731832092;13254.867451325363;13264.137831040951;15548.92225538865;15616.297266623029;15809.604759881095;16043.759343609856;16076.598085047968;6029.849253768691;7200.279972002758;7295.963520182365;7302.941073544413;7330.926690733025;889.1730690457936;993.7267251505893;1016.8271393863062;1075.370908018802;1153.76786627414;29777.40445191084;30409.087727368213;30827;30920.381592368478;30964.535531967038;957.1863915671623;997.7006897930592;1118.6923596011;1146.633077415219;1196.8085106382937;15612.92193539025;16013.439529616408;16059.598510037342;16144.354225830835;16147.67704645924;666175;666335;668886;672689;674467;56043.15935260974;57242.141367879514;57887.42112578904;58389.70805145947;58865.41134588685;1280.775864223757;1362.9981963256998;1425.287356321839;1428.4643258777958;1436.5259464376732;26632.733672663024;28820;29291.12126636119;30262.243443914078;30892.69107308988;49878;50260.74348141326;50692.49307506878;50696;50763.492365077356;603119;604529;606283;610020;611274;32494.51258231081;32576.51135233021;39939.80030099831;40298.395524066575;40700.1859962805;46424;47108.7644561775;47469;47728.04543909033;48123.5187648119;38975.025624359616;39060.41409378805;39108.413373798845;39433.605663942995;39623.61317353879;37898.43152352662;38151.618483814804;38377.6162238374;39301.820945371685;39556.60443395645;37366.252674945805;38056.80971595124;38259;38336.80831595824;38375.42436863393;31636;34636.98236006103;34677.9596612102;34873.82563087168;35052;21873.687578745325;26197.73802262029;26283;26474.50924030774;26509.60235596506 00:40:32 INFO - PROCESS | 1642 | |2;jquery.html;371.10933758978456;386.37021654702846;388.15382466223656;399.81408644980087;417.85299353275263;20181.19275228991;21473.24843630471;21560.02979865906;21773;22144.778552214473;19342.51643708908;20845.95770211491;21161;21226.57546849062;21468;5331.520163185312;5602.327720673525;5639.520640745542;5640.323161220639;5704.600677952545;5602.047651899166;5650;5676.460736230051;5701.429857014306;5715.342735585398;5473.972630136844;5541.224228607998;5555.2778138842095;5665.971670141644;5694.886102277952;5543.25166102575;5560.638558493685;5640.407757185498;5855.912161317584;6183.505319574423;5450.972745136249;5928.229330187091;5945.16767652529;5955.047192449188;6052.757889684407;13595.796063059062;13599.59201223965;22929.50958187729;24248.030078796826;25560;2163.468682205855;2402.3153401280724;2451.6690246816806;2764.751172394474;2909.214512081747;10260.794784104351;10587.629432969887;10763.19276054299;10785;13349.86650133496;1782.8841125326812;1854.1841589700623;2013.7684166320914;2025.989870050655;2063.6388631989344;101614;111910.44044779724;137914.31042844823;138019.92970105456;138034;9786.608535658635;10372.585096596202;10459.790804183875;10582.682519524273;11906.46420911061;10931.398773067398;12813.807792883114;12820.935895320463;12826.55107071248;12886.80669789954;8133.792424987703;8377.832443351099;8386.748397548083;8388.832223355499;8439.198276163756;8710.390272680977;8747.737567872973;8760.992485864208;8862.493376126075;8938.731838044869;3577.481265216529;3653.2510835278704;4016.136530645925;4144.378343248537;4147.543770185277;2019.2326915771912;2050.3438899552;2083.14591017682;2088.882447890371;2092.4350425385364;737.5206116024519;781.7654703588901;904.9502577010636;934.9668616179024;971.4074414607084;21708.565828683655;22209.888950555145;22634.207802727156;22747.772522274565;22815.31554053381;856.546030603781;911.49867572836;921.5991043895926;999.2805180270194;1037.8183817832;11474.426278686033;11768.411579420994;11786.646400607995;11843.526258949545;11844.526218951318;553865;609113;617876;620369.7963020402;634639;81598.59200704077;83038;121089;135582;141187;979.3829887171037;1010.7675234696061;1019.8419245017034;1020.7295066807302;1026.958921643126;19848.40454786359;19965.901875396994;20450.386488405373;20464.976751162085;20502.38492845217;53258.93482130413;54977.72511137419;55387.16919246295;57848.42151578599;58100.70949645225;74457.25542744504;81221.18778812373;82523.5873820651;83214;84391.15608844078;8398.916010839814;8425.4944703318;8538.871916921375;8549.572521374032;8598.140185981601;12504.437300321326;13180;13280.734385312433;13328.466861325438;13429.395677194354;11460.426978650867;11612.012978896888;11921.642350729491;11936;11983.940080299542;10940;11075.618741970515;11260.605878794202;11312.547498099984;11491.425428728697;9406.05939406054;11190.720231994264;11716.648500544998;11738.70653233676;12049.879501205227;8152.551609661526;8370.079291277832;8383.664653413794;8484.321254299517;8494.32045436376;9683.32216744821;11351.829722554003;11669.88330116688;11929.880701193224;12028.699282518008 00:40:32 INFO - PROCESS | 1642 | |3;mootools.html;1373.182956141096;1472.5729538433852;1659.917004149793;1834.147121588461;1862.9534261643466;7416.258374162581;7633.893085502599;8070.677172913084;8545.871811922827;8548.016978047519;8045.1552586978405;8305.50166989981;8308.50148991061;8397.622107005183;8404.369672274588;2156.676498525218;2319.5824751544715;2358.587247231736;2389.116027069978;2392.210570511727;2385.189035727852;2411.7097352916194;2427.9757202428013;2436.3543660929868;2442.658027876099;2169.717936668231;2260.604394231011;2382.9880850595723;2383.189715496731;2408.2414039577566;2113.0491278924546;2224.8331375146927;2244.8540844845033;2363.5036642305136;2384.856908585482;2160.0387827416807;2317.2584772872688;2387.8089752819733;2403.4111642647663;2410.9035638574437;8262.793430164294;8292;8328.958355208246;8413.368997325226;8422.536760478171;5139.434662187156;5267.367915850123;5299.920501192485;5309.283246761676;5325.254464374991;3033.529802880557;3303.2567672273785;3405.4210784166753;3554.0581745837376;3555.8933232003083;1035.6012935019996;1040.3913710479378;1093.6008356949735;1098.2092893117024;1098.4946924414778;10735.677929662044;10742.462876856125;10821.729456763644;10834.566617335218;10855.40295283759;4533.795979180879;4649.976750116228;4704.929426058612;4719.386479757678;4798.712077275374;8256.793580160544;9252.491112988715;9282.443053416817;9433.103855133751;9451.29115316354;5251.1598144297495;5256.26412302278;5269;5277.604179686539;5337.306150200449;4374.4531933508315;4383.49589797171;4817.638677099161;4859.368282123372;4873.6832105913;3882.4370466282794;3906.2187562487616;3953.2291203215095;3965.2862484753023;3985.780782056957;1299.590628951877;1301.1412467771227;1306.5296493262417;1312.2651315263483;1325.2843464529046;821.3470291118575;931.7624005878457;936.5925822267335;941.4351389166445;947.3652652722692;5625.043742563774;5865.061590145556;5906.5570082244;5907.940920590739;6007.609505382136;950.3395140377371;966.3766870368573;991.5984026469291;997.6009596161448;1005.532427421238;3477.4609935460044;3811.5426148862316;3956.3274243378696;4034.717569770147;4044.0698639313123;9975.700728977998;10130.544125514369;10157.085862272432;10173.745656358651;10188.184945204513;9860;9864.802703946025;10077.899221007696;10103.646372376932;10143.695689129338;7459.776206713807;7808.648610812527;8012.5192488450875;8056.476329038711;8081.717139900075;5797.333306669787;5843.328017278068;5911.91132133027;5913.113033045078;5975.940240597713;8973.37186396972;9172.954135229282;9190.770230744285;9284.58219380143;9502.239820814457;9447.622095116394;9466.52667366615;9563.378380405251;9581.377210481296;9581.712548623553;6764.3573860483175;6939.375456208965;7054.929450705427;7202.315780000891;7348.96325518369;7858.371330293448;7981.960090199744;8028.43800933929;8050.993625796776;8097.068837083811;6219.689015549114;7157.248488908798;7210.96394518024;7245;7251.709931602888;6884.931150688429;7012.263712310134;7106.324899134574;7120.2167761547225;7165.176004759519;6728.327167283428;6730;6780.32196780318;6784.3894049535775;6797.694103765243;4928.457869634266;4934.777934992862;4935.457099718957;4977.527134922177;4983.352164218773;4889.682170658896;4919.311296418576;4930.8767280818265;4935.432425271139;5062.721550314768 00:40:32 INFO - PROCESS | 1642 | |4;prototype.html;263.31800636351846;266.59610689804947;283.2592769906694;288.9436559870825;332.71220394358886;4877.951220487794;5374.516293533581;5536.640118392302;5566.775309431923;5568.658804717168;4683.437987441512;5481.260029895963;5492.423295553969;5520.199571062193;5522.806701765439;3483.9477407838904;4142.482189726276;4162.771047592381;4176.7076304658685;4195.916081678364;3208;3583.498310236569;3721.758085724433;4017.83482789992;4208.768517731523;4087.386891966214;4106.7125301228925;4118.299889018874;4127.782304220247;4148.315527937902;3877.9030524236837;4096.316912422368;4110.958890411088;4111.835526578933;4118.567550407194;3506.053365591276;3581.28374325136;3586.803439975209;3603.9099022524647;3612.4039533476944;5152.896942061137;5202.609804264657;5216.400113986864;5279.736013199325;5400.648957817769;3801.60498885703;4523.462022912226;4595.425571803525;4769.284607308897;4783.354247176656;5492.105223697818;5707.4577915098;5833.3833023525685;5855.970720146414;5860.853478663025;3699.834552116102;3904.726669133162;3938.6061393860673;3940.3844423786395;3991.7604943703473;4533.54664533544;5512.732071623509;5632.9436705632825;5975.820725378246;6037.064255040432;3314;3390.7782015696043;3615.8553657853918;3988.521377434726;4039.939400908989;3651.4157734762844;3818.9045273868373;4036.6972477064337;4041.555428902818;4077.4699289092823;4499.6400287976885;4542;4695.882602934954;4719.433667959798;4787.138315103315;5063.088644044107;5157.613179011589;5204.375474943031;5242.449542797951;5826.883462330729;1213.8968187704145;1259.218206238181;1284.2615496089786;1289.6131160651767;1319.920804751718;879.7536689726886;895.3061377432542;903.4534106865252;905.5879574793453;909.8999110097884;4553.157665831832;4658.883527911829;5149.9400239904335;5179.81870634526;5204.323437953118;5573;5631.324241091095;5654.321481422174;5694.572907031989;5748.540116790647;4823.758812059383;4831.444383895827;5109.821156259513;5215.295935048795;5223.1718898386025;2657.162993656992;2912.3738396244908;2977.776666749959;2998.4003199360213;3001.0589622170396;4886.9493058991775;5037.697738135724;5219.295395121686;5489.972550137224;5726.77092916287;4728.550787675165;4981.854173540106;5186.066508028591;5425.945740542623;5715.771369145271;5577.776888924479;5805.896879592864;5917.644941303535;5921.111833225051;5935.2877654681715;5289.958273992393;5302.3637163540625;5650.802221922213;5664.320281566238;5690.5163061140265;5033.295338652519;5091;5270.841874743764;5577.2191893135805;5621.594601349662;5225.477452254744;5738.1554358579015;5916.78705865288;5924.674142922181;5952.345242023287;3184.363127374488;3758.718096142855;3810.161764411825;3817.828197731053;3826.693864490778;4556.498785133566;5732.971335143297;5935.762569497172;5967.9701601491715;6010.175217647698;4579.702319349231;5389.167682987803;5843.883122337615;5917.940820591911;5930.280218736518;4507.819687212606;5736.68448235351;5810.970945145247;5861.677607731615;5993.250843644544;4502.01911159102;4570.7257564546235;5674.141583723108;5755.597108202385;5791.189233507396;4620.422447194101;5870.5010074144175;5900.793472228452;5908.936391449581;5915.970420147872;5690.943090569207;5731.76766995098;5771.826845194651;5778.219940308005;5782.508486778671 00:40:32 INFO - PROCESS | 1642 | |5;yui.html;709.0711168369436;734.9999999999997;743.2196193996302;750.3584435307812;771.9421043421745;14797.482088126904;15073.246337683113;15186.772198417018;15418.229088545584;15609.375624974988;13055.60833175004;13288;13318.800217996737;13328.40022199001;13339.933300333509;847.855864503036;885.3935054487697;889.9065598112202;892.2326798952928;893.5800173918248;864.3387808326635;907.0430695616122;907.98305897395;912.0560220172123;915.9771005724876;896.9775755606097;914.8536234202529;938.8263171313329;945.7162851144664;953.6090203016764;793.3256731778;917.9770505737343;937.2221056523069;945.8817647794026;948.9145976862081;665.0390186180971;667.346000919102;691.022203581931;708.9964550177268;710.0520804725697;14554.417823287056;14968.101913885203;14978.925105374403;15164.393424263017;15352.232388380648;13787;13856.400903936907;14058.92970535151;14152.36314365856;14236.359363828653;10362.378257304586;10888.891111088868;10971.780564388668;11134.554617815278;11212.159088068345;3771.7925514096714;3800.4489349044234;3804.372278574032;3833.1758671885677;3918.784466854322;78816;80270;81340;89540.55229723876;96702.51648741782;10900.291481053864;10939;11013.118950484102;11166.776664466828;11169.553217871195;18708.906455467637;19084.618307634046;21062.789372106083;21098.683519747217;21100.366988990354;7467.439942004371;7726.845463090819;7839.333656639135;8165.38759593021;8313.750587482386;4302.548232435549;4475.977620111878;4487.483939346952;4497.752623605667;4513.5486451355255;3313.7680362374404;3391.033555436738;3405.11467018572;3428.2629234714655;3432.056184549219;625.2184769038702;639.1334863138819;652.5856081388258;657.7138944559036;662.9933700663028;632.7408457170291;633.37612451735;634.765136899341;638.7891995641427;653.6666300186939;8705;8736;8926.062763409878;8930.86603700945;9059.501727405055;560.778492495462;566.815784869919;580.7909152705107;594.9494292985145;666.9099671544376;4082.825291329687;4242.896846819787;4341.9565804341555;4352.303631418958;4356.346548017759;106785;111008;111774.44112779383;114656.70686586389;119801.40099299447;90941.54529227444;92104;94084;99863;101876.98123018675;86874.56562717145;88939;90063.54968225247;90796;94832.52583737037;9229.169374756304;9726.416415015121;9899.703008909744;9931.702048938543;9966.651167209402;53435.732821335645;55432;56050.43949560615;57237;58091.83816323734;60230;74441.6277918607;79470.01324966922;81898.59050704946;84223;12025.819612705991;12358.505659773868;12371.319577423328;12386.442610082388;12571.622851314476;14506.1296322221;14678.339474723876;14689.045212061183;14714.926425367805;14716.117032978056;11771.411429428323;12444.564440244549;13144.211347319191;13342.599722008355;14420.711585768435;13561.050726449053;13634.386452609459;13837.515686950908;13940;13990.930045349709;12968.93515532454;13160.670983225496;13201.933990330372;13297.26865022433;13323.933380333036;11208.831867522156;11318.886811132114;11364.602238921598;11877.406129693309;11919.207050658086;11169.609063682732;11569.305841649528;11752.529898803952;11816.881831181578;11827.586034488751 00:40:32 INFO - PROCESS | 1642 | __end_tp_report 00:40:32 INFO - PROCESS | 1642 | __start_cc_report 00:40:32 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,344 00:40:32 INFO - PROCESS | 1642 | __end_cc_report 00:40:32 INFO - PROCESS | 1642 | __startTimestamp1485247232339__endTimestamp 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | ------- Summary: start ------- 00:40:32 INFO - PROCESS | 1642 | Number of tests: 6 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5875.26 Median:6156.97 stddev:651.17 (10.6%) stddev-sans-first:611.38 00:40:32 INFO - PROCESS | 1642 | Values: 2949.4 3575.2 3598.5 3610.1 3613.2 5860.5 5911.4 5945.9 5955.6 5972.4 5672.3 5946.7 5979.6 5986.8 6016.9 5146.2 5310.6 5331.5 5401.1 5408.6 5388.9 5402.1 5412.1 5418.6 5422.9 5250.2 5292.9 5387.9 5401.5 5440.9 5296.4 5336.4 5363.0 5408.8 5455.2 4482.5 5235.6 5300.4 5343.5 5344.7 4752.8 5733.3 5965.3 5992.6 6092.7 6182.2 6200.9 6216.5 6229.6 6248.3 4966.6 6276.6 6329.8 6375.2 6396.2 6075.9 6082.4 6092.6 6100.4 6111.7 6193.2 6229.7 6387.3 6406.9 6425.8 6268.2 6287.7 6290.2 6291.4 6323.3 6268.0 6311.4 6317.4 6331.0 6331.4 6158.1 6179.8 6202.9 6234.3 6239.7 5650.5 5985.6 6278.7 6290.9 6294.3 5054.7 5092.5 5115.1 5128.0 5128.5 4486.3 4489.8 4558.7 4568.6 4633.4 5954.8 6154.3 6182.5 6198.9 6202.0 6301.2 6308.3 6341.4 6353.7 6393.8 6037.4 6097.3 6102.4 6127.6 6128.3 5592.9 5627.7 5640.8 5651.3 5651.7 6591.2 6597.0 6607.9 6611.3 6622.8 5713.7 6089.5 6202.4 6233.7 6363.7 6548.1 6561.4 6566.6 6566.7 6594.0 6224.4 6264.4 6274.2 6284.4 6292.7 6184.3 6184.8 6200.3 6257.7 6350.1 6154.2 6212.9 6254.7 6255.1 6264.1 6236.0 6255.2 6259.5 6282.5 6288.2 5965.8 6031.8 6038.8 6166.4 6177.9 6182.8 6201.4 6201.7 6285.2 6305.3 6156.1 6157.0 6196.8 6202.8 6217.2 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:71247.72 Median:39900.70 stddev:156870.07 (393.2%) stddev-sans-first:157220.23 00:40:32 INFO - PROCESS | 1642 | Values: 513.4 519.3 534.8 573.7 574.6 32941.5 37539.2 38283.0 40564.4 40606.8 32822.0 41678.0 41832.4 42125.0 42193.6 8142.0 9708.0 9710.8 9720.8 9732.7 9502.8 9574.7 9580.8 9597.0 9622.6 9575.7 9583.3 9635.3 9675.4 9710.5 8098.0 9466.1 9629.6 9631.4 9668.7 9577.4 9615.5 9618.0 9621.0 9676.5 38897.4 39195.0 39720.4 39752.4 39861.6 3294.0 3463.8 3521.7 3715.6 4192.7 30276.1 30309.4 30727.2 30845.5 30852.6 3215.2 3276.2 3322.7 3333.4 3430.5 457961.0 462705.0 463792.0 465647.0 466414.0 59447.7 59509.7 59622.0 59954.7 60015.4 60590.0 61350.8 61614.4 61895.5 61955.7 16661.4 16733.0 16847.5 16969.4 16985.7 12848.2 13155.5 13250.4 13254.9 13264.1 15548.9 15616.3 15809.6 16043.8 16076.6 6029.8 7200.3 7296.0 7302.9 7330.9 889.2 993.7 1016.8 1075.4 1153.8 29777.4 30409.1 30827.0 30920.4 30964.5 957.2 997.7 1118.7 1146.6 1196.8 15612.9 16013.4 16059.6 16144.4 16147.7 666175.0 666335.0 668886.0 672689.0 674467.0 56043.2 57242.1 57887.4 58389.7 58865.4 1280.8 1363.0 1425.3 1428.5 1436.5 26632.7 28820.0 29291.1 30262.2 30892.7 49878.0 50260.7 50692.5 50696.0 50763.5 603119.0 604529.0 606283.0 610020.0 611274.0 32494.5 32576.5 39939.8 40298.4 40700.2 46424.0 47108.8 47469.0 47728.0 48123.5 38975.0 39060.4 39108.4 39433.6 39623.6 37898.4 38151.6 38377.6 39301.8 39556.6 37366.3 38056.8 38259.0 38336.8 38375.4 31636.0 34637.0 34678.0 34873.8 35052.0 21873.7 26197.7 26283.0 26474.5 26509.6 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35221.44 Median:13349.85 stddev:101352.70 (759.2%) stddev-sans-first:101603.24 00:40:32 INFO - PROCESS | 1642 | Values: 371.1 386.4 388.2 399.8 417.9 20181.2 21473.2 21560.0 21773.0 22144.8 19342.5 20846.0 21161.0 21226.6 21468.0 5331.5 5602.3 5639.5 5640.3 5704.6 5602.0 5650.0 5676.5 5701.4 5715.3 5474.0 5541.2 5555.3 5666.0 5694.9 5543.3 5560.6 5640.4 5855.9 6183.5 5451.0 5928.2 5945.2 5955.0 6052.8 13595.8 13599.6 22929.5 24248.0 25560.0 2163.5 2402.3 2451.7 2764.8 2909.2 10260.8 10587.6 10763.2 10785.0 13349.9 1782.9 1854.2 2013.8 2026.0 2063.6 101614.0 111910.4 137914.3 138019.9 138034.0 9786.6 10372.6 10459.8 10582.7 11906.5 10931.4 12813.8 12820.9 12826.6 12886.8 8133.8 8377.8 8386.7 8388.8 8439.2 8710.4 8747.7 8761.0 8862.5 8938.7 3577.5 3653.3 4016.1 4144.4 4147.5 2019.2 2050.3 2083.1 2088.9 2092.4 737.5 781.8 905.0 935.0 971.4 21708.6 22209.9 22634.2 22747.8 22815.3 856.5 911.5 921.6 999.3 1037.8 11474.4 11768.4 11786.6 11843.5 11844.5 553865.0 609113.0 617876.0 620369.8 634639.0 81598.6 83038.0 121089.0 135582.0 141187.0 979.4 1010.8 1019.8 1020.7 1027.0 19848.4 19965.9 20450.4 20465.0 20502.4 53258.9 54977.7 55387.2 57848.4 58100.7 74457.3 81221.2 82523.6 83214.0 84391.2 8398.9 8425.5 8538.9 8549.6 8598.1 12504.4 13180.0 13280.7 13328.5 13429.4 11460.4 11612.0 11921.6 11936.0 11983.9 10940.0 11075.6 11260.6 11312.5 11491.4 9406.1 11190.7 11716.6 11738.7 12049.9 8152.6 8370.1 8383.7 8484.3 8494.3 9683.3 11351.8 11669.9 11929.9 12028.7 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5488.61 Median:5261.82 stddev:2956.06 (56.2%) stddev-sans-first:2948.17 00:40:32 INFO - PROCESS | 1642 | Values: 1373.2 1472.6 1659.9 1834.1 1863.0 7416.3 7633.9 8070.7 8545.9 8548.0 8045.2 8305.5 8308.5 8397.6 8404.4 2156.7 2319.6 2358.6 2389.1 2392.2 2385.2 2411.7 2428.0 2436.4 2442.7 2169.7 2260.6 2383.0 2383.2 2408.2 2113.0 2224.8 2244.9 2363.5 2384.9 2160.0 2317.3 2387.8 2403.4 2410.9 8262.8 8292.0 8329.0 8413.4 8422.5 5139.4 5267.4 5299.9 5309.3 5325.3 3033.5 3303.3 3405.4 3554.1 3555.9 1035.6 1040.4 1093.6 1098.2 1098.5 10735.7 10742.5 10821.7 10834.6 10855.4 4533.8 4650.0 4704.9 4719.4 4798.7 8256.8 9252.5 9282.4 9433.1 9451.3 5251.2 5256.3 5269.0 5277.6 5337.3 4374.5 4383.5 4817.6 4859.4 4873.7 3882.4 3906.2 3953.2 3965.3 3985.8 1299.6 1301.1 1306.5 1312.3 1325.3 821.3 931.8 936.6 941.4 947.4 5625.0 5865.1 5906.6 5907.9 6007.6 950.3 966.4 991.6 997.6 1005.5 3477.5 3811.5 3956.3 4034.7 4044.1 9975.7 10130.5 10157.1 10173.7 10188.2 9860.0 9864.8 10077.9 10103.6 10143.7 7459.8 7808.6 8012.5 8056.5 8081.7 5797.3 5843.3 5911.9 5913.1 5975.9 8973.4 9173.0 9190.8 9284.6 9502.2 9447.6 9466.5 9563.4 9581.4 9581.7 6764.4 6939.4 7054.9 7202.3 7349.0 7858.4 7982.0 8028.4 8051.0 8097.1 6219.7 7157.2 7211.0 7245.0 7251.7 6884.9 7012.3 7106.3 7120.2 7165.2 6728.3 6730.0 6780.3 6784.4 6797.7 4928.5 4934.8 4935.5 4977.5 4983.4 4889.7 4919.3 4930.9 4935.4 5062.7 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4548.42 Median:5129.88 stddev:1408.71 (27.5%) stddev-sans-first:1375.46 00:40:32 INFO - PROCESS | 1642 | Values: 263.3 266.6 283.3 288.9 332.7 4878.0 5374.5 5536.6 5566.8 5568.7 4683.4 5481.3 5492.4 5520.2 5522.8 3483.9 4142.5 4162.8 4176.7 4195.9 3208.0 3583.5 3721.8 4017.8 4208.8 4087.4 4106.7 4118.3 4127.8 4148.3 3877.9 4096.3 4111.0 4111.8 4118.6 3506.1 3581.3 3586.8 3603.9 3612.4 5152.9 5202.6 5216.4 5279.7 5400.6 3801.6 4523.5 4595.4 4769.3 4783.4 5492.1 5707.5 5833.4 5856.0 5860.9 3699.8 3904.7 3938.6 3940.4 3991.8 4533.5 5512.7 5632.9 5975.8 6037.1 3314.0 3390.8 3615.9 3988.5 4039.9 3651.4 3818.9 4036.7 4041.6 4077.5 4499.6 4542.0 4695.9 4719.4 4787.1 5063.1 5157.6 5204.4 5242.4 5826.9 1213.9 1259.2 1284.3 1289.6 1319.9 879.8 895.3 903.5 905.6 909.9 4553.2 4658.9 5149.9 5179.8 5204.3 5573.0 5631.3 5654.3 5694.6 5748.5 4823.8 4831.4 5109.8 5215.3 5223.2 2657.2 2912.4 2977.8 2998.4 3001.1 4886.9 5037.7 5219.3 5490.0 5726.8 4728.6 4981.9 5186.1 5425.9 5715.8 5577.8 5805.9 5917.6 5921.1 5935.3 5290.0 5302.4 5650.8 5664.3 5690.5 5033.3 5091.0 5270.8 5577.2 5621.6 5225.5 5738.2 5916.8 5924.7 5952.3 3184.4 3758.7 3810.2 3817.8 3826.7 4556.5 5733.0 5935.8 5968.0 6010.2 4579.7 5389.2 5843.9 5917.9 5930.3 4507.8 5736.7 5811.0 5861.7 5993.3 4502.0 4570.7 5674.1 5755.6 5791.2 4620.4 5870.5 5900.8 5908.9 5916.0 5690.9 5731.8 5771.8 5778.2 5782.5 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20988.01 Median:4354.33 stddev:30601.19 (702.8%) stddev-sans-first:30649.15 00:40:32 INFO - PROCESS | 1642 | Values: 709.1 735.0 743.2 750.4 771.9 14797.5 15073.2 15186.8 15418.2 15609.4 13055.6 13288.0 13318.8 13328.4 13339.9 847.9 885.4 889.9 892.2 893.6 864.3 907.0 908.0 912.1 916.0 897.0 914.9 938.8 945.7 953.6 793.3 918.0 937.2 945.9 948.9 665.0 667.3 691.0 709.0 710.1 14554.4 14968.1 14978.9 15164.4 15352.2 13787.0 13856.4 14058.9 14152.4 14236.4 10362.4 10888.9 10971.8 11134.6 11212.2 3771.8 3800.4 3804.4 3833.2 3918.8 78816.0 80270.0 81340.0 89540.6 96702.5 10900.3 10939.0 11013.1 11166.8 11169.6 18708.9 19084.6 21062.8 21098.7 21100.4 7467.4 7726.8 7839.3 8165.4 8313.8 4302.5 4476.0 4487.5 4497.8 4513.5 3313.8 3391.0 3405.1 3428.3 3432.1 625.2 639.1 652.6 657.7 663.0 632.7 633.4 634.8 638.8 653.7 8705.0 8736.0 8926.1 8930.9 9059.5 560.8 566.8 580.8 594.9 666.9 4082.8 4242.9 4342.0 4352.3 4356.3 106785.0 111008.0 111774.4 114656.7 119801.4 90941.5 92104.0 94084.0 99863.0 101877.0 86874.6 88939.0 90063.5 90796.0 94832.5 9229.2 9726.4 9899.7 9931.7 9966.7 53435.7 55432.0 56050.4 57237.0 58091.8 60230.0 74441.6 79470.0 81898.6 84223.0 12025.8 12358.5 12371.3 12386.4 12571.6 14506.1 14678.3 14689.0 14714.9 14716.1 11771.4 12444.6 13144.2 13342.6 14420.7 13561.1 13634.4 13837.5 13940.0 13990.9 12968.9 13160.7 13201.9 13297.3 13323.9 11208.8 11318.9 11364.6 11877.4 11919.2 11169.6 11569.3 11752.5 11816.9 11827.6 00:40:32 INFO - PROCESS | 1642 | -------- Summary: end -------- 00:40:32 INFO - PROCESS | 1642 | 00:40:32 INFO - TEST-INFO | 1642: exit 0 00:40:32 INFO - TEST-OK | dromaeo_css | took 1114418ms 00:40:32 INFO - TEST-START | kraken 00:40:32 INFO - operating with platform_type : mac_ 00:40:32 INFO - Initialising browser for kraken test... 00:40:32 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpHal1fh/profile http://localhost:49248/getInfo.html) 00:40:35 INFO - PROCESS | 1654 | 2017-01-24 00:40:35.635 plugin-container[1655:9905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 00:40:35 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:40:35 INFO - PROCESS | 1654 | 2017-01-24 00:40:35.636 plugin-container[1655:9905] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 00:40:35 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:40:35 INFO - PROCESS | 1654 | 2017-01-24 00:40:35.636 plugin-container[1655:9905] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:40:35 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 00:40:35 INFO - PROCESS | 1654 | colorDepth:24 00:40:35 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 00:40:35 INFO - PROCESS | 1654 | __metrics 00:40:35 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 00:40:36 INFO - TEST-INFO | 1654: exit 0 00:40:36 INFO - Browser initialized. 00:40:36 INFO - Running cycle 1/1 for kraken test... 00:40:36 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpHal1fh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:40:39 INFO - PROCESS | 1656 | 2017-01-24 00:40:39.222 plugin-container[1657:10022] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 00:40:39 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:40:39 INFO - PROCESS | 1656 | 2017-01-24 00:40:39.223 plugin-container[1657:10022] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 00:40:39 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:40:39 INFO - PROCESS | 1656 | 2017-01-24 00:40:39.223 plugin-container[1657:10022] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:40:49 INFO - PROCESS | 1656 | RSS: Main: 178819072 00:40:49 INFO - PROCESS | 1656 | 00:40:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 00:40:52 INFO - PROCESS | 1656 | RSS: Main: 190935040 00:40:52 INFO - PROCESS | 1656 | 00:40:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 00:40:55 INFO - PROCESS | 1656 | RSS: Main: 199069696 00:40:55 INFO - PROCESS | 1656 | 00:40:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 00:40:59 INFO - PROCESS | 1656 | RSS: Main: 202825728 00:40:59 INFO - PROCESS | 1656 | 00:41:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 00:41:02 INFO - PROCESS | 1656 | RSS: Main: 204185600 00:41:02 INFO - PROCESS | 1656 | 00:41:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:41:05 INFO - PROCESS | 1656 | RSS: Main: 204177408 00:41:05 INFO - PROCESS | 1656 | 00:41:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 00:41:08 INFO - PROCESS | 1656 | RSS: Main: 208326656 00:41:08 INFO - PROCESS | 1656 | 00:41:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 00:41:12 INFO - PROCESS | 1656 | RSS: Main: 207618048 00:41:12 INFO - PROCESS | 1656 | 00:41:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 00:41:16 INFO - PROCESS | 1656 | RSS: Main: 207437824 00:41:16 INFO - PROCESS | 1656 | 00:41:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:41:18 INFO - PROCESS | 1656 | RSS: Main: 206872576 00:41:18 INFO - PROCESS | 1656 | 00:41:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:41:21 INFO - PROCESS | 1656 | RSS: Main: 206966784 00:41:21 INFO - PROCESS | 1656 | 00:41:23 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:41:23 INFO - PROCESS | 1656 | RSS: Main: 206929920 00:41:23 INFO - PROCESS | 1656 | 00:41:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:41:27 INFO - PROCESS | 1656 | RSS: Main: 207233024 00:41:27 INFO - PROCESS | 1656 | 00:41:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:41:30 INFO - PROCESS | 1656 | RSS: Main: 207290368 00:41:30 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 00:41:32 INFO - PROCESS | 1656 | RSS: Main: 208683008 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | __start_tp_report 00:41:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 00:41:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 00:41:32 INFO - PROCESS | 1656 | |i|pagename|runs| 00:41:32 INFO - PROCESS | 1656 | |0;ai-astar;107;116;118;117;116;117;96;172;103;167 00:41:32 INFO - PROCESS | 1656 | |1;audio-beat-detection;142;111;111;141;110;111;112;112;139;112 00:41:32 INFO - PROCESS | 1656 | |2;audio-dft;198;202;194;202;198;196;198;198;196;210 00:41:32 INFO - PROCESS | 1656 | |3;audio-fft;74;59;60;85;66;71;86;83;102;60 00:41:32 INFO - PROCESS | 1656 | |4;audio-oscillator;91;72;124;90;56;90;117;100;99;120 00:41:32 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;132;84;78;74;115;107;77;115;135;95 00:41:32 INFO - PROCESS | 1656 | |6;imaging-darkroom;105;119;90;137;152;141;97;98;152;150 00:41:32 INFO - PROCESS | 1656 | |7;imaging-desaturate;92;91;72;122;140;142;89;90;95;135 00:41:32 INFO - PROCESS | 1656 | |8;json-parse-financial;55;55;55;56;59;57;56;65;86;87 00:41:32 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;72;63;91;108;100;69;69;67;69 00:41:32 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;81;85;82;85;80;83;81;84;85;83 00:41:32 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;156;155;135;136;139;138;128;161;196;180 00:41:32 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;165;165;167;162;167;165;160;163;165;160 00:41:32 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;72;86;85;81;66;67;66;65;66;67 00:41:32 INFO - PROCESS | 1656 | __end_tp_report 00:41:32 INFO - PROCESS | 1656 | __start_cc_report 00:41:32 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,903 00:41:32 INFO - PROCESS | 1656 | __end_cc_report 00:41:32 INFO - PROCESS | 1656 | __startTimestamp1485247292892__endTimestamp 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | ------- Summary: start ------- 00:41:32 INFO - PROCESS | 1656 | Number of tests: 14 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:122.90 Median:117.50 stddev:25.64 (21.8%) stddev-sans-first:26.54 00:41:32 INFO - PROCESS | 1656 | Values: 107.0 116.0 118.0 117.0 116.0 117.0 96.0 172.0 103.0 167.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:112.00 stddev:14.22 (12.7%) stddev-sans-first:12.69 00:41:32 INFO - PROCESS | 1656 | Values: 142.0 111.0 111.0 141.0 110.0 111.0 112.0 112.0 139.0 112.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:199.20 Median:198.00 stddev:4.54 (2.3%) stddev-sans-first:4.80 00:41:32 INFO - PROCESS | 1656 | Values: 198.0 202.0 194.0 202.0 198.0 196.0 198.0 198.0 196.0 210.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:74.60 Median:72.50 stddev:14.21 (19.6%) stddev-sans-first:15.07 00:41:32 INFO - PROCESS | 1656 | Values: 74.0 59.0 60.0 85.0 66.0 71.0 86.0 83.0 102.0 60.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:81.00 stddev:21.34 (26.3%) stddev-sans-first:22.56 00:41:32 INFO - PROCESS | 1656 | Values: 91.0 72.0 124.0 90.0 56.0 90.0 117.0 100.0 99.0 120.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:75.50 stddev:22.86 (30.3%) stddev-sans-first:21.36 00:41:32 INFO - PROCESS | 1656 | Values: 132.0 84.0 78.0 74.0 115.0 107.0 77.0 115.0 135.0 95.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:124.10 Median:152.00 stddev:25.05 (16.5%) stddev-sans-first:25.60 00:41:32 INFO - PROCESS | 1656 | Values: 105.0 119.0 90.0 137.0 152.0 141.0 97.0 98.0 152.0 150.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:89.50 stddev:25.35 (28.3%) stddev-sans-first:26.32 00:41:32 INFO - PROCESS | 1656 | Values: 92.0 91.0 72.0 122.0 140.0 142.0 89.0 90.0 95.0 135.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:58.00 stddev:12.70 (21.9%) stddev-sans-first:13.12 00:41:32 INFO - PROCESS | 1656 | Values: 55.0 55.0 55.0 56.0 59.0 57.0 56.0 65.0 86.0 87.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:69.00 stddev:15.97 (23.2%) stddev-sans-first:16.48 00:41:32 INFO - PROCESS | 1656 | Values: 67.0 72.0 63.0 91.0 108.0 100.0 69.0 69.0 67.0 69.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.85 (2.2%) stddev-sans-first:1.83 00:41:32 INFO - PROCESS | 1656 | Values: 81.0 85.0 82.0 85.0 80.0 83.0 81.0 84.0 85.0 83.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:155.50 stddev:21.88 (14.1%) stddev-sans-first:23.17 00:41:32 INFO - PROCESS | 1656 | Values: 156.0 155.0 135.0 136.0 139.0 138.0 128.0 161.0 196.0 180.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:165.00 stddev:2.56 (1.6%) stddev-sans-first:2.68 00:41:32 INFO - PROCESS | 1656 | Values: 165.0 165.0 167.0 162.0 167.0 165.0 160.0 163.0 165.0 160.0 00:41:32 INFO - PROCESS | 1656 | 00:41:32 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.50 stddev:8.52 (12.3%) stddev-sans-first:9.03 00:41:32 INFO - PROCESS | 1656 | Values: 72.0 86.0 85.0 81.0 66.0 67.0 66.0 65.0 66.0 67.0 00:41:32 INFO - PROCESS | 1656 | -------- Summary: end -------- 00:41:32 INFO - PROCESS | 1656 | 00:41:33 INFO - TEST-INFO | 1656: exit 0 00:41:33 INFO - TEST-OK | kraken | took 60967ms 00:41:33 INFO - SUITE-END | took 1175s 00:41:34 INFO - Completed test suite (00:19:35) 00:41:34 INFO - javascript benchmark 00:41:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7331.896705061149, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2949.380630067687, 3575.213453040331, 3598.4962105305253, 3610.1335679436943, 3613.2231570212416, 5860.5311575074, 5911.408859114086, 5945.910811337833, 5955.642661440311, 5972.372900845414, 5672.347680016799, 5946.740238709284, 5979.641221526712, 5986.820395388135, 6016.909746353808, 5146.2023386374985, 5310.62825602208, 5331.520163185312, 5401.135818269077, 5408.621396502246, 5388.892222155555, 5402.081646120169, 5412.134058550632, 5418.620696551243, 5422.91865622016, 5250.212468129773, 5292.894142117156, 5387.89462701103, 5401.540869026137, 5440.863978400552, 5296.443873393277, 5336.38631557372, 5363.007843548917, 5408.783648654049, 5455.18172274162, 4482.462104547442, 5235.58115350771, 5300.443453437372, 5343.519083282523, 5344.652597581145, 4752.7623618818925, 5733.254676891977, 5965.254343207099, 5992.610480318765, 6092.695365231765, 6182.196314479134, 6200.87598248037, 6216.502679785652, 6229.563930524865, 6248.250209974832, 4966.602671786249, 6276.592021518587, 6329.810105696836, 6375.234971803413, 6396.168498095218, 6075.878482430327, 6082.422169893853, 6092.573519853612, 6100.389961003864, 6111.724972376165, 6193.225846769154, 6229.688515574203, 6387.329330420332, 6406.8718625627225, 6425.839354016093, 6268.216472940882, 6287.654179020106, 6290.150829638032, 6291.402316779899, 6323.336049714806, 6268.0, 6311.400416960381, 6317.368263173646, 6330.968345158337, 6331.430171284606, 6158.107074474176, 6179.783707570214, 6202.875942481125, 6234.251889773256, 6239.719212635442, 5650.491455768918, 5985.610935289193, 6278.748850046039, 6290.905636415458, 6294.339094395023, 5054.721990290495, 5092.541671249605, 5115.130427827278, 5127.974360128175, 5128.512791284822, 4486.327050942385, 4489.820407183742, 4558.749268790182, 4568.588827005586, 4633.397658304399, 5954.821355359346, 6154.292256390483, 6182.474489668429, 6198.907016394758, 6201.96899015502, 6301.243850737941, 6308.337624549356, 6341.365863413714, 6353.68231588428, 6393.808185754435, 6037.366076561985, 6097.3292937776805, 6102.420270074336, 6127.617148554337, 6128.26460824695, 5592.937341905025, 5627.6904770237215, 5640.802571909963, 5651.26533550644, 5651.660900345993, 6591.209054913441, 6596.967015164893, 6607.933920660732, 6611.305812889674, 6622.8344291393105, 5713.685747283773, 6089.51283897296, 6202.379762023762, 6233.688315584112, 6363.713632886624, 6548.148740663683, 6561.442277406283, 6566.573172743756, 6566.737330506726, 6593.967030164818, 6224.37756224374, 6264.404881536247, 6274.247090349188, 6284.402981716729, 6292.653904035322, 6184.257889053342, 6184.752609895734, 6200.255969283715, 6257.68711564429, 6350.110984462087, 6154.169187159676, 6212.9068063978175, 6254.749810007549, 6255.124282600531, 6264.091706702594, 6236.0, 6255.218097737783, 6259.467945224706, 6282.465990390868, 6288.24541055058, 5965.821025369246, 6031.849203769941, 6038.8188354347685, 6166.414190651881, 6177.876442471215, 6182.752689892533, 6201.410865967726, 6201.6899155041165, 6285.214348206474, 6305.274893387135, 6156.138140660221, 6156.969215153896, 6196.752129914753, 6202.751889924352, 6217.222847144107], "value": 5835.08076516255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4326569141099, 519.2859817750593, 534.8475684429937, 573.7360814025546, 574.6322353693639, 32941.50587741186, 37539.24921501572, 38283.0, 40564.39153412701, 40606.7969660152, 32822.0, 41678.0, 41832.37251441231, 42125.0, 42193.57806421935, 8142.0, 9707.980662030492, 9710.757231069209, 9720.805583888317, 9732.708018759413, 9502.762430939212, 9574.664886728966, 9580.80838383232, 9596.95201523995, 9622.566984485715, 9575.712728618153, 9583.28125390595, 9635.325527213097, 9675.371100878421, 9710.465924374157, 8097.9595102024405, 9466.148046675798, 9629.614815407445, 9631.422114673142, 9668.70993870185, 9577.377470464398, 9615.51922403877, 9617.951910240405, 9621.0, 9676.467794271312, 38897.41653875194, 39195.0, 39720.404193937116, 39752.40371394432, 39861.60138398608, 3293.950590741141, 3463.7748546344405, 3521.7006554442905, 3715.6284371562897, 4192.685548583838, 30276.091717248517, 30309.393812123635, 30727.231819204477, 30845.537316940263, 30852.611632476594, 3215.2283451971593, 3276.2464633134273, 3322.7009569138895, 3333.3666603345287, 3430.5025771263026, 457961.0, 462705.0, 463792.0, 465647.0, 466413.9999999966, 59447.70276148592, 59509.702451487465, 59622.0, 59954.700226498586, 60015.39984600098, 60590.0, 61350.77298454006, 61614.38385616176, 61895.524179032334, 61955.690221548604, 16661.416850410176, 16732.996020238825, 16847.494575162764, 16969.406070787463, 16985.660286794442, 12848.229106253655, 13155.539556115682, 13250.403731832092, 13254.867451325363, 13264.137831040951, 15548.92225538865, 15616.297266623029, 15809.604759881095, 16043.759343609856, 16076.598085047968, 6029.849253768691, 7200.279972002758, 7295.963520182365, 7302.941073544413, 7330.926690733025, 889.1730690457936, 993.7267251505893, 1016.8271393863062, 1075.370908018802, 1153.76786627414, 29777.40445191084, 30409.087727368213, 30827.0, 30920.381592368478, 30964.535531967038, 957.1863915671623, 997.7006897930592, 1118.6923596011, 1146.633077415219, 1196.8085106382937, 15612.92193539025, 16013.439529616408, 16059.598510037342, 16144.354225830835, 16147.67704645924, 666175.0, 666335.0, 668886.0, 672689.0, 674467.0, 56043.15935260974, 57242.141367879514, 57887.42112578904, 58389.70805145947, 58865.41134588685, 1280.775864223757, 1362.9981963256998, 1425.287356321839, 1428.4643258777958, 1436.5259464376732, 26632.733672663024, 28820.0, 29291.12126636119, 30262.243443914078, 30892.69107308988, 49878.0, 50260.74348141326, 50692.49307506878, 50696.0, 50763.492365077356, 603119.0, 604529.0, 606283.0, 610020.0, 611274.0, 32494.51258231081, 32576.51135233021, 39939.80030099831, 40298.395524066575, 40700.1859962805, 46424.0, 47108.7644561775, 47469.0, 47728.04543909033, 48123.5187648119, 38975.025624359616, 39060.41409378805, 39108.413373798845, 39433.605663942995, 39623.61317353879, 37898.43152352662, 38151.618483814804, 38377.6162238374, 39301.820945371685, 39556.60443395645, 37366.252674945805, 38056.80971595124, 38259.0, 38336.80831595824, 38375.42436863393, 31636.0, 34636.98236006103, 34677.9596612102, 34873.82563087168, 35052.0, 21873.687578745325, 26197.73802262029, 26283.0, 26474.50924030774, 26509.60235596506], "value": 20156.369261667238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.10933758978456, 386.37021654702846, 388.15382466223656, 399.81408644980087, 417.85299353275263, 20181.19275228991, 21473.24843630471, 21560.02979865906, 21773.0, 22144.778552214473, 19342.51643708908, 20845.95770211491, 21161.0, 21226.57546849062, 21468.0, 5331.520163185312, 5602.327720673525, 5639.520640745542, 5640.323161220639, 5704.600677952545, 5602.047651899166, 5650.0, 5676.460736230051, 5701.429857014306, 5715.342735585398, 5473.972630136844, 5541.224228607998, 5555.2778138842095, 5665.971670141644, 5694.886102277952, 5543.25166102575, 5560.638558493685, 5640.407757185498, 5855.912161317584, 6183.505319574423, 5450.972745136249, 5928.229330187091, 5945.16767652529, 5955.047192449188, 6052.757889684407, 13595.796063059062, 13599.59201223965, 22929.50958187729, 24248.030078796826, 25560.0, 2163.468682205855, 2402.3153401280724, 2451.6690246816806, 2764.751172394474, 2909.214512081747, 10260.794784104351, 10587.629432969887, 10763.19276054299, 10785.0, 13349.86650133496, 1782.8841125326812, 1854.1841589700623, 2013.7684166320914, 2025.989870050655, 2063.6388631989344, 101614.0, 111910.44044779724, 137914.31042844823, 138019.92970105456, 138034.0, 9786.608535658635, 10372.585096596202, 10459.790804183875, 10582.682519524273, 11906.46420911061, 10931.398773067398, 12813.807792883114, 12820.935895320463, 12826.55107071248, 12886.80669789954, 8133.792424987703, 8377.832443351099, 8386.748397548083, 8388.832223355499, 8439.198276163756, 8710.390272680977, 8747.737567872973, 8760.992485864208, 8862.493376126075, 8938.731838044869, 3577.481265216529, 3653.2510835278704, 4016.136530645925, 4144.378343248537, 4147.543770185277, 2019.2326915771912, 2050.3438899552, 2083.14591017682, 2088.882447890371, 2092.4350425385364, 737.5206116024519, 781.7654703588901, 904.9502577010636, 934.9668616179024, 971.4074414607084, 21708.565828683655, 22209.888950555145, 22634.207802727156, 22747.772522274565, 22815.31554053381, 856.546030603781, 911.49867572836, 921.5991043895926, 999.2805180270194, 1037.8183817832, 11474.426278686033, 11768.411579420994, 11786.646400607995, 11843.526258949545, 11844.526218951318, 553865.0, 609113.0, 617876.0, 620369.7963020402, 634639.0, 81598.59200704077, 83038.0, 121089.0, 135582.0, 141187.0, 979.3829887171037, 1010.7675234696061, 1019.8419245017034, 1020.7295066807302, 1026.958921643126, 19848.40454786359, 19965.901875396994, 20450.386488405373, 20464.976751162085, 20502.38492845217, 53258.93482130413, 54977.72511137419, 55387.16919246295, 57848.42151578599, 58100.70949645225, 74457.25542744504, 81221.18778812373, 82523.5873820651, 83214.0, 84391.15608844078, 8398.916010839814, 8425.4944703318, 8538.871916921375, 8549.572521374032, 8598.140185981601, 12504.437300321326, 13180.0, 13280.734385312433, 13328.466861325438, 13429.395677194354, 11460.426978650867, 11612.012978896888, 11921.642350729491, 11936.0, 11983.940080299542, 10940.0, 11075.618741970515, 11260.605878794202, 11312.547498099984, 11491.425428728697, 9406.05939406054, 11190.720231994264, 11716.648500544998, 11738.70653233676, 12049.879501205227, 8152.551609661526, 8370.079291277832, 8383.664653413794, 8484.321254299517, 8494.32045436376, 9683.32216744821, 11351.829722554003, 11669.88330116688, 11929.880701193224, 12028.699282518008], "value": 9617.82619258137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.182956141096, 1472.5729538433852, 1659.917004149793, 1834.147121588461, 1862.9534261643466, 7416.258374162581, 7633.893085502599, 8070.677172913084, 8545.871811922827, 8548.016978047519, 8045.1552586978405, 8305.50166989981, 8308.50148991061, 8397.622107005183, 8404.369672274588, 2156.676498525218, 2319.5824751544715, 2358.587247231736, 2389.116027069978, 2392.210570511727, 2385.189035727852, 2411.7097352916194, 2427.9757202428013, 2436.3543660929868, 2442.658027876099, 2169.717936668231, 2260.604394231011, 2382.9880850595723, 2383.189715496731, 2408.2414039577566, 2113.0491278924546, 2224.8331375146927, 2244.8540844845033, 2363.5036642305136, 2384.856908585482, 2160.0387827416807, 2317.2584772872688, 2387.8089752819733, 2403.4111642647663, 2410.9035638574437, 8262.793430164294, 8292.0, 8328.958355208246, 8413.368997325226, 8422.536760478171, 5139.434662187156, 5267.367915850123, 5299.920501192485, 5309.283246761676, 5325.254464374991, 3033.529802880557, 3303.2567672273785, 3405.4210784166753, 3554.0581745837376, 3555.8933232003083, 1035.6012935019996, 1040.3913710479378, 1093.6008356949735, 1098.2092893117024, 1098.4946924414778, 10735.677929662044, 10742.462876856125, 10821.729456763644, 10834.566617335218, 10855.40295283759, 4533.795979180879, 4649.976750116228, 4704.929426058612, 4719.386479757678, 4798.712077275374, 8256.793580160544, 9252.491112988715, 9282.443053416817, 9433.103855133751, 9451.29115316354, 5251.1598144297495, 5256.26412302278, 5269.0, 5277.604179686539, 5337.306150200449, 4374.4531933508315, 4383.49589797171, 4817.638677099161, 4859.368282123372, 4873.6832105913, 3882.4370466282794, 3906.2187562487616, 3953.2291203215095, 3965.2862484753023, 3985.780782056957, 1299.590628951877, 1301.1412467771227, 1306.5296493262417, 1312.2651315263483, 1325.2843464529046, 821.3470291118575, 931.7624005878457, 936.5925822267335, 941.4351389166445, 947.3652652722692, 5625.043742563774, 5865.061590145556, 5906.5570082244, 5907.940920590739, 6007.609505382136, 950.3395140377371, 966.3766870368573, 991.5984026469291, 997.6009596161448, 1005.532427421238, 3477.4609935460044, 3811.5426148862316, 3956.3274243378696, 4034.717569770147, 4044.0698639313123, 9975.700728977998, 10130.544125514369, 10157.085862272432, 10173.745656358651, 10188.184945204513, 9860.0, 9864.802703946025, 10077.899221007696, 10103.646372376932, 10143.695689129338, 7459.776206713807, 7808.648610812527, 8012.5192488450875, 8056.476329038711, 8081.717139900075, 5797.333306669787, 5843.328017278068, 5911.91132133027, 5913.113033045078, 5975.940240597713, 8973.37186396972, 9172.954135229282, 9190.770230744285, 9284.58219380143, 9502.239820814457, 9447.622095116394, 9466.52667366615, 9563.378380405251, 9581.377210481296, 9581.712548623553, 6764.3573860483175, 6939.375456208965, 7054.929450705427, 7202.315780000891, 7348.96325518369, 7858.371330293448, 7981.960090199744, 8028.43800933929, 8050.993625796776, 8097.068837083811, 6219.689015549114, 7157.248488908798, 7210.96394518024, 7245.0, 7251.709931602888, 6884.931150688429, 7012.263712310134, 7106.324899134574, 7120.2167761547225, 7165.176004759519, 6728.327167283428, 6730.0, 6780.32196780318, 6784.3894049535775, 6797.694103765243, 4928.457869634266, 4934.777934992862, 4935.457099718957, 4977.527134922177, 4983.352164218773, 4889.682170658896, 4919.311296418576, 4930.8767280818265, 4935.432425271139, 5062.721550314768], "value": 4478.564448727572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.31800636351846, 266.59610689804947, 283.2592769906694, 288.9436559870825, 332.71220394358886, 4877.951220487794, 5374.516293533581, 5536.640118392302, 5566.775309431923, 5568.658804717168, 4683.437987441512, 5481.260029895963, 5492.423295553969, 5520.199571062193, 5522.806701765439, 3483.9477407838904, 4142.482189726276, 4162.771047592381, 4176.7076304658685, 4195.916081678364, 3208.0, 3583.498310236569, 3721.758085724433, 4017.83482789992, 4208.768517731523, 4087.386891966214, 4106.7125301228925, 4118.299889018874, 4127.782304220247, 4148.315527937902, 3877.9030524236837, 4096.316912422368, 4110.958890411088, 4111.835526578933, 4118.567550407194, 3506.053365591276, 3581.28374325136, 3586.803439975209, 3603.9099022524647, 3612.4039533476944, 5152.896942061137, 5202.609804264657, 5216.400113986864, 5279.736013199325, 5400.648957817769, 3801.60498885703, 4523.462022912226, 4595.425571803525, 4769.284607308897, 4783.354247176656, 5492.105223697818, 5707.4577915098, 5833.3833023525685, 5855.970720146414, 5860.853478663025, 3699.834552116102, 3904.726669133162, 3938.6061393860673, 3940.3844423786395, 3991.7604943703473, 4533.54664533544, 5512.732071623509, 5632.9436705632825, 5975.820725378246, 6037.064255040432, 3314.0, 3390.7782015696043, 3615.8553657853918, 3988.521377434726, 4039.939400908989, 3651.4157734762844, 3818.9045273868373, 4036.6972477064337, 4041.555428902818, 4077.4699289092823, 4499.6400287976885, 4542.0, 4695.882602934954, 4719.433667959798, 4787.138315103315, 5063.088644044107, 5157.613179011589, 5204.375474943031, 5242.449542797951, 5826.883462330729, 1213.8968187704145, 1259.218206238181, 1284.2615496089786, 1289.6131160651767, 1319.920804751718, 879.7536689726886, 895.3061377432542, 903.4534106865252, 905.5879574793453, 909.8999110097884, 4553.157665831832, 4658.883527911829, 5149.9400239904335, 5179.81870634526, 5204.323437953118, 5573.0, 5631.324241091095, 5654.321481422174, 5694.572907031989, 5748.540116790647, 4823.758812059383, 4831.444383895827, 5109.821156259513, 5215.295935048795, 5223.1718898386025, 2657.162993656992, 2912.3738396244908, 2977.776666749959, 2998.4003199360213, 3001.0589622170396, 4886.9493058991775, 5037.697738135724, 5219.295395121686, 5489.972550137224, 5726.77092916287, 4728.550787675165, 4981.854173540106, 5186.066508028591, 5425.945740542623, 5715.771369145271, 5577.776888924479, 5805.896879592864, 5917.644941303535, 5921.111833225051, 5935.2877654681715, 5289.958273992393, 5302.3637163540625, 5650.802221922213, 5664.320281566238, 5690.5163061140265, 5033.295338652519, 5091.0, 5270.841874743764, 5577.2191893135805, 5621.594601349662, 5225.477452254744, 5738.1554358579015, 5916.78705865288, 5924.674142922181, 5952.345242023287, 3184.363127374488, 3758.718096142855, 3810.161764411825, 3817.828197731053, 3826.693864490778, 4556.498785133566, 5732.971335143297, 5935.762569497172, 5967.9701601491715, 6010.175217647698, 4579.702319349231, 5389.167682987803, 5843.883122337615, 5917.940820591911, 5930.280218736518, 4507.819687212606, 5736.68448235351, 5810.970945145247, 5861.677607731615, 5993.250843644544, 4502.01911159102, 4570.7257564546235, 5674.141583723108, 5755.597108202385, 5791.189233507396, 4620.422447194101, 5870.5010074144175, 5900.793472228452, 5908.936391449581, 5915.970420147872, 5690.943090569207, 5731.76766995098, 5771.826845194651, 5778.219940308005, 5782.508486778671], "value": 4093.2069902535413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.0711168369436, 734.9999999999997, 743.2196193996302, 750.3584435307812, 771.9421043421745, 14797.482088126904, 15073.246337683113, 15186.772198417018, 15418.229088545584, 15609.375624974988, 13055.60833175004, 13288.0, 13318.800217996737, 13328.40022199001, 13339.933300333509, 847.855864503036, 885.3935054487697, 889.9065598112202, 892.2326798952928, 893.5800173918248, 864.3387808326635, 907.0430695616122, 907.98305897395, 912.0560220172123, 915.9771005724876, 896.9775755606097, 914.8536234202529, 938.8263171313329, 945.7162851144664, 953.6090203016764, 793.3256731778, 917.9770505737343, 937.2221056523069, 945.8817647794026, 948.9145976862081, 665.0390186180971, 667.346000919102, 691.022203581931, 708.9964550177268, 710.0520804725697, 14554.417823287056, 14968.101913885203, 14978.925105374403, 15164.393424263017, 15352.232388380648, 13787.0, 13856.400903936907, 14058.92970535151, 14152.36314365856, 14236.359363828653, 10362.378257304586, 10888.891111088868, 10971.780564388668, 11134.554617815278, 11212.159088068345, 3771.7925514096714, 3800.4489349044234, 3804.372278574032, 3833.1758671885677, 3918.784466854322, 78816.0, 80270.0, 81340.0, 89540.55229723876, 96702.51648741782, 10900.291481053864, 10939.0, 11013.118950484102, 11166.776664466828, 11169.553217871195, 18708.906455467637, 19084.618307634046, 21062.789372106083, 21098.683519747217, 21100.366988990354, 7467.439942004371, 7726.845463090819, 7839.333656639135, 8165.38759593021, 8313.750587482386, 4302.548232435549, 4475.977620111878, 4487.483939346952, 4497.752623605667, 4513.5486451355255, 3313.7680362374404, 3391.033555436738, 3405.11467018572, 3428.2629234714655, 3432.056184549219, 625.2184769038702, 639.1334863138819, 652.5856081388258, 657.7138944559036, 662.9933700663028, 632.7408457170291, 633.37612451735, 634.765136899341, 638.7891995641427, 653.6666300186939, 8705.0, 8736.0, 8926.062763409878, 8930.86603700945, 9059.501727405055, 560.778492495462, 566.815784869919, 580.7909152705107, 594.9494292985145, 666.9099671544376, 4082.825291329687, 4242.896846819787, 4341.9565804341555, 4352.303631418958, 4356.346548017759, 106785.0, 111008.0, 111774.44112779383, 114656.70686586389, 119801.40099299447, 90941.54529227444, 92104.0, 94084.0, 99863.0, 101876.98123018675, 86874.56562717145, 88939.0, 90063.54968225247, 90796.0, 94832.52583737037, 9229.169374756304, 9726.416415015121, 9899.703008909744, 9931.702048938543, 9966.651167209402, 53435.732821335645, 55432.0, 56050.43949560615, 57237.0, 58091.83816323734, 60230.0, 74441.6277918607, 79470.01324966922, 81898.59050704946, 84223.0, 12025.819612705991, 12358.505659773868, 12371.319577423328, 12386.442610082388, 12571.622851314476, 14506.1296322221, 14678.339474723876, 14689.045212061183, 14714.926425367805, 14716.117032978056, 11771.411429428323, 12444.564440244549, 13144.211347319191, 13342.599722008355, 14420.711585768435, 13561.050726449053, 13634.386452609459, 13837.515686950908, 13940.0, 13990.930045349709, 12968.93515532454, 13160.670983225496, 13201.933990330372, 13297.26865022433, 13323.933380333036, 11208.831867522156, 11318.886811132114, 11364.602238921598, 11877.406129693309, 11919.207050658086, 11169.609063682732, 11569.305841649528, 11752.529898803952, 11816.881831181578, 11827.586034488751], "value": 7490.531274370946, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 118.0, 117.0, 116.0, 117.0, 96.0, 172.0, 103.0, 167.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 111.0, 141.0, 110.0, 111.0, 112.0, 112.0, 139.0, 112.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 194.0, 202.0, 198.0, 196.0, 198.0, 198.0, 196.0, 210.0], "value": 199.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 59.0, 60.0, 85.0, 66.0, 71.0, 86.0, 83.0, 102.0, 60.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 124.0, 90.0, 56.0, 90.0, 117.0, 100.0, 99.0, 120.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 84.0, 78.0, 74.0, 115.0, 107.0, 77.0, 115.0, 135.0, 95.0], "value": 101.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 90.0, 137.0, 152.0, 141.0, 97.0, 98.0, 152.0, 150.0], "value": 124.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 72.0, 122.0, 140.0, 142.0, 89.0, 90.0, 95.0, 135.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 59.0, 57.0, 56.0, 65.0, 86.0, 87.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 63.0, 91.0, 108.0, 100.0, 69.0, 69.0, 67.0, 69.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 82.0, 85.0, 80.0, 83.0, 81.0, 84.0, 85.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 135.0, 136.0, 139.0, 138.0, 128.0, 161.0, 196.0, 180.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 167.0, 162.0, 167.0, 165.0, 160.0, 163.0, 165.0, 160.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 86.0, 85.0, 81.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0], "value": 72.1, "unit": "score"}]}]} 00:41:34 INFO - Return code: 0 00:41:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:41:34 ERROR - # TBPL SUCCESS # 00:41:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:41:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:41:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:41:34 INFO - 2017-01-24 00:41:34.205 screenresolution[1661:10400] starting screenresolution argv=screenresolution get 00:41:34 INFO - 2017-01-24 00:41:34.210 screenresolution[1661:10400] Display 0: 1600x1200x32@60 00:41:34 INFO - 2017-01-24 00:41:34.216 screenresolution[1662:10403] starting screenresolution argv=screenresolution list 00:41:34 INFO - Available Modes on Display 0 00:41:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:41:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:41:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:41:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:41:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:41:34 INFO - Intel Iris: 00:41:34 INFO - Chipset Model: Intel Iris 00:41:34 INFO - Type: GPU 00:41:34 INFO - Bus: Built-In 00:41:34 INFO - VRAM (Dynamic, Max): 1536 MB 00:41:34 INFO - Vendor: Intel (0x8086) 00:41:34 INFO - Device ID: 0x0a2e 00:41:34 INFO - Revision ID: 0x0009 00:41:34 INFO - Displays: 00:41:34 INFO - Display: 00:41:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:41:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:41:34 INFO - Display Serial Number: 1600x1200 60 00:41:34 INFO - Main Display: Yes 00:41:34 INFO - Mirror: Off 00:41:34 INFO - Online: Yes 00:41:34 INFO - Rotation: Supported 00:41:34 INFO - Return code: 0 00:41:34 INFO - Running post-action listener: _resource_record_post_action 00:41:34 INFO - [mozharness: 2017-01-24 08:41:34.458900Z] Finished run-tests step (success) 00:41:34 INFO - Running post-run listener: _resource_record_post_run 00:41:34 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39094272; Write bytes: 499064832; Read time: 245; Write time: 1604 00:41:34 INFO - TinderboxPrint: CPU usage
54.2% 00:41:34 INFO - TinderboxPrint: I/O read bytes / time
39,094,272 / 245 00:41:34 INFO - TinderboxPrint: I/O write bytes / time
499,064,832 / 1,604 00:41:34 INFO - TinderboxPrint: CPU idle
2,195.6 (45.8%) 00:41:34 INFO - TinderboxPrint: CPU system
969.4 (20.2%) 00:41:34 INFO - TinderboxPrint: CPU user
1,624.8 (33.9%) 00:41:34 INFO - TinderboxPrint: Swap in / out
230,350,848 / 0 00:41:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 186878464; Write bytes: 186068992; Read time: 16801; Write time: 419 00:41:34 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37197824; Write bytes: 306044928; Read time: 230; Write time: 1155 00:41:34 INFO - Running post-run listener: _upload_blobber_files 00:41:34 INFO - Blob upload gear active. 00:41:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:41:34 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 00:41:34 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:41:34 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:41:35 INFO - (blobuploader) - INFO - Open directory for files ... 00:41:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:41:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:36 INFO - (blobuploader) - INFO - Done attempting. 00:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:41:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:37 INFO - (blobuploader) - INFO - Done attempting. 00:41:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:41:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:41:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:41:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:41:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:41:39 INFO - (blobuploader) - INFO - Done attempting. 00:41:39 INFO - (blobuploader) - INFO - Iteration through files over. 00:41:39 INFO - Return code: 0 00:41:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:41:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:41:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/681242e897521b5b6bb2df17fa6f7719fbc18521ee3402db4122d857b4c435356404a45a2fbba7ac349a3bfefa52afd072f196383de3580a72181519f9142a74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0eb58246454bdfb30b609fd010975e9a4fab758cf2abbb0024defb9580a11b3a456ea1b717de6bc20e17afc63d23c58a5abd180e5049e79378e6dfe22cc33bb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/04fede6d6f6eb96e3ceb38c9103fc9c811c1506c702f28680c65081e5a81623836537e2162f3651dac146072c81454c9eb2f21c1828f1a2c12276e8270d4eeda"} 00:41:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:41:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:41:39 INFO - Contents: 00:41:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/681242e897521b5b6bb2df17fa6f7719fbc18521ee3402db4122d857b4c435356404a45a2fbba7ac349a3bfefa52afd072f196383de3580a72181519f9142a74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0eb58246454bdfb30b609fd010975e9a4fab758cf2abbb0024defb9580a11b3a456ea1b717de6bc20e17afc63d23c58a5abd180e5049e79378e6dfe22cc33bb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/04fede6d6f6eb96e3ceb38c9103fc9c811c1506c702f28680c65081e5a81623836537e2162f3651dac146072c81454c9eb2f21c1828f1a2c12276e8270d4eeda"} 00:41:39 INFO - Running post-run listener: copy_logs_to_upload_dir 00:41:39 INFO - Copying logs to upload dir... 00:41:39 INFO - mkdir: /builds/slave/test/build/upload/logs 00:41:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.010082 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-24 00:41:39.711853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 00:41:39.715041) ========= 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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-Beta/sha512/681242e897521b5b6bb2df17fa6f7719fbc18521ee3402db4122d857b4c435356404a45a2fbba7ac349a3bfefa52afd072f196383de3580a72181519f9142a74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0eb58246454bdfb30b609fd010975e9a4fab758cf2abbb0024defb9580a11b3a456ea1b717de6bc20e17afc63d23c58a5abd180e5049e79378e6dfe22cc33bb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/04fede6d6f6eb96e3ceb38c9103fc9c811c1506c702f28680c65081e5a81623836537e2162f3651dac146072c81454c9eb2f21c1828f1a2c12276e8270d4eeda"} build_url:https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011021 build_url: 'https://queue.taskcluster.net/v1/task/cz9ie37UQGGEad6zTTvXGw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/681242e897521b5b6bb2df17fa6f7719fbc18521ee3402db4122d857b4c435356404a45a2fbba7ac349a3bfefa52afd072f196383de3580a72181519f9142a74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0eb58246454bdfb30b609fd010975e9a4fab758cf2abbb0024defb9580a11b3a456ea1b717de6bc20e17afc63d23c58a5abd180e5049e79378e6dfe22cc33bb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/04fede6d6f6eb96e3ceb38c9103fc9c811c1506c702f28680c65081e5a81623836537e2162f3651dac146072c81454c9eb2f21c1828f1a2c12276e8270d4eeda"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 00:41:39.753156) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:41:39.753930) ========= 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.QiuNSfd8Pn/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.X33Y4eGqdR/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.005108 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 00:41:39.812446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 00:41:39.812737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 00:41:39.813064) ========= ========= Total master_lag: 0.91 =========