builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1480693593.45 results: success (0) buildid: 20161202063745 builduid: 66b6a8ed1329485fa5b58b2c57e7699e revision: 857532658f4838d486a8c54be6fbfceed7d2030e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:33.449535) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:33.450088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:33.450370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:33.801517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:33.801960) ========= 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.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 --2016-12-02 07:46:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.1M=0s 2016-12-02 07:46:34 (25.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.391437 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:34.254178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:34.254469) ========= 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.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.026690 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:34.306278) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 07:46:34.306623) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 857532658f4838d486a8c54be6fbfceed7d2030e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 857532658f4838d486a8c54be6fbfceed7d2030e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 2016-12-02 07:46:34,439 truncating revision to first 12 chars 2016-12-02 07:46:34,439 Setting DEBUG logging. 2016-12-02 07:46:34,439 attempt 1/10 2016-12-02 07:46:34,439 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/857532658f48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 07:46:35,127 unpacking tar archive at: mozilla-aurora-857532658f48/testing/mozharness/ program finished with exit code 0 elapsedTime=0.973142 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 07:46:35.309149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:35.309472) ========= script_repo_revision: 857532658f4838d486a8c54be6fbfceed7d2030e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:35.309889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:35.310156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 07:46:35.329834) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-12-02 07:46:35.330132) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:46:35 INFO - MultiFileLogger online at 20161202 07:46:35 in /builds/slave/test 07:46:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:46:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:35 INFO - {'append_to_log': False, 07:46:35 INFO - 'base_work_dir': '/builds/slave/test', 07:46:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:46:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:35 INFO - 'branch': 'Mozilla-Aurora', 07:46:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:35 INFO - 'config_files': ('talos/mac_config.py',), 07:46:35 INFO - 'default_actions': ('clobber', 07:46:35 INFO - 'read-buildbot-config', 07:46:35 INFO - 'download-and-extract', 07:46:35 INFO - 'populate-webroot', 07:46:35 INFO - 'create-virtualenv', 07:46:35 INFO - 'install', 07:46:35 INFO - 'run-tests'), 07:46:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:35 INFO - 'download_minidump_stackwalk': True, 07:46:35 INFO - 'download_symbols': 'ondemand', 07:46:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:35 INFO - 'installer_path': 'installer.exe', 07:46:35 INFO - 'log_level': 'info', 07:46:35 INFO - 'log_name': 'talos', 07:46:35 INFO - 'log_to_console': True, 07:46:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:35 INFO - 'opt_config_files': (), 07:46:35 INFO - 'pip_index': False, 07:46:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:35 INFO - 'cmd': ('bash', 07:46:35 INFO - '-c', 07:46:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:35 INFO - 'enabled': True, 07:46:35 INFO - 'halt_on_failure': False, 07:46:35 INFO - 'name': 'check_screen_resolution'},), 07:46:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:35 INFO - 'cmd': ('bash', 07:46:35 INFO - '-c', 07:46:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:35 INFO - 'enabled': True, 07:46:35 INFO - 'halt_on_failure': False, 07:46:35 INFO - 'name': 'check_screen_resolution'},), 07:46:35 INFO - 'run_cmd_checks_enabled': True, 07:46:35 INFO - 'sps_profile': False, 07:46:35 INFO - 'sps_profile_interval': 0, 07:46:35 INFO - 'suite': 'dromaeojs-e10s', 07:46:35 INFO - 'system_bits': '32', 07:46:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:35 INFO - 'title': 't-yosemite-r7-0167', 07:46:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:35 INFO - 'use_talos_json': True, 07:46:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:35 INFO - 'work_dir': 'build'} 07:46:35 INFO - [mozharness: 2016-12-02 15:46:35.570962Z] Running clobber step. 07:46:35 INFO - Running pre-action listener: _resource_record_pre_action 07:46:35 INFO - Running main action method: clobber 07:46:35 INFO - rmtree: /builds/slave/test/build 07:46:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:37 INFO - Running post-action listener: _resource_record_post_action 07:46:37 INFO - [mozharness: 2016-12-02 15:46:37.938322Z] Finished clobber step (success) 07:46:37 INFO - [mozharness: 2016-12-02 15:46:37.938481Z] Running read-buildbot-config step. 07:46:37 INFO - Running pre-action listener: _resource_record_pre_action 07:46:37 INFO - Running main action method: read_buildbot_config 07:46:37 INFO - Using buildbot properties: 07:46:37 INFO - { 07:46:37 INFO - "project": "", 07:46:37 INFO - "product": "firefox", 07:46:37 INFO - "script_repo_revision": "production", 07:46:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:46:37 INFO - "repository": "", 07:46:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:46:37 INFO - "buildid": "20161202063745", 07:46:37 INFO - "pgo_build": "False", 07:46:37 INFO - "basedir": "/builds/slave/test", 07:46:37 INFO - "buildnumber": 5, 07:46:37 INFO - "slavename": "t-yosemite-r7-0167", 07:46:37 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:46:37 INFO - "platform": "yosemite_r7", 07:46:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:46:37 INFO - "branch": "mozilla-aurora", 07:46:37 INFO - "repo_path": "releases/mozilla-aurora", 07:46:37 INFO - "revision": "857532658f4838d486a8c54be6fbfceed7d2030e", 07:46:37 INFO - "stage_platform": "macosx64", 07:46:37 INFO - "builduid": "66b6a8ed1329485fa5b58b2c57e7699e", 07:46:37 INFO - "slavebuilddir": "test" 07:46:37 INFO - } 07:46:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:46:37 INFO - Running post-action listener: _resource_record_post_action 07:46:37 INFO - [mozharness: 2016-12-02 15:46:37.941881Z] Finished read-buildbot-config step (success) 07:46:37 INFO - [mozharness: 2016-12-02 15:46:37.942001Z] Running download-and-extract step. 07:46:37 INFO - Running pre-action listener: _resource_record_pre_action 07:46:37 INFO - Running main action method: download_and_extract 07:46:37 INFO - mkdir: /builds/slave/test/build/tests 07:46:37 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')]} 07:46:37 INFO - trying https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:46:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:46:38 INFO - Downloaded 1199 bytes. 07:46:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:46:38 INFO - Using the following test package requirements: 07:46:38 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:46:38 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:46:38 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:46:38 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'jsshell-mac.zip'], 07:46:38 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:46:38 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:46:38 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:46:38 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:46:38 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:46:38 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:46:38 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:46:38 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:46:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:46:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:46:38 INFO - Fetch https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:46:39 INFO - Http code: 200 07:46:39 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 07:46:39 INFO - x-amz-cf-id: qe9QY48HwAwc-aS-VfTxXh0YvEyji4BwuhWHzpQ6dbaLmMM4A5xE7A== 07:46:39 INFO - x-amz-version-id: JmoRynZjfR2Xes0DK1aTILqRSIyNwWGU 07:46:39 INFO - Expected file size: 16273993 07:46:39 INFO - Obtained file size: 16273993 07:46:46 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:46:47 INFO - Http code: 200 07:46:47 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 07:46:47 INFO - x-amz-cf-id: sOceiqvha9djqe3Mt7GTgzQMelDJVLfQJRlis2Pw7-DI85JyN-Hmcg== 07:46:47 INFO - x-amz-version-id: JmoRynZjfR2Xes0DK1aTILqRSIyNwWGU 07:46:47 INFO - Expected file size: 16273993 07:46:47 INFO - Obtained file size: 16273993 07:46:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:46:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:46:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:46:54 INFO - Http code: 200 07:46:54 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 07:46:54 INFO - x-amz-cf-id: 6FaMebVBzsF6l_zrszp5udGbLngZIsQkBN1s6RE4P0OKAr5NnA6Hig== 07:46:54 INFO - x-amz-version-id: 0staKh5aW19Vg7RBQkvYxVTPy2GjrBnb 07:46:55 INFO - Expected file size: 14409038 07:46:55 INFO - Obtained file size: 14409038 07:46:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:55 INFO - trying https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:46:55 INFO - Downloading https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:46:58 INFO - Downloaded 109761159 bytes. 07:46:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:46:58 INFO - mkdir: /builds/slave/test/properties 07:46:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:58 INFO - Contents: 07:46:58 INFO - build_url:https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:46:59 INFO - Running post-action listener: _resource_record_post_action 07:46:59 INFO - Running post-action listener: set_extra_try_arguments 07:46:59 INFO - [mozharness: 2016-12-02 15:46:59.038157Z] Finished download-and-extract step (success) 07:46:59 INFO - [mozharness: 2016-12-02 15:46:59.038277Z] Running populate-webroot step. 07:46:59 INFO - Running pre-action listener: _resource_record_pre_action 07:46:59 INFO - Running main action method: populate_webroot 07:46:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:59 INFO - '--tppagecycles', 07:46:59 INFO - '7'], 07:46:59 INFO - 'tests': ['tsvgm']}}, 07:46:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['damp', 'tps']}, 07:46:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'tests': ['damp', 'tps']}, 07:46:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['dromaeo_dom']}, 07:46:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['basic_compositor_video']}, 07:46:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['a11yr', 07:46:59 INFO - 'ts_paint', 07:46:59 INFO - 'tpaint', 07:46:59 INFO - 'sessionrestore', 07:46:59 INFO - 'sessionrestore_no_auto_restore', 07:46:59 INFO - 'tabpaint']}, 07:46:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['tsvgx', 07:46:59 INFO - 'tsvgr_opacity', 07:46:59 INFO - 'tart', 07:46:59 INFO - 'tscrollx', 07:46:59 INFO - 'cart']}, 07:46:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:59 INFO - 'tsvgr_opacity', 07:46:59 INFO - 'tart', 07:46:59 INFO - 'tscrollx', 07:46:59 INFO - 'cart']}, 07:46:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'talos_options': ['--disable-e10s'], 07:46:59 INFO - 'tests': ['tp5o']}, 07:46:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'tests': ['tp5o']}, 07:46:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'talos_options': ['--disable-e10s', 07:46:59 INFO - '--xperf_path', 07:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:59 INFO - 'tests': ['tp5n']}, 07:46:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:59 INFO - 'talos_options': ['--xperf_path', 07:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:59 INFO - 'tests': ['tp5n']}}, 07:46:59 INFO - 'talos.zip': {'path': '', 07:46:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:59 INFO - Running post-action listener: _resource_record_post_action 07:46:59 INFO - [mozharness: 2016-12-02 15:46:59.056922Z] Finished populate-webroot step (success) 07:46:59 INFO - [mozharness: 2016-12-02 15:46:59.057016Z] Running create-virtualenv step. 07:46:59 INFO - Running pre-action listener: _resource_record_pre_action 07:46:59 INFO - Running main action method: create_virtualenv 07:46:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:59 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 07:46:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:59 INFO - Using real prefix '/tools/python27' 07:46:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:02 INFO - Installing pip.................done. 07:47:02 INFO - Return code: 0 07:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:47:03 INFO - Reading from file tmpfile_stdout 07:47:03 INFO - Output received: 07:47:03 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) 07:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:47:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:03 INFO - 'HOME': '/Users/cltbld', 07:47:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:03 INFO - 'LOGNAME': 'cltbld', 07:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:03 INFO - 'MOZ_NO_REMOTE': '1', 07:47:03 INFO - 'NO_EM_RESTART': '1', 07:47:03 INFO - 'PAGER': '/bin/cat', 07:47:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:03 INFO - 'PWD': '/builds/slave/test', 07:47:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:03 INFO - 'SHELL': '/bin/bash', 07:47:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:03 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:03 INFO - 'USER': 'cltbld', 07:47:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:03 INFO - 'XPC_FLAGS': '0x0', 07:47:03 INFO - 'XPC_SERVICE_NAME': '0', 07:47:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:47:03 INFO - Cleaning up... 07:47:03 INFO - Return code: 0 07:47:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:47:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:03 INFO - 'HOME': '/Users/cltbld', 07:47:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:03 INFO - 'LOGNAME': 'cltbld', 07:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:03 INFO - 'MOZ_NO_REMOTE': '1', 07:47:03 INFO - 'NO_EM_RESTART': '1', 07:47:03 INFO - 'PAGER': '/bin/cat', 07:47:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:03 INFO - 'PWD': '/builds/slave/test', 07:47:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:03 INFO - 'SHELL': '/bin/bash', 07:47:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:03 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:03 INFO - 'USER': 'cltbld', 07:47:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:03 INFO - 'XPC_FLAGS': '0x0', 07:47:03 INFO - 'XPC_SERVICE_NAME': '0', 07:47:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:03 INFO - Downloading/unpacking psutil>=3.1.1 07:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:06 INFO - Installing collected packages: psutil 07:47:06 INFO - Running setup.py install for psutil 07:47:07 INFO - building 'psutil._psutil_osx' extension 07:47:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:47:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:47:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:47:07 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 07:47:07 INFO - building 'psutil._psutil_posix' extension 07:47:07 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 07:47:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:47:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:47:07 INFO - ^ 07:47:07 INFO - 1 warning generated. 07:47:07 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 07:47:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:47:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:47:08 INFO - Successfully installed psutil 07:47:08 INFO - Cleaning up... 07:47:08 INFO - Return code: 0 07:47:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:08 INFO - 'HOME': '/Users/cltbld', 07:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:08 INFO - 'LOGNAME': 'cltbld', 07:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:08 INFO - 'MOZ_NO_REMOTE': '1', 07:47:08 INFO - 'NO_EM_RESTART': '1', 07:47:08 INFO - 'PAGER': '/bin/cat', 07:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:08 INFO - 'PWD': '/builds/slave/test', 07:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:08 INFO - 'SHELL': '/bin/bash', 07:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:08 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:08 INFO - 'USER': 'cltbld', 07:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:08 INFO - 'XPC_FLAGS': '0x0', 07:47:08 INFO - 'XPC_SERVICE_NAME': '0', 07:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:47:11 INFO - Installing collected packages: mozsystemmonitor 07:47:11 INFO - Running setup.py install for mozsystemmonitor 07:47:11 INFO - Successfully installed mozsystemmonitor 07:47:11 INFO - Cleaning up... 07:47:11 INFO - Return code: 0 07:47:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:11 INFO - 'HOME': '/Users/cltbld', 07:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:11 INFO - 'LOGNAME': 'cltbld', 07:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:11 INFO - 'MOZ_NO_REMOTE': '1', 07:47:11 INFO - 'NO_EM_RESTART': '1', 07:47:11 INFO - 'PAGER': '/bin/cat', 07:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:11 INFO - 'PWD': '/builds/slave/test', 07:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:11 INFO - 'SHELL': '/bin/bash', 07:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:11 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:11 INFO - 'USER': 'cltbld', 07:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:11 INFO - 'XPC_FLAGS': '0x0', 07:47:11 INFO - 'XPC_SERVICE_NAME': '0', 07:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:47:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:14 INFO - Downloading functools32-3.2.3-2.tar.gz 07:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:47:14 INFO - warning: no files found matching '*.txt' 07:47:14 INFO - no previously-included directories found matching 'build' 07:47:14 INFO - no previously-included directories found matching 'dist' 07:47:14 INFO - no previously-included directories found matching '.git*' 07:47:14 INFO - Installing collected packages: jsonschema, functools32 07:47:14 INFO - Running setup.py install for functools32 07:47:14 INFO - warning: no files found matching '*.txt' 07:47:14 INFO - no previously-included directories found matching 'build' 07:47:14 INFO - no previously-included directories found matching 'dist' 07:47:14 INFO - no previously-included directories found matching '.git*' 07:47:14 INFO - Successfully installed jsonschema functools32 07:47:14 INFO - Cleaning up... 07:47:14 INFO - Return code: 0 07:47:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:47:14 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')]} 07:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:14 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')]} 07:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:14 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 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:14 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 07:47:14 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 07:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:14 INFO - 'HOME': '/Users/cltbld', 07:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:14 INFO - 'LOGNAME': 'cltbld', 07:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:14 INFO - 'MOZ_NO_REMOTE': '1', 07:47:14 INFO - 'NO_EM_RESTART': '1', 07:47:14 INFO - 'PAGER': '/bin/cat', 07:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:14 INFO - 'PWD': '/builds/slave/test', 07:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:14 INFO - 'SHELL': '/bin/bash', 07:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:14 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:14 INFO - 'USER': 'cltbld', 07:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:14 INFO - 'XPC_FLAGS': '0x0', 07:47:14 INFO - 'XPC_SERVICE_NAME': '0', 07:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:47:15 INFO - Cleaning up... 07:47:15 INFO - Return code: 0 07:47:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:47:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:15 INFO - 'HOME': '/Users/cltbld', 07:47:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:15 INFO - 'LOGNAME': 'cltbld', 07:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:15 INFO - 'MOZ_NO_REMOTE': '1', 07:47:15 INFO - 'NO_EM_RESTART': '1', 07:47:15 INFO - 'PAGER': '/bin/cat', 07:47:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:15 INFO - 'PWD': '/builds/slave/test', 07:47:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:15 INFO - 'SHELL': '/bin/bash', 07:47:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:15 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:15 INFO - 'USER': 'cltbld', 07:47:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:15 INFO - 'XPC_FLAGS': '0x0', 07:47:15 INFO - 'XPC_SERVICE_NAME': '0', 07:47:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:47:15 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 07:47:15 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 07:47:15 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 07:47:15 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 07:47:15 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 07:47:15 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 07:47:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:47:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:47:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47: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 07:47:19 INFO - Downloading docopt-0.6.1.tar.gz 07:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:47:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:47:19 INFO - Running setup.py install for blobuploader 07:47:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:47:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:47:19 INFO - Running setup.py install for requests 07:47:19 INFO - Running setup.py install for docopt 07:47:20 INFO - Successfully installed blobuploader requests docopt 07:47:20 INFO - Cleaning up... 07:47:20 INFO - Return code: 0 07:47:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:20 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 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:20 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 07:47:20 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 07:47:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:20 INFO - 'HOME': '/Users/cltbld', 07:47:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:20 INFO - 'LOGNAME': 'cltbld', 07:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:20 INFO - 'MOZ_NO_REMOTE': '1', 07:47:20 INFO - 'NO_EM_RESTART': '1', 07:47:20 INFO - 'PAGER': '/bin/cat', 07:47:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:20 INFO - 'PWD': '/builds/slave/test', 07:47:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:20 INFO - 'SHELL': '/bin/bash', 07:47:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:20 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:20 INFO - 'USER': 'cltbld', 07:47:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:20 INFO - 'XPC_FLAGS': '0x0', 07:47:20 INFO - 'XPC_SERVICE_NAME': '0', 07:47:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BaN4ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AXuI6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BCzOgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SzVzjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-UBbxDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uOf9At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:20 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0Pts0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Y_uAlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PPlfM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-JWdS7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0MEJtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-fYseep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9rOokO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-_cIF32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-dMj1Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:21 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YQO9MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mGlEMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:47:22 INFO - Running setup.py install for manifestparser 07:47:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:47:22 INFO - Running setup.py install for mozcrash 07:47:22 INFO - Running setup.py install for mozdebug 07:47:22 INFO - Running setup.py install for mozdevice 07:47:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:47:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:47:22 INFO - Running setup.py install for mozfile 07:47:22 INFO - Running setup.py install for mozhttpd 07:47:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Running setup.py install for mozinfo 07:47:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Running setup.py install for mozInstall 07:47:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Running setup.py install for mozleak 07:47:23 INFO - Running setup.py install for mozlog 07:47:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Running setup.py install for moznetwork 07:47:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:47:23 INFO - Running setup.py install for mozprocess 07:47:23 INFO - Running setup.py install for mozprofile 07:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:47:24 INFO - Running setup.py install for mozrunner 07:47:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:47:24 INFO - Running setup.py install for mozscreenshot 07:47:24 INFO - Running setup.py install for moztest 07:47:24 INFO - Running setup.py install for mozversion 07:47:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:47:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:47:24 INFO - Cleaning up... 07:47:24 INFO - Return code: 0 07:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47: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')]} 07:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47: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')]} 07:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:24 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 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:24 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 07:47:24 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 07:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:24 INFO - 'HOME': '/Users/cltbld', 07:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:24 INFO - 'LOGNAME': 'cltbld', 07:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:24 INFO - 'MOZ_NO_REMOTE': '1', 07:47:24 INFO - 'NO_EM_RESTART': '1', 07:47:24 INFO - 'PAGER': '/bin/cat', 07:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:24 INFO - 'PWD': '/builds/slave/test', 07:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:24 INFO - 'SHELL': '/bin/bash', 07:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:24 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:24 INFO - 'USER': 'cltbld', 07:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:24 INFO - 'XPC_FLAGS': '0x0', 07:47:24 INFO - 'XPC_SERVICE_NAME': '0', 07:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:47:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7Lpviw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Xd03QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-U9wYbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YPyy9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-lw2N1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LDPQzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-CbC4vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FO0TQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-y_cGtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:47:25 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)) 07:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:47:25 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-1U6CeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Mwbuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:47:26 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-fuxPGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:47:26 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-2Cuzjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:47:26 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-o_xLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:47:26 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-tY92LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:47:26 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-vSPD9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:47:26 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-KFqj0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:47:26 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)) 07:47:26 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)) 07:47:26 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)) 07:47:26 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)) 07:47:26 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)) 07:47:26 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)) 07:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:29 INFO - Downloading blessings-1.6.tar.gz 07:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:47:29 INFO - Installing collected packages: blessings 07:47:29 INFO - Running setup.py install for blessings 07:47:30 INFO - Successfully installed blessings 07:47:30 INFO - Cleaning up... 07:47:30 INFO - Return code: 0 07:47:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:30 INFO - Reading from file tmpfile_stdout 07:47:30 INFO - Current package versions: 07:47:30 INFO - blessings == 1.6 07:47:30 INFO - blobuploader == 1.2.4 07:47:30 INFO - docopt == 0.6.1 07:47:30 INFO - functools32 == 3.2.3-2 07:47:30 INFO - jsonschema == 2.5.1 07:47:30 INFO - manifestparser == 1.1 07:47:30 INFO - mozInstall == 1.12 07:47:30 INFO - mozcrash == 1.0 07:47:30 INFO - mozdebug == 0.1 07:47:30 INFO - mozdevice == 0.48 07:47:30 INFO - mozfile == 1.2 07:47:30 INFO - mozhttpd == 0.7 07:47:30 INFO - mozinfo == 0.9 07:47:30 INFO - mozleak == 0.1 07:47:30 INFO - mozlog == 3.4 07:47:30 INFO - moznetwork == 0.27 07:47:30 INFO - mozprocess == 0.23 07:47:30 INFO - mozprofile == 0.28 07:47:30 INFO - mozrunner == 6.13 07:47:30 INFO - mozscreenshot == 0.1 07:47:30 INFO - mozsystemmonitor == 0.3 07:47:30 INFO - moztest == 0.7 07:47:30 INFO - mozversion == 1.4 07:47:30 INFO - psutil == 3.1.1 07:47:30 INFO - requests == 1.2.3 07:47:30 INFO - wsgiref == 0.1.2 07:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:30 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')]} 07:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:30 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')]} 07:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:30 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 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:30 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 07:47:30 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 07:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:30 INFO - 'HOME': '/Users/cltbld', 07:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:30 INFO - 'LOGNAME': 'cltbld', 07:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:30 INFO - 'MOZ_NO_REMOTE': '1', 07:47:30 INFO - 'NO_EM_RESTART': '1', 07:47:30 INFO - 'PAGER': '/bin/cat', 07:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:30 INFO - 'PWD': '/builds/slave/test', 07:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:30 INFO - 'SHELL': '/bin/bash', 07:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:30 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:30 INFO - 'USER': 'cltbld', 07:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:30 INFO - 'XPC_FLAGS': '0x0', 07:47:30 INFO - 'XPC_SERVICE_NAME': '0', 07:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:31 INFO - Cleaning up... 07:47:31 INFO - Return code: 0 07:47:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1094e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10945b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faaa15cb620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, '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.FZa82J0fkS/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.p6S0Paeewc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 07:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:31 INFO - 'HOME': '/Users/cltbld', 07:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:31 INFO - 'LOGNAME': 'cltbld', 07:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:31 INFO - 'MOZ_NO_REMOTE': '1', 07:47:31 INFO - 'NO_EM_RESTART': '1', 07:47:31 INFO - 'PAGER': '/bin/cat', 07:47:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:31 INFO - 'PWD': '/builds/slave/test', 07:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:31 INFO - 'SHELL': '/bin/bash', 07:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:47:31 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:31 INFO - 'USER': 'cltbld', 07:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:31 INFO - 'XPC_FLAGS': '0x0', 07:47:31 INFO - 'XPC_SERVICE_NAME': '0', 07:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:31 INFO - Cleaning up... 07:47:31 INFO - Return code: 0 07:47:31 INFO - Running post-action listener: _resource_record_post_action 07:47:31 INFO - Running post-action listener: _start_resource_monitoring 07:47:31 INFO - Starting resource monitoring. 07:47:31 INFO - [mozharness: 2016-12-02 15:47:31.374550Z] Finished create-virtualenv step (success) 07:47:31 INFO - [mozharness: 2016-12-02 15:47:31.375527Z] Running install step. 07:47:31 INFO - Running pre-action listener: _resource_record_pre_action 07:47:31 INFO - Running main action method: install 07:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:31 INFO - Reading from file tmpfile_stdout 07:47:31 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:31 INFO - Reading from file tmpfile_stdout 07:47:31 INFO - Output received: 07:47:31 INFO - Usage: mozinstall [options] installer 07:47:31 INFO - Options: 07:47:31 INFO - -h, --help show this help message and exit 07:47:31 INFO - -d DEST, --destination=DEST 07:47:31 INFO - Directory to install application into. [default: 07:47:31 INFO - "/builds/slave/test"] 07:47:31 INFO - --app=APP Application being installed. [default: firefox] 07:47:31 INFO - mkdir: /builds/slave/test/build/application 07:47:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:48:03 INFO - Reading from file tmpfile_stdout 07:48:03 INFO - Output received: 07:48:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:48:03 INFO - Running post-action listener: _resource_record_post_action 07:48:03 INFO - [mozharness: 2016-12-02 15:48:03.636198Z] Finished install step (success) 07:48:03 INFO - [mozharness: 2016-12-02 15:48:03.636332Z] Running run-tests step. 07:48:03 INFO - Running pre-action listener: _resource_record_pre_action 07:48:03 INFO - Running main action method: run_tests 07:48:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:03 INFO - 2016-12-02 07:48:03.650 screenresolution[1628:7747] starting screenresolution argv=screenresolution get 07:48:03 INFO - 2016-12-02 07:48:03.653 screenresolution[1628:7747] Display 0: 1600x1200x32@60 07:48:03 INFO - 2016-12-02 07:48:03.659 screenresolution[1629:7749] starting screenresolution argv=screenresolution list 07:48:03 INFO - Available Modes on Display 0 07:48:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:03 INFO - Intel Iris: 07:48:03 INFO - Chipset Model: Intel Iris 07:48:03 INFO - Type: GPU 07:48:03 INFO - Bus: Built-In 07:48:03 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:03 INFO - Vendor: Intel (0x8086) 07:48:03 INFO - Device ID: 0x0a2e 07:48:03 INFO - Revision ID: 0x0009 07:48:03 INFO - Displays: 07:48:03 INFO - Display: 07:48:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:03 INFO - Display Serial Number: 1600x1200 60 07:48:03 INFO - Main Display: Yes 07:48:03 INFO - Mirror: Off 07:48:03 INFO - Online: Yes 07:48:03 INFO - Rotation: Supported 07:48:03 INFO - Return code: 0 07:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:03 INFO - Python 2.7.3 07:48:03 INFO - Return code: 0 07:48:03 INFO - grabbing minidump binary from tooltool 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092f9d30>, '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 0x10915fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092f1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:48:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:48:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:48:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:04 INFO - Return code: 0 07:48:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 07:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 07:48:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FZa82J0fkS/Render', 07:48:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:04 INFO - 'HOME': '/Users/cltbld', 07:48:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:04 INFO - 'LOGNAME': 'cltbld', 07:48:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:04 INFO - 'MOZ_NO_REMOTE': '1', 07:48:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:04 INFO - 'NO_EM_RESTART': '1', 07:48:04 INFO - 'PAGER': '/bin/cat', 07:48:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:04 INFO - 'PWD': '/builds/slave/test', 07:48:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:04 INFO - 'SHELL': '/bin/bash', 07:48:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p6S0Paeewc/Listeners', 07:48:04 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 07:48:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:04 INFO - 'USER': 'cltbld', 07:48:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:04 INFO - 'XPC_FLAGS': '0x0', 07:48:04 INFO - 'XPC_SERVICE_NAME': '0', 07:48:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 07:48:04 INFO - mozversion application_buildid: 20161202063745 07:48:04 INFO - mozversion application_changeset: 857532658f4838d486a8c54be6fbfceed7d2030e 07:48:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:48:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:04 INFO - mozversion application_name: Firefox 07:48:04 INFO - mozversion application_remotingname: firefox-dev 07:48:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:48:04 INFO - mozversion application_vendor: Mozilla 07:48:04 INFO - mozversion application_version: 52.0a2 07:48:04 INFO - mozversion platform_buildid: 20161202063745 07:48:04 INFO - mozversion platform_changeset: 857532658f4838d486a8c54be6fbfceed7d2030e 07:48:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:48:04 INFO - mozversion platform_version: 52.0a2 07:48:04 INFO - using testdate: 1480693684 07:48:04 INFO - actual date: 1480693684 07:48:04 INFO - starting webserver on 'localhost:49250' 07:48:04 INFO - SUITE-START | Running 2 tests 07:48:04 INFO - TEST-START | dromaeo_css 07:48:04 INFO - operating with platform_type : mac_ 07:48:04 INFO - Initialising browser for dromaeo_css test... 07:48:04 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpu_cary/profile http://localhost:49250/getInfo.html) 07:48:07 INFO - PROCESS | 1639 | 2016-12-02 07:48:07.495 plugin-container[1641:7936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 07:48:07 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:07 INFO - PROCESS | 1639 | 2016-12-02 07:48:07.498 plugin-container[1641:7936] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 07:48:07 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:07 INFO - PROCESS | 1639 | 2016-12-02 07:48:07.498 plugin-container[1641:7936] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:07 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 07:48:07 INFO - PROCESS | 1639 | colorDepth:24 07:48:07 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 07:48:07 INFO - PROCESS | 1639 | __metrics 07:48:07 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:48:08 INFO - TEST-INFO | 1639: exit 0 07:48:08 INFO - Browser initialized. 07:48:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:08 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpu_cary/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:11 INFO - PROCESS | 1642 | 2016-12-02 07:48:11.100 plugin-container[1643:8070] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 07:48:11 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:11 INFO - PROCESS | 1642 | 2016-12-02 07:48:11.102 plugin-container[1643:8070] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 07:48:11 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:48:11 INFO - PROCESS | 1642 | 2016-12-02 07:48:11.102 plugin-container[1643:8070] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:48:20 INFO - PROCESS | 1642 | RSS: Main: 229482496 07:48:20 INFO - PROCESS | 1642 | 07:49:10 INFO - PROCESS | 1642 | 1480693750382 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:51:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 07:51:26 INFO - PROCESS | 1642 | RSS: Main: 234053632 07:51:26 INFO - PROCESS | 1642 | 07:54:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 07:54:29 INFO - PROCESS | 1642 | RSS: Main: 243388416 07:54:29 INFO - PROCESS | 1642 | 07:57:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 07:57:32 INFO - PROCESS | 1642 | RSS: Main: 246296576 07:57:32 INFO - PROCESS | 1642 | 08:00:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 08:00:34 INFO - PROCESS | 1642 | RSS: Main: 245411840 08:00:34 INFO - PROCESS | 1642 | 08:03:37 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 08:03:38 INFO - PROCESS | 1642 | RSS: Main: 249917440 08:03:38 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 08:06:40 INFO - PROCESS | 1642 | RSS: Main: 251289600 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | __start_tp_report 08:06:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 08:06:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 08:06:40 INFO - PROCESS | 1642 | |i|pagename|runs| 08:06:40 INFO - PROCESS | 1642 | |0;dojo.html;3393.9830300848494;3410.590729112507;3415.487676848473;3432.708219801317;3438.724902007839;5797.275340582427;5812.970935145324;5818.505427038702;5852.502537284336;5855.76576936922;4809.230523116302;5744.908467391193;5767.33675627303;5838.182654428373;5876.353601103875;5184.818531351403;5240.895182096356;5253.973730131344;5302.310699609065;5333.4399888011785;5237.162054071349;5314.3091398118195;5315.521603055724;5323;5377.677339359631;5161.27742116104;5181.145111056671;5219.660722053054;5238.161894096965;5245.082110630625;5155.458676838915;5161.225816127573;5187.170052791535;5199.064168449678;5249.580033597303;5101.566366858821;5166.457521960216;5179.197224430181;5234.581233501349;5252.395974462947;4851.835559465738;5757.625754325955;5792.160136780185;5801.767929282823;5819.301683797971;6125.356837532039;6201.534884883652;6214.378562143795;6245.46913512352;6246.531510136758;6207.906881396782;6208.472279856218;6223.751049957997;6232.781852635136;6254.122444084651;5701;5752.36723960364;5759.798407055817;5909.113632955091;5938.792142275;6170.660613666201;6231.875362492725;6264.749410023639;6276.152719382916;6366.84082897922;6166.414190651881;6173.290071641819;6179.969100154471;6193.690315484298;6195.31851496335;6150.876982460326;6205.875882482325;6218.9378106218355;6230.626162430269;6238.563300568917;6067.089936509559;6134.1610691366095;6135.07955838608;6141.539384546177;6163.260408750979;5478.835634930959;5843.152742852262;6190.938090619126;6196.1635179251125;6217.9689101555105;4914.459409464956;4937.259411088294;4954.380702412199;4957.851264462072;4983.9252411213865;4403.515613282536;4435.090806384684;4452.710573812692;4460.30865215892;4477.104579084196;5024.84925452237;5761.164631128463;6001.159837622737;6004.249468816398;6013.428724271187;6153.938460615336;6160.722767475474;6200.751969921243;6231.40801623845;6262.5616206866;5980.671063091571;6018.037114061816;6020.518358531307;6028.2766068072115;6078.544109191828;5235.633505654568;5367.838964831061;5408.161734931014;5428.972855135699;5457.836264912059;6139.2019037526625;6178.752849886134;6187.1647327612;6202.317745047951;6207.6275423474735;5068.391792984866;5379.273798037215;6098.481629061579;6107.511399088151;6133.080037994158;5044.646874718735;5112.233165025127;5588.944110558842;5837;6180.072989051679;4711.222648263135;5276.788928442819;6126.761967422386;6190.535709821691;6193.81418557444;6165.136880836597;6172.259328880563;6177.6911154443;6185.195924529962;6203.7828675996125;5953.940460595339;5982.371850955587;6067.302260239952;6075.453209211192;6121.938780612137;6023.548233882564;6059.303180134341;6069.908951365821;6076.483498902643;6089.421504957022;5889.6171748837905;5987.221661184019;6011.368806275453;6060.6363618181285;6077.48341390969;6059;6064.454199121924;6077.574569780073;6099.2985806632805;6151.3541078186145;5086.28791969132;5997.520198384206;6014.669193194416;6054.576179667381;6078.240219972504 08:06:40 INFO - PROCESS | 1642 | |1;ext.html;437.6498800959232;459.1345314082957;480.730790757176;486.31186870578136;523.0350004242172;35957.82021089894;39353.60646393535;39464.81605551834;41397.17205655885;41440.96397590062;40517.39223911644;40779.79610101953;40851.79574102133;40883.79558102205;40929;9289.860652090225;9429.104235097655;9462.952685236598;9491.14579687828;9491.383060101105;9396.389234699756;9467.053294670512;9470.66852660157;9493.430394176337;9498.762530936712;9426.057394260588;9484.241260699127;9485.004074572174;9492.145706886378;9513.476758778264;9373.203277721368;9456.52717364129;9459.66891158813;9470.905290947072;9483;9295.256379489625;9338.393004454756;9372.8594071089;9388.62445502179;9406.670766523139;38712.80643596792;38819.41770873439;39129;39253.21493570141;39299.60700392988;3292.308615190813;3296.7362610991063;3301.0756988043145;3380.1211684962086;3380.5436266104252;29099.85450072736;29372.853135734185;29873.25316867074;29934.55098173529;30505.69494305051;3163.43058249515;3168.778185527014;3178.8092714437207;3199.440097982867;3271.7219036381935;467269;475704;476478;479626.6018669919;481116;56379;56535;56595;56742.716286418305;56764.148537771965;58779.706101470074;59006.40993590095;59083.70458147682;59421.70289148613;59745;14910;15114.622134446507;15119.16844573559;15182.924085379502;15183.468578599917;11671.591494297829;11682;11731.35477548743;11733.647990560297;11753.942145206973;14126.364313605913;14615.853841461661;15003;15106.773398399033;15341.232938353038;3164.2880351921094;3246.3182731626152;5878.29460464747;6047.334793172748;6051.4553690168095;876.3252295732251;884.8186121845006;934.7008957133788;938.3150300280834;1063.4788953412926;29286.85356573246;29599.85200073986;29602;30028.84985575058;30148.84925575358;1028.2236911132197;1057.3708643357345;1112.866456025266;1127.9210455268053;1158.0966845860241;13058.934705326412;13222.867771322357;15080.698386032438;15389.846101538842;15629.765553516707;602874;643764;643892;644065;644140;54460;54884;54886.72556637191;54984.45015549874;55207.61980950428;1261.4575732435142;1330.886874615649;1350.9324533773467;1353.553327401955;1364.7884577890443;28690;29178.56232156477;29233.707662923098;29763.404731905674;29816.10551683453;47422.288665670734;47666;47682.761586193235;47729.28406073842;47880.52119478761;539925;541795;542035;542223;544204;25732.742672573033;25824.483510330065;26265;26277.605835912094;26310.736892631594;43831;44239.33640995452;44854.3271850929;45039.32441013322;45336.54663453323;37546;37644.62355376411;37678.62321376861;37839.24321513609;38831.2233755329;37223.44164837584;37269;37560.812195938845;38440.6155938437;38531.2293754129;28778;36997.81501092477;37125;37148.88553343404;37183.256334873695;32161.356772863943;33719.831400842835;33839;33923.98228053162;33936.83031584826;24797.25608231756;25094;25360.82679319261;25506.362340941625;25530 08:06:40 INFO - PROCESS | 1642 | |2;jquery.html;366.6938106680921;368.96679298863097;379.15070242656446;382.7072289698383;395.02626026843825;9536.141747242747;11172.776544469105;11600.59397921074;11756.000739937115;18198.454046378596;17356.652866942655;20008.39974800758;21056;21091.68362474564;21586.89206553969;6224.315325314223;6642.169728783902;6654.767083152091;6657.800265992004;6661.600303981777;4345.913081738363;4803.927941080887;6290.685465726719;6407.03894415839;7332.0834895638045;6410.326915673857;6785.76249831256;7026.648667566601;7103.467239956998;7560.017197764283;6157.445829875288;7281.053463049796;7392.593407362593;7400.296971787671;7411.332980031796;6212.937870621281;7075.575465472037;7103.964480177618;7208.747693830744;7261.673224704901;26616.60075098875;26778.196654100408;27268;27592.310192245153;27962.3009424764;2352.7294361148342;2573.6525569048313;2641.8546979916096;2705.3371923878776;3107.704768047032;15049.398024079133;16329.02025878451;16586.83413165865;16635.66728665432;16887;1926;2044.723962265105;2061.288855344904;2065.297798748418;2082.95834083319;79677;133479.6652033477;140130.2993485026;142242;142459.2877035608;16772.832271677373;18131.093445327682;21076.10315071651;21577.460563485725;21840.344789656338;27370.178894633194;34717.652823471944;34981.9505414838;35373;35511.82244088763;10059.949700251453;10159.238057145743;10371.27401081917;10429.530671119817;10514.211434142317;7620.80947976305;7785.416093792988;8324.167583241628;8331.416800824005;8573.957130214309;9454.527273636291;9601.231901447867;9680.806383872425;9708.951455242679;9760.267979901535;1554.6319239069546;1600.3198640577707;1671.2980548169799;1681.991590042042;3704.759190652599;368.95203623529306;380.8952538052058;407.9816408261635;848.8090179709516;892.9330300227509;11566.537338506534;11600.361980091177;11661.24201926872;11698.47356868943;11825.822612660817;420.4240190938434;423.75205021212236;447.17496219475015;877.3376101043672;901.2249465459699;10127.729051141387;10580.788384232272;10657;10675.946620266848;10804;556912.2154389202;568916;577686;594556.0272198698;595287;104402;137199;139239;139494;145822;973.0755782007121;987.6247026130025;994.9005099489993;996.4021587047713;1002.7092143278368;17987.730184047512;18002.63994720072;18134.81865181384;18159.546011349823;18192.363267285582;52322.73838630935;52516.47483525116;52687.94624107573;53033.20450193327;53823;63402;72985.27014729998;76722;78339.60830196041;82051.5897420533;6575.704093315717;7324;8027.357811375193;8061.758147255592;8157.1842815717955;9792.971737967411;10238.897611023795;11257.49341279628;12072;12644.241345519298;9852.310338276251;10636.202284828514;10678.679639610513;10687.893121069;10831.350118992885;4976.402831660224;9485.762855928657;9629.374090684363;10591.841122383325;10677.611910451591;10615.150787936793;10723.678289651323;10802.189835762192;10807.189460790314;11215.887841121485;7976.641051152828;8021.398395120273;8110.148434414302;8114.310283625958;8123.3501319893085;10012.849807253042;10758.46207689628;10832.079273261546;11065.446727663746;11162.386068766296 08:06:40 INFO - PROCESS | 1642 | |3;mootools.html;1284.2679672586626;1458.8912426555821;1614.3623268808822;1755.7454169145467;1809.8280663336977;6002.489788367994;7790.9610451947665;8079.434439589231;8458.984921809384;8512.446690965091;6927;7942.880856787153;8062.91937080629;8200.753977380688;8221.38339624529;1760.8151144129874;2256.4697296135437;2295.4376177836452;2307.2962746362355;2358.433975845802;2120.628889944261;2124.224657999827;2305.5849947009533;2308.4228942764307;2312.4103353644796;2265.026038803314;2278.5556816420803;2320.9303720888315;2349.4126468382906;2352.6118190498632;2322.7096612923383;2334.813214942809;2351.4356554426986;2353.6116540770754;2355;2346.272655476808;2360.6223004319227;2365.065799009382;2374.3351861478814;2378.940526486834;8333.416660833744;8387.245147936716;8505.362097842686;8510.106438823896;8517.190866867699;5101.540861322499;5244.501772331622;5253.553447956928;5256.763445644955;5260.500252476008;3174.8888788892277;3364.966350336514;3595.406757884972;3641.3991691370893;3645.7812531247946;1039.5114296280735;1042.67677020124;1089.8310761831929;1102.6802227354058;1102.939338336391;10934.671959841218;10988.230823842334;11006.559737610485;11034.282771619819;11085.83371249432;4531.342955271467;4580.519045500175;4648.209804333272;4670.416197975253;4698.788554515055;9324.207442367475;9386.483743394043;9482;9510.953795082536;9525.952370238105;5216.713080780518;5239.030779305841;5243;5243.161094224905;5252.080885844962;4259.552746961586;4404.559544045634;4463.174312752087;4494.235979883428;4777.689450185727;3823.464714939855;3868.168343806095;3932.1545867638597;3945.447637330776;3955.723099383016;1275.3686924972199;1291.3285091752236;1292.7479141567492;1301.4533895763802;1308.1366298243113;793.2067932067932;893.9195472407384;894.2756367342473;923.2337160157053;928.661038720862;5560.555155587544;5600.915986260209;5608.663480191201;5650.350209725934;5690.715464226772;883.9469631822111;924.9815003700023;929.1266209762802;964.5804075227298;980.7057882635181;3597.514335564665;3827.6363745444137;3831.023089112314;3866.284737323604;3944.881653550398;9651.372660777028;9891.159251463563;9906.950465247628;10008.79982400348;10009.949950250202;9495.572699228413;9973.401595904124;9981.500924953723;10007.199424046059;10128.59485620567;7679.924810526531;7843.647035883285;7846.568438735924;7916.327112195528;7931.127575966639;4639.095376401704;5665.85835354103;5691.032524470767;5699.23060386859;5822.155787410887;9265.490398028172;9444.858327125236;9456.243500520079;9469.384490008128;9471.19494842946;7754.651040703069;9431.481268530297;9443.905560944302;9453.621855125994;9500.524973751422;7159.821004474929;7212.170600381023;7233.963830180815;7267.127944646676;7299.890501642586;7829.491083079582;7861.174576669596;7961.283484486193;7966.243206895336;7973.760787176394;7047.929520704727;7183.138023437221;7223.277672232734;7234.421246300389;7304.269573042653;6080.2399700037495;6988.8951665724035;7027.367536921702;7069.9646501767165;7131.25121862197;6624.701888414937;6674.799756007327;6702.564333318319;6711;6733.831654208684;4815.181419158681;4832.734199619054;4862.902741945212;4884.340614017062;4897.608191344755;4805.9038819224115;4829.855104346875;4898.828541001048;4950.430700469492;4972.5276098770555 08:06:40 INFO - PROCESS | 1642 | |4;prototype.html;243.83662945826293;297.51802080629386;299.1668204051715;302.30922342447514;306.74541126791416;5199.428062913076;5292.576593872491;5334.119870221413;5406.702391426059;5416.458354164586;4548.590626843584;5051.873703157423;5297.311349524566;5332.280142180804;5351.638414692024;3189.282411457421;3868.678792724371;3964.623360780721;4047.392891066349;4053.2298863215897;3602.6670132051177;3939.8424063037446;4049.4330793688905;4066.512018557777;4120.846163074329;4023.7384570002855;4036.8385264589383;4046.4132700758373;4056.817443215062;4074.6740260779065;3984.023914141025;4001.698598656106;4034.458291276477;4064.9390259146135;4069.9389509157386;2812.3531587734733;3079.7844150909445;3451.87918422854;3506.842192101336;3560.537130173087;3937.7046721495717;4376.094647392572;4983.92845538211;4994.650374473788;5112.872178195537;3737.607551207111;4043.474348334727;4586.885327866797;4614;4625.653076019278;4859.271109333593;5306.787728490855;5606.579506536985;5614.550835933115;5625.465580769861;3751.249750050001;3852.3836186210074;3874.6512813846607;3893.1824316893203;3900.258950799339;5852;5871.178035075093;5872.941270587282;5880.852978675524;5900.7934722284945;3654.3970244909824;3869.187470631143;3935.5670876203594;3945.585713500099;3982.820773065219;3165.6201255848987;3662.8901132966053;3705.8332375043187;4051.534073581517;4053.5946405359227;3775.9056023599082;4531.728096314232;4557.065801510682;4562.224421848294;4571.497135315112;4872.9512704873205;5402.756875940592;5656.123300888369;5667.287926408209;5677;1041.6979076068008;1101.823708206683;1107.789519991199;1108.2740804772886;1121.657894342217;653.3107571512005;772.1622538358671;841.6801615386114;845.5053793530731;877.6752601537472;4369.759663218553;4374.540673229329;5012.523810238022;5074.893919023638;5076.847694569169;4591;4879.096937322288;5178.730811525157;5539.750711218005;5582.934314303652;4145.854895078658;4318.956810431919;4853.49038350968;5049.843847595253;5076;2422.1833624781416;2608.8695565221665;2616.659834221539;2755.870093261753;2904.4481548506137;4738.431388233365;5274.446183150714;5455.987155430071;5594.16799492349;5647.661140331593;4351.521332653406;4956.157453232959;5138.869448721275;5583.581231407661;5599.7480113394995;4413.44831896013;4865.659403841697;5044.369453818273;5120.156743572311;5330.748243571418;4503.437070366204;5018.698878067327;5027.396712394389;5110.729133354582;5297.17893726473;4977.502249774993;5021.447640759587;5193.454687257935;5392.649477783932;5414.675119492843;5568;5603.411641777555;5619.943800561942;5649.406812284651;5664.688442135722;3215.4694475411293;3538.1517878107343;3634.9818250908575;3661.6887564556246;3693.095191678056;4744.715317080986;5146.8604151466825;5165.328507294028;5401.756920938646;5463.093887870192;4779.808807647794;5263.157894736799;5301.390340110936;5320.882614650966;5350.946490535045;4948.208286674115;5141.665791723526;5145.331106956221;5323.813666521653;5326.334208223972;4612.30815377696;5132.358455193101;5254.842354729364;5296.41739408657;5427.937383794291;5570.749316280858;5621.494065534122;5636.577256705846;5653.434656534314;5663.122216056518;5234.842954711365;5453.545904342982;5466;5485.835424937259;5507.807226747044 08:06:40 INFO - PROCESS | 1642 | |5;yui.html;647.8833809914216;672.1161672400796;692.2489099327233;752.7992851402012;791.9366450683946;13873.098248613845;14557.999999999987;14686.485972990948;14757.409703611856;15625.609359766011;14584.635384115376;14916.776248356256;14938.32777525014;14940.103593784354;14959.102453852776;790.5809920742001;813.9552324622143;816.4978538198994;816.9591520423985;819.115355416152;641.791417789218;656.2715385921623;784.4234487651601;798.2735710503443;809.0291650019971;699.5767560625825;843.8396704626132;845.9027211870653;847.2036285891273;850.345234169689;708.2492557888629;830.1449507007792;836.9163083691612;845.1506236232547;846.817934144162;520.3521615588579;601.978930737422;619.6591874469069;621.7699451203039;621.9129321894939;10758.246922715412;14013.159210447406;14207;14209.928950355183;14214.502492412716;13130;13181.802272965913;13337.599872003855;13351.599452016455;13626.250556219404;9258.259339252843;10918.399488028155;10968.287061340987;11482.368469734245;11541.538338466451;3601.873934412283;3683.116052147492;3734.309152806712;3750.1749615084636;3852.287326844543;68404.97392539115;69416;88313;91459.08540914571;92760;10463.319884207654;10493.89814069527;10533.789324213472;10571.260011799253;10594.099501542301;19671.704924426143;19764;19821.10805013778;19970.001499924947;20020.799792001893;7398;7457.179710231871;7560.130584982688;7654.081510218809;7771.572563509061;4264.7654379009455;4284.935725964113;4313.162720242356;4365.995820961197;4375.496817865923;3419.692227699519;3505.4741788731385;3535.9823200884343;3677.9448308275396;3852.5569559500454;653.3205466315075;696.6551556979327;700.2787129256874;719.7408932784193;720.0854914258862;620.7485968182893;639.4053530216943;641.1792905081503;645.2901808011244;675.3853992866468;7756.340711039512;8760.8685869712;8835.895513060867;9059.954700226588;9103.362764606547;623.8689875126274;650.6649075726004;655.5574986883835;661.5435349608755;665.3134304537973;4025.0742329264435;4152.688548358825;4258;4645.396098507173;4821.2045012573235;63941.081767547046;63983;64514.03228951569;94775;101781.49109254406;88989.11010889937;93129.5343523278;94110.58834117494;96111.51944240373;96427.03572964181;79012.20987790164;79916;81401;82719.7592036108;84668.57665711633;9098.681546145854;9503.429794212369;9510;9533.237341012564;9557.569909353957;42963;51449.228261576856;53676.19485707796;54526;56296.87406251934;72950.63524682343;76243.61878190574;77331;78754.60622697079;79347.80978285446;11952.880471195176;11998.760024799281;12287.324197169242;12503.624891253277;12519.374031298581;11522.596709115141;13429.328533573478;13967.790483142559;14053.929730351283;14385.387033987041;9527.57125929321;12058.819117713418;12531.812022819848;12802;13603.047786654839;10152.746181345525;12336.198147120409;12791.976641868441;12918.547850825176;13303.26832024248;12360.381980901098;12514.874851251736;13093.869061309266;13198.406071726988;13416.463341466622;11088.33469991803;11223.71940701489;11261.099112070851;11504.712382190512;11540.192186546861;11163.44182790841;11207.327560346404;11478.770424591628;11490.94254528722;11520.078393728314 08:06:40 INFO - PROCESS | 1642 | __end_tp_report 08:06:40 INFO - PROCESS | 1642 | __start_cc_report 08:06:40 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,371 08:06:40 INFO - PROCESS | 1642 | __end_cc_report 08:06:40 INFO - PROCESS | 1642 | __startTimestamp1480694800969__endTimestamp 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | ------- Summary: start ------- 08:06:40 INFO - PROCESS | 1642 | Number of tests: 6 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5691.32 Median:5987.22 stddev:630.49 (10.5%) stddev-sans-first:606.12 08:06:40 INFO - PROCESS | 1642 | Values: 3394.0 3410.6 3415.5 3432.7 3438.7 5797.3 5813.0 5818.5 5852.5 5855.8 4809.2 5744.9 5767.3 5838.2 5876.4 5184.8 5240.9 5254.0 5302.3 5333.4 5237.2 5314.3 5315.5 5323.0 5377.7 5161.3 5181.1 5219.7 5238.2 5245.1 5155.5 5161.2 5187.2 5199.1 5249.6 5101.6 5166.5 5179.2 5234.6 5252.4 4851.8 5757.6 5792.2 5801.8 5819.3 6125.4 6201.5 6214.4 6245.5 6246.5 6207.9 6208.5 6223.8 6232.8 6254.1 5701.0 5752.4 5759.8 5909.1 5938.8 6170.7 6231.9 6264.7 6276.2 6366.8 6166.4 6173.3 6180.0 6193.7 6195.3 6150.9 6205.9 6218.9 6230.6 6238.6 6067.1 6134.2 6135.1 6141.5 6163.3 5478.8 5843.2 6190.9 6196.2 6218.0 4914.5 4937.3 4954.4 4957.9 4983.9 4403.5 4435.1 4452.7 4460.3 4477.1 5024.8 5761.2 6001.2 6004.2 6013.4 6153.9 6160.7 6200.8 6231.4 6262.6 5980.7 6018.0 6020.5 6028.3 6078.5 5235.6 5367.8 5408.2 5429.0 5457.8 6139.2 6178.8 6187.2 6202.3 6207.6 5068.4 5379.3 6098.5 6107.5 6133.1 5044.6 5112.2 5588.9 5837.0 6180.1 4711.2 5276.8 6126.8 6190.5 6193.8 6165.1 6172.3 6177.7 6185.2 6203.8 5953.9 5982.4 6067.3 6075.5 6121.9 6023.5 6059.3 6069.9 6076.5 6089.4 5889.6 5987.2 6011.4 6060.6 6077.5 6059.0 6064.5 6077.6 6099.3 6151.4 5086.3 5997.5 6014.7 6054.6 6078.2 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:67767.31 Median:38980.11 stddev:148437.25 (380.8%) stddev-sans-first:148767.57 08:06:40 INFO - PROCESS | 1642 | Values: 437.6 459.1 480.7 486.3 523.0 35957.8 39353.6 39464.8 41397.2 41441.0 40517.4 40779.8 40851.8 40883.8 40929.0 9289.9 9429.1 9463.0 9491.1 9491.4 9396.4 9467.1 9470.7 9493.4 9498.8 9426.1 9484.2 9485.0 9492.1 9513.5 9373.2 9456.5 9459.7 9470.9 9483.0 9295.3 9338.4 9372.9 9388.6 9406.7 38712.8 38819.4 39129.0 39253.2 39299.6 3292.3 3296.7 3301.1 3380.1 3380.5 29099.9 29372.9 29873.3 29934.6 30505.7 3163.4 3168.8 3178.8 3199.4 3271.7 467269.0 475704.0 476478.0 479626.6 481116.0 56379.0 56535.0 56595.0 56742.7 56764.1 58779.7 59006.4 59083.7 59421.7 59745.0 14910.0 15114.6 15119.2 15182.9 15183.5 11671.6 11682.0 11731.4 11733.6 11753.9 14126.4 14615.9 15003.0 15106.8 15341.2 3164.3 3246.3 5878.3 6047.3 6051.5 876.3 884.8 934.7 938.3 1063.5 29286.9 29599.9 29602.0 30028.8 30148.8 1028.2 1057.4 1112.9 1127.9 1158.1 13058.9 13222.9 15080.7 15389.8 15629.8 602874.0 643764.0 643892.0 644065.0 644140.0 54460.0 54884.0 54886.7 54984.5 55207.6 1261.5 1330.9 1350.9 1353.6 1364.8 28690.0 29178.6 29233.7 29763.4 29816.1 47422.3 47666.0 47682.8 47729.3 47880.5 539925.0 541795.0 542035.0 542223.0 544204.0 25732.7 25824.5 26265.0 26277.6 26310.7 43831.0 44239.3 44854.3 45039.3 45336.5 37546.0 37644.6 37678.6 37839.2 38831.2 37223.4 37269.0 37560.8 38440.6 38531.2 28778.0 36997.8 37125.0 37148.9 37183.3 32161.4 33719.8 33839.0 33924.0 33936.8 24797.3 25094.0 25360.8 25506.4 25530.0 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35446.67 Median:35177.48 stddev:97164.48 (276.2%) stddev-sans-first:97401.35 08:06:40 INFO - PROCESS | 1642 | Values: 366.7 369.0 379.2 382.7 395.0 9536.1 11172.8 11600.6 11756.0 18198.5 17356.7 20008.4 21056.0 21091.7 21586.9 6224.3 6642.2 6654.8 6657.8 6661.6 4345.9 4803.9 6290.7 6407.0 7332.1 6410.3 6785.8 7026.6 7103.5 7560.0 6157.4 7281.1 7392.6 7400.3 7411.3 6212.9 7075.6 7104.0 7208.7 7261.7 26616.6 26778.2 27268.0 27592.3 27962.3 2352.7 2573.7 2641.9 2705.3 3107.7 15049.4 16329.0 16586.8 16635.7 16887.0 1926.0 2044.7 2061.3 2065.3 2083.0 79677.0 133479.7 140130.3 142242.0 142459.3 16772.8 18131.1 21076.1 21577.5 21840.3 27370.2 34717.7 34982.0 35373.0 35511.8 10059.9 10159.2 10371.3 10429.5 10514.2 7620.8 7785.4 8324.2 8331.4 8574.0 9454.5 9601.2 9680.8 9709.0 9760.3 1554.6 1600.3 1671.3 1682.0 3704.8 369.0 380.9 408.0 848.8 892.9 11566.5 11600.4 11661.2 11698.5 11825.8 420.4 423.8 447.2 877.3 901.2 10127.7 10580.8 10657.0 10675.9 10804.0 556912.2 568916.0 577686.0 594556.0 595287.0 104402.0 137199.0 139239.0 139494.0 145822.0 973.1 987.6 994.9 996.4 1002.7 17987.7 18002.6 18134.8 18159.5 18192.4 52322.7 52516.5 52687.9 53033.2 53823.0 63402.0 72985.3 76722.0 78339.6 82051.6 6575.7 7324.0 8027.4 8061.8 8157.2 9793.0 10238.9 11257.5 12072.0 12644.2 9852.3 10636.2 10678.7 10687.9 10831.4 4976.4 9485.8 9629.4 10591.8 10677.6 10615.2 10723.7 10802.2 10807.2 11215.9 7976.6 8021.4 8110.1 8114.3 8123.4 10012.8 10758.5 10832.1 11065.4 11162.4 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5430.98 Median:5248.29 stddev:2959.84 (56.4%) stddev-sans-first:2951.73 08:06:40 INFO - PROCESS | 1642 | Values: 1284.3 1458.9 1614.4 1755.7 1809.8 6002.5 7791.0 8079.4 8459.0 8512.4 6927.0 7942.9 8062.9 8200.8 8221.4 1760.8 2256.5 2295.4 2307.3 2358.4 2120.6 2124.2 2305.6 2308.4 2312.4 2265.0 2278.6 2320.9 2349.4 2352.6 2322.7 2334.8 2351.4 2353.6 2355.0 2346.3 2360.6 2365.1 2374.3 2378.9 8333.4 8387.2 8505.4 8510.1 8517.2 5101.5 5244.5 5253.6 5256.8 5260.5 3174.9 3365.0 3595.4 3641.4 3645.8 1039.5 1042.7 1089.8 1102.7 1102.9 10934.7 10988.2 11006.6 11034.3 11085.8 4531.3 4580.5 4648.2 4670.4 4698.8 9324.2 9386.5 9482.0 9511.0 9526.0 5216.7 5239.0 5243.0 5243.2 5252.1 4259.6 4404.6 4463.2 4494.2 4777.7 3823.5 3868.2 3932.2 3945.4 3955.7 1275.4 1291.3 1292.7 1301.5 1308.1 793.2 893.9 894.3 923.2 928.7 5560.6 5600.9 5608.7 5650.4 5690.7 883.9 925.0 929.1 964.6 980.7 3597.5 3827.6 3831.0 3866.3 3944.9 9651.4 9891.2 9907.0 10008.8 10009.9 9495.6 9973.4 9981.5 10007.2 10128.6 7679.9 7843.6 7846.6 7916.3 7931.1 4639.1 5665.9 5691.0 5699.2 5822.2 9265.5 9444.9 9456.2 9469.4 9471.2 7754.7 9431.5 9443.9 9453.6 9500.5 7159.8 7212.2 7234.0 7267.1 7299.9 7829.5 7861.2 7961.3 7966.2 7973.8 7047.9 7183.1 7223.3 7234.4 7304.3 6080.2 6988.9 7027.4 7070.0 7131.3 6624.7 6674.8 6702.6 6711.0 6733.8 4815.2 4832.7 4862.9 4884.3 4897.6 4805.9 4829.9 4898.8 4950.4 4972.5 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4366.83 Median:4952.18 stddev:1353.39 (27.3%) stddev-sans-first:1321.33 08:06:40 INFO - PROCESS | 1642 | Values: 243.8 297.5 299.2 302.3 306.7 5199.4 5292.6 5334.1 5406.7 5416.5 4548.6 5051.9 5297.3 5332.3 5351.6 3189.3 3868.7 3964.6 4047.4 4053.2 3602.7 3939.8 4049.4 4066.5 4120.8 4023.7 4036.8 4046.4 4056.8 4074.7 3984.0 4001.7 4034.5 4064.9 4069.9 2812.4 3079.8 3451.9 3506.8 3560.5 3937.7 4376.1 4983.9 4994.7 5112.9 3737.6 4043.5 4586.9 4614.0 4625.7 4859.3 5306.8 5606.6 5614.6 5625.5 3751.2 3852.4 3874.7 3893.2 3900.3 5852.0 5871.2 5872.9 5880.9 5900.8 3654.4 3869.2 3935.6 3945.6 3982.8 3165.6 3662.9 3705.8 4051.5 4053.6 3775.9 4531.7 4557.1 4562.2 4571.5 4873.0 5402.8 5656.1 5667.3 5677.0 1041.7 1101.8 1107.8 1108.3 1121.7 653.3 772.2 841.7 845.5 877.7 4369.8 4374.5 5012.5 5074.9 5076.8 4591.0 4879.1 5178.7 5539.8 5582.9 4145.9 4319.0 4853.5 5049.8 5076.0 2422.2 2608.9 2616.7 2755.9 2904.4 4738.4 5274.4 5456.0 5594.2 5647.7 4351.5 4956.2 5138.9 5583.6 5599.7 4413.4 4865.7 5044.4 5120.2 5330.7 4503.4 5018.7 5027.4 5110.7 5297.2 4977.5 5021.4 5193.5 5392.6 5414.7 5568.0 5603.4 5619.9 5649.4 5664.7 3215.5 3538.2 3635.0 3661.7 3693.1 4744.7 5146.9 5165.3 5401.8 5463.1 4779.8 5263.2 5301.4 5320.9 5350.9 4948.2 5141.7 5145.3 5323.8 5326.3 4612.3 5132.4 5254.8 5296.4 5427.9 5570.7 5621.5 5636.6 5653.4 5663.1 5234.8 5453.5 5466.0 5485.8 5507.8 08:06:40 INFO - PROCESS | 1642 | 08:06:40 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19317.32 Median:25984.79 stddev:27260.86 (104.9%) stddev-sans-first:27301.29 08:06:40 INFO - PROCESS | 1642 | Values: 647.9 672.1 692.2 752.8 791.9 13873.1 14558.0 14686.5 14757.4 15625.6 14584.6 14916.8 14938.3 14940.1 14959.1 790.6 814.0 816.5 817.0 819.1 641.8 656.3 784.4 798.3 809.0 699.6 843.8 845.9 847.2 850.3 708.2 830.1 836.9 845.2 846.8 520.4 602.0 619.7 621.8 621.9 10758.2 14013.2 14207.0 14209.9 14214.5 13130.0 13181.8 13337.6 13351.6 13626.3 9258.3 10918.4 10968.3 11482.4 11541.5 3601.9 3683.1 3734.3 3750.2 3852.3 68405.0 69416.0 88313.0 91459.1 92760.0 10463.3 10493.9 10533.8 10571.3 10594.1 19671.7 19764.0 19821.1 19970.0 20020.8 7398.0 7457.2 7560.1 7654.1 7771.6 4264.8 4284.9 4313.2 4366.0 4375.5 3419.7 3505.5 3536.0 3677.9 3852.6 653.3 696.7 700.3 719.7 720.1 620.7 639.4 641.2 645.3 675.4 7756.3 8760.9 8835.9 9060.0 9103.4 623.9 650.7 655.6 661.5 665.3 4025.1 4152.7 4258.0 4645.4 4821.2 63941.1 63983.0 64514.0 94775.0 101781.5 88989.1 93129.5 94110.6 96111.5 96427.0 79012.2 79916.0 81401.0 82719.8 84668.6 9098.7 9503.4 9510.0 9533.2 9557.6 42963.0 51449.2 53676.2 54526.0 56296.9 72950.6 76243.6 77331.0 78754.6 79347.8 11952.9 11998.8 12287.3 12503.6 12519.4 11522.6 13429.3 13967.8 14053.9 14385.4 9527.6 12058.8 12531.8 12802.0 13603.0 10152.7 12336.2 12792.0 12918.5 13303.3 12360.4 12514.9 13093.9 13198.4 13416.5 11088.3 11223.7 11261.1 11504.7 11540.2 11163.4 11207.3 11478.8 11490.9 11520.1 08:06:40 INFO - PROCESS | 1642 | -------- Summary: end -------- 08:06:40 INFO - PROCESS | 1642 | 08:06:41 INFO - TEST-INFO | 1642: exit 0 08:06:41 INFO - TEST-OK | dromaeo_css | took 1117347ms 08:06:41 INFO - TEST-START | kraken 08:06:41 INFO - operating with platform_type : mac_ 08:06:41 INFO - Initialising browser for kraken test... 08:06:41 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpZYCatv/profile http://localhost:49250/getInfo.html) 08:06:44 INFO - PROCESS | 1653 | 2016-12-02 08:06:44.669 plugin-container[1654:10373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 08:06:44 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:44 INFO - PROCESS | 1653 | 2016-12-02 08:06:44.672 plugin-container[1654:10373] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:06:44 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:44 INFO - PROCESS | 1653 | 2016-12-02 08:06:44.672 plugin-container[1654:10373] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:44 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 08:06:44 INFO - PROCESS | 1653 | colorDepth:24 08:06:44 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 08:06:44 INFO - PROCESS | 1653 | __metrics 08:06:44 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:06:45 INFO - TEST-INFO | 1653: exit 0 08:06:45 INFO - Browser initialized. 08:06:45 INFO - Running cycle 1/1 for kraken test... 08:06:45 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpZYCatv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:48 INFO - PROCESS | 1655 | 2016-12-02 08:06:48.284 plugin-container[1656:10496] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4453, name = 'com.apple.tsm.portname' 08:06:48 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:48 INFO - PROCESS | 1655 | 2016-12-02 08:06:48.284 plugin-container[1656:10496] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 08:06:48 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:06:48 INFO - PROCESS | 1655 | 2016-12-02 08:06:48.285 plugin-container[1656:10496] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:06:57 INFO - PROCESS | 1655 | RSS: Main: 229502976 08:06:57 INFO - PROCESS | 1655 | 08:07:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:01 INFO - PROCESS | 1655 | RSS: Main: 241639424 08:07:01 INFO - PROCESS | 1655 | 08:07:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 08:07:05 INFO - PROCESS | 1655 | RSS: Main: 249274368 08:07:05 INFO - PROCESS | 1655 | 08:07:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 08:07:09 INFO - PROCESS | 1655 | RSS: Main: 253050880 08:07:09 INFO - PROCESS | 1655 | 08:07:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 08:07:11 INFO - PROCESS | 1655 | RSS: Main: 254373888 08:07:11 INFO - PROCESS | 1655 | 08:07:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:14 INFO - PROCESS | 1655 | RSS: Main: 254406656 08:07:14 INFO - PROCESS | 1655 | 08:07:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:17 INFO - PROCESS | 1655 | RSS: Main: 258408448 08:07:17 INFO - PROCESS | 1655 | 08:07:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 08:07:21 INFO - PROCESS | 1655 | RSS: Main: 258826240 08:07:21 INFO - PROCESS | 1655 | 08:07:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 08:07:24 INFO - PROCESS | 1655 | RSS: Main: 258416640 08:07:24 INFO - PROCESS | 1655 | 08:07:26 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:07:26 INFO - PROCESS | 1655 | RSS: Main: 257302528 08:07:26 INFO - PROCESS | 1655 | 08:07:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:07:29 INFO - PROCESS | 1655 | RSS: Main: 257286144 08:07:29 INFO - PROCESS | 1655 | 08:07:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:07:32 INFO - PROCESS | 1655 | RSS: Main: 257310720 08:07:32 INFO - PROCESS | 1655 | 08:07:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:07:35 INFO - PROCESS | 1655 | RSS: Main: 257523712 08:07:35 INFO - PROCESS | 1655 | 08:07:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:39 INFO - PROCESS | 1655 | RSS: Main: 257695744 08:07:39 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 08:07:41 INFO - PROCESS | 1655 | RSS: Main: 259477504 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | __start_tp_report 08:07:41 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:07:41 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:07:41 INFO - PROCESS | 1655 | |i|pagename|runs| 08:07:41 INFO - PROCESS | 1655 | |0;ai-astar;107;143;178;150;119;119;118;118;117;119 08:07:41 INFO - PROCESS | 1655 | |1;audio-beat-detection;152;117;111;152;108;126;143;99;179;142 08:07:41 INFO - PROCESS | 1655 | |2;audio-dft;195;187;196;198;228;225;196;196;190;195 08:07:41 INFO - PROCESS | 1655 | |3;audio-fft;82;56;59;85;61;61;60;60;77;58 08:07:41 INFO - PROCESS | 1655 | |4;audio-oscillator;82;71;89;72;68;69;85;68;69;89 08:07:41 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;93;90;93;88;91;87;92;110;93;90 08:07:41 INFO - PROCESS | 1655 | |6;imaging-darkroom;99;97;137;99;98;98;98;98;98;98 08:07:41 INFO - PROCESS | 1655 | |7;imaging-desaturate;90;93;88;88;94;90;89;93;88;89 08:07:41 INFO - PROCESS | 1655 | |8;json-parse-financial;57;56;57;59;61;62;59;59;59;59 08:07:41 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;68;75;71;77;69;68;71;71;73;73 08:07:41 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;86;86;96;108;102;108;81;107;103;108 08:07:41 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;161;167;155;147;149;154;150;150;250;182 08:07:41 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;171;172;209;175;172;180;227;229;180;177 08:07:41 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;70;73;85;89;88;74;66;92;92;87 08:07:41 INFO - PROCESS | 1655 | __end_tp_report 08:07:41 INFO - PROCESS | 1655 | __start_cc_report 08:07:41 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,975 08:07:41 INFO - PROCESS | 1655 | __end_cc_report 08:07:41 INFO - PROCESS | 1655 | __startTimestamp1480694861760__endTimestamp 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:07:41 INFO - PROCESS | 1655 | Number of tests: 14 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:128.80 Median:119.00 stddev:21.62 (18.2%) stddev-sans-first:21.45 08:07:41 INFO - PROCESS | 1655 | Values: 107.0 143.0 178.0 150.0 119.0 119.0 118.0 118.0 117.0 119.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:147.50 stddev:24.92 (16.9%) stddev-sans-first:25.45 08:07:41 INFO - PROCESS | 1655 | Values: 152.0 117.0 111.0 152.0 108.0 126.0 143.0 99.0 179.0 142.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:200.60 Median:196.00 stddev:14.05 (7.2%) stddev-sans-first:14.75 08:07:41 INFO - PROCESS | 1655 | Values: 195.0 187.0 196.0 198.0 228.0 225.0 196.0 196.0 190.0 195.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.00 stddev:10.92 (17.9%) stddev-sans-first:9.91 08:07:41 INFO - PROCESS | 1655 | Values: 82.0 56.0 59.0 85.0 61.0 61.0 60.0 60.0 77.0 58.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.00 stddev:8.95 (11.6%) stddev-sans-first:9.25 08:07:41 INFO - PROCESS | 1655 | Values: 82.0 71.0 89.0 72.0 68.0 69.0 85.0 68.0 69.0 89.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:91.50 stddev:6.43 (7.0%) stddev-sans-first:6.82 08:07:41 INFO - PROCESS | 1655 | Values: 93.0 90.0 93.0 88.0 91.0 87.0 92.0 110.0 93.0 90.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:98.00 stddev:12.31 (12.6%) stddev-sans-first:13.01 08:07:41 INFO - PROCESS | 1655 | Values: 99.0 97.0 137.0 99.0 98.0 98.0 98.0 98.0 98.0 98.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:90.20 Median:90.00 stddev:2.30 (2.6%) stddev-sans-first:2.44 08:07:41 INFO - PROCESS | 1655 | Values: 90.0 93.0 88.0 88.0 94.0 90.0 89.0 93.0 88.0 89.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.81 (3.1%) stddev-sans-first:1.80 08:07:41 INFO - PROCESS | 1655 | Values: 57.0 56.0 57.0 59.0 61.0 62.0 59.0 59.0 59.0 59.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.00 stddev:2.95 (4.1%) stddev-sans-first:2.83 08:07:41 INFO - PROCESS | 1655 | Values: 68.0 75.0 71.0 77.0 69.0 68.0 71.0 71.0 73.0 73.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:94.50 stddev:10.54 (11.2%) stddev-sans-first:10.17 08:07:41 INFO - PROCESS | 1655 | Values: 86.0 86.0 96.0 108.0 102.0 108.0 81.0 107.0 103.0 108.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:166.50 Median:158.00 stddev:31.20 (19.7%) stddev-sans-first:33.03 08:07:41 INFO - PROCESS | 1655 | Values: 161.0 167.0 155.0 147.0 149.0 154.0 150.0 150.0 250.0 182.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.20 Median:180.00 stddev:23.21 (12.9%) stddev-sans-first:23.66 08:07:41 INFO - PROCESS | 1655 | Values: 171.0 172.0 209.0 175.0 172.0 180.0 227.0 229.0 180.0 177.0 08:07:41 INFO - PROCESS | 1655 | 08:07:41 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.60 Median:87.50 stddev:9.79 (11.2%) stddev-sans-first:9.44 08:07:41 INFO - PROCESS | 1655 | Values: 70.0 73.0 85.0 89.0 88.0 74.0 66.0 92.0 92.0 87.0 08:07:41 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:07:41 INFO - PROCESS | 1655 | 08:07:42 INFO - TEST-INFO | 1655: exit 0 08:07:42 INFO - TEST-OK | kraken | took 61177ms 08:07:42 INFO - SUITE-END | took 1178s 08:07:42 INFO - Completed test suite (00:19:38) 08:07:42 INFO - javascript benchmark 08:07:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7138.790921061169, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.9830300848494, 3410.590729112507, 3415.487676848473, 3432.708219801317, 3438.724902007839, 5797.275340582427, 5812.970935145324, 5818.505427038702, 5852.502537284336, 5855.76576936922, 4809.230523116302, 5744.908467391193, 5767.33675627303, 5838.182654428373, 5876.353601103875, 5184.818531351403, 5240.895182096356, 5253.973730131344, 5302.310699609065, 5333.4399888011785, 5237.162054071349, 5314.3091398118195, 5315.521603055724, 5323.0, 5377.677339359631, 5161.27742116104, 5181.145111056671, 5219.660722053054, 5238.161894096965, 5245.082110630625, 5155.458676838915, 5161.225816127573, 5187.170052791535, 5199.064168449678, 5249.580033597303, 5101.566366858821, 5166.457521960216, 5179.197224430181, 5234.581233501349, 5252.395974462947, 4851.835559465738, 5757.625754325955, 5792.160136780185, 5801.767929282823, 5819.301683797971, 6125.356837532039, 6201.534884883652, 6214.378562143795, 6245.46913512352, 6246.531510136758, 6207.906881396782, 6208.472279856218, 6223.751049957997, 6232.781852635136, 6254.122444084651, 5701.0, 5752.36723960364, 5759.798407055817, 5909.113632955091, 5938.792142275, 6170.660613666201, 6231.875362492725, 6264.749410023639, 6276.152719382916, 6366.84082897922, 6166.414190651881, 6173.290071641819, 6179.969100154471, 6193.690315484298, 6195.31851496335, 6150.876982460326, 6205.875882482325, 6218.9378106218355, 6230.626162430269, 6238.563300568917, 6067.089936509559, 6134.1610691366095, 6135.07955838608, 6141.539384546177, 6163.260408750979, 5478.835634930959, 5843.152742852262, 6190.938090619126, 6196.1635179251125, 6217.9689101555105, 4914.459409464956, 4937.259411088294, 4954.380702412199, 4957.851264462072, 4983.9252411213865, 4403.515613282536, 4435.090806384684, 4452.710573812692, 4460.30865215892, 4477.104579084196, 5024.84925452237, 5761.164631128463, 6001.159837622737, 6004.249468816398, 6013.428724271187, 6153.938460615336, 6160.722767475474, 6200.751969921243, 6231.40801623845, 6262.5616206866, 5980.671063091571, 6018.037114061816, 6020.518358531307, 6028.2766068072115, 6078.544109191828, 5235.633505654568, 5367.838964831061, 5408.161734931014, 5428.972855135699, 5457.836264912059, 6139.2019037526625, 6178.752849886134, 6187.1647327612, 6202.317745047951, 6207.6275423474735, 5068.391792984866, 5379.273798037215, 6098.481629061579, 6107.511399088151, 6133.080037994158, 5044.646874718735, 5112.233165025127, 5588.944110558842, 5837.0, 6180.072989051679, 4711.222648263135, 5276.788928442819, 6126.761967422386, 6190.535709821691, 6193.81418557444, 6165.136880836597, 6172.259328880563, 6177.6911154443, 6185.195924529962, 6203.7828675996125, 5953.940460595339, 5982.371850955587, 6067.302260239952, 6075.453209211192, 6121.938780612137, 6023.548233882564, 6059.303180134341, 6069.908951365821, 6076.483498902643, 6089.421504957022, 5889.6171748837905, 5987.221661184019, 6011.368806275453, 6060.6363618181285, 6077.48341390969, 6059.0, 6064.454199121924, 6077.574569780073, 6099.2985806632805, 6151.3541078186145, 5086.28791969132, 5997.520198384206, 6014.669193194416, 6054.576179667381, 6078.240219972504], "value": 5654.756246303884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.6498800959232, 459.1345314082957, 480.730790757176, 486.31186870578136, 523.0350004242172, 35957.82021089894, 39353.60646393535, 39464.81605551834, 41397.17205655885, 41440.96397590062, 40517.39223911644, 40779.79610101953, 40851.79574102133, 40883.79558102205, 40929.0, 9289.860652090225, 9429.104235097655, 9462.952685236598, 9491.14579687828, 9491.383060101105, 9396.389234699756, 9467.053294670512, 9470.66852660157, 9493.430394176337, 9498.762530936712, 9426.057394260588, 9484.241260699127, 9485.004074572174, 9492.145706886378, 9513.476758778264, 9373.203277721368, 9456.52717364129, 9459.66891158813, 9470.905290947072, 9483.0, 9295.256379489625, 9338.393004454756, 9372.8594071089, 9388.62445502179, 9406.670766523139, 38712.80643596792, 38819.41770873439, 39129.0, 39253.21493570141, 39299.60700392988, 3292.308615190813, 3296.7362610991063, 3301.0756988043145, 3380.1211684962086, 3380.5436266104252, 29099.85450072736, 29372.853135734185, 29873.25316867074, 29934.55098173529, 30505.69494305051, 3163.43058249515, 3168.778185527014, 3178.8092714437207, 3199.440097982867, 3271.7219036381935, 467269.0, 475704.0, 476478.0, 479626.6018669919, 481116.0, 56379.0, 56535.0, 56595.0, 56742.716286418305, 56764.148537771965, 58779.706101470074, 59006.40993590095, 59083.70458147682, 59421.70289148613, 59745.0, 14910.0, 15114.622134446507, 15119.16844573559, 15182.924085379502, 15183.468578599917, 11671.591494297829, 11682.0, 11731.35477548743, 11733.647990560297, 11753.942145206973, 14126.364313605913, 14615.853841461661, 15003.0, 15106.773398399033, 15341.232938353038, 3164.2880351921094, 3246.3182731626152, 5878.29460464747, 6047.334793172748, 6051.4553690168095, 876.3252295732251, 884.8186121845006, 934.7008957133788, 938.3150300280834, 1063.4788953412926, 29286.85356573246, 29599.85200073986, 29602.0, 30028.84985575058, 30148.84925575358, 1028.2236911132197, 1057.3708643357345, 1112.866456025266, 1127.9210455268053, 1158.0966845860241, 13058.934705326412, 13222.867771322357, 15080.698386032438, 15389.846101538842, 15629.765553516707, 602874.0, 643764.0, 643892.0, 644065.0, 644140.0, 54460.0, 54884.0, 54886.72556637191, 54984.45015549874, 55207.61980950428, 1261.4575732435142, 1330.886874615649, 1350.9324533773467, 1353.553327401955, 1364.7884577890443, 28690.0, 29178.56232156477, 29233.707662923098, 29763.404731905674, 29816.10551683453, 47422.288665670734, 47666.0, 47682.761586193235, 47729.28406073842, 47880.52119478761, 539925.0, 541795.0, 542035.0, 542223.0, 544204.0, 25732.742672573033, 25824.483510330065, 26265.0, 26277.605835912094, 26310.736892631594, 43831.0, 44239.33640995452, 44854.3271850929, 45039.32441013322, 45336.54663453323, 37546.0, 37644.62355376411, 37678.62321376861, 37839.24321513609, 38831.2233755329, 37223.44164837584, 37269.0, 37560.812195938845, 38440.6155938437, 38531.2293754129, 28778.0, 36997.81501092477, 37125.0, 37148.88553343404, 37183.256334873695, 32161.356772863943, 33719.831400842835, 33839.0, 33923.98228053162, 33936.83031584826, 24797.25608231756, 25094.0, 25360.82679319261, 25506.362340941625, 25530.0], "value": 19029.06412783144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.6938106680921, 368.96679298863097, 379.15070242656446, 382.7072289698383, 395.02626026843825, 9536.141747242747, 11172.776544469105, 11600.59397921074, 11756.000739937115, 18198.454046378596, 17356.652866942655, 20008.39974800758, 21056.0, 21091.68362474564, 21586.89206553969, 6224.315325314223, 6642.169728783902, 6654.767083152091, 6657.800265992004, 6661.600303981777, 4345.913081738363, 4803.927941080887, 6290.685465726719, 6407.03894415839, 7332.0834895638045, 6410.326915673857, 6785.76249831256, 7026.648667566601, 7103.467239956998, 7560.017197764283, 6157.445829875288, 7281.053463049796, 7392.593407362593, 7400.296971787671, 7411.332980031796, 6212.937870621281, 7075.575465472037, 7103.964480177618, 7208.747693830744, 7261.673224704901, 26616.60075098875, 26778.196654100408, 27268.0, 27592.310192245153, 27962.3009424764, 2352.7294361148342, 2573.6525569048313, 2641.8546979916096, 2705.3371923878776, 3107.704768047032, 15049.398024079133, 16329.02025878451, 16586.83413165865, 16635.66728665432, 16887.0, 1926.0, 2044.723962265105, 2061.288855344904, 2065.297798748418, 2082.95834083319, 79677.0, 133479.6652033477, 140130.2993485026, 142242.0, 142459.2877035608, 16772.832271677373, 18131.093445327682, 21076.10315071651, 21577.460563485725, 21840.344789656338, 27370.178894633194, 34717.652823471944, 34981.9505414838, 35373.0, 35511.82244088763, 10059.949700251453, 10159.238057145743, 10371.27401081917, 10429.530671119817, 10514.211434142317, 7620.80947976305, 7785.416093792988, 8324.167583241628, 8331.416800824005, 8573.957130214309, 9454.527273636291, 9601.231901447867, 9680.806383872425, 9708.951455242679, 9760.267979901535, 1554.6319239069546, 1600.3198640577707, 1671.2980548169799, 1681.991590042042, 3704.759190652599, 368.95203623529306, 380.8952538052058, 407.9816408261635, 848.8090179709516, 892.9330300227509, 11566.537338506534, 11600.361980091177, 11661.24201926872, 11698.47356868943, 11825.822612660817, 420.4240190938434, 423.75205021212236, 447.17496219475015, 877.3376101043672, 901.2249465459699, 10127.729051141387, 10580.788384232272, 10657.0, 10675.946620266848, 10804.0, 556912.2154389202, 568916.0, 577686.0, 594556.0272198698, 595287.0, 104402.0, 137199.0, 139239.0, 139494.0, 145822.0, 973.0755782007121, 987.6247026130025, 994.9005099489993, 996.4021587047713, 1002.7092143278368, 17987.730184047512, 18002.63994720072, 18134.81865181384, 18159.546011349823, 18192.363267285582, 52322.73838630935, 52516.47483525116, 52687.94624107573, 53033.20450193327, 53823.0, 63402.0, 72985.27014729998, 76722.0, 78339.60830196041, 82051.5897420533, 6575.704093315717, 7324.0, 8027.357811375193, 8061.758147255592, 8157.1842815717955, 9792.971737967411, 10238.897611023795, 11257.49341279628, 12072.0, 12644.241345519298, 9852.310338276251, 10636.202284828514, 10678.679639610513, 10687.893121069, 10831.350118992885, 4976.402831660224, 9485.762855928657, 9629.374090684363, 10591.841122383325, 10677.611910451591, 10615.150787936793, 10723.678289651323, 10802.189835762192, 10807.189460790314, 11215.887841121485, 7976.641051152828, 8021.398395120273, 8110.148434414302, 8114.310283625958, 8123.3501319893085, 10012.849807253042, 10758.46207689628, 10832.079273261546, 11065.446727663746, 11162.386068766296], "value": 9938.216125325109, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.2679672586626, 1458.8912426555821, 1614.3623268808822, 1755.7454169145467, 1809.8280663336977, 6002.489788367994, 7790.9610451947665, 8079.434439589231, 8458.984921809384, 8512.446690965091, 6927.0, 7942.880856787153, 8062.91937080629, 8200.753977380688, 8221.38339624529, 1760.8151144129874, 2256.4697296135437, 2295.4376177836452, 2307.2962746362355, 2358.433975845802, 2120.628889944261, 2124.224657999827, 2305.5849947009533, 2308.4228942764307, 2312.4103353644796, 2265.026038803314, 2278.5556816420803, 2320.9303720888315, 2349.4126468382906, 2352.6118190498632, 2322.7096612923383, 2334.813214942809, 2351.4356554426986, 2353.6116540770754, 2355.0, 2346.272655476808, 2360.6223004319227, 2365.065799009382, 2374.3351861478814, 2378.940526486834, 8333.416660833744, 8387.245147936716, 8505.362097842686, 8510.106438823896, 8517.190866867699, 5101.540861322499, 5244.501772331622, 5253.553447956928, 5256.763445644955, 5260.500252476008, 3174.8888788892277, 3364.966350336514, 3595.406757884972, 3641.3991691370893, 3645.7812531247946, 1039.5114296280735, 1042.67677020124, 1089.8310761831929, 1102.6802227354058, 1102.939338336391, 10934.671959841218, 10988.230823842334, 11006.559737610485, 11034.282771619819, 11085.83371249432, 4531.342955271467, 4580.519045500175, 4648.209804333272, 4670.416197975253, 4698.788554515055, 9324.207442367475, 9386.483743394043, 9482.0, 9510.953795082536, 9525.952370238105, 5216.713080780518, 5239.030779305841, 5243.0, 5243.161094224905, 5252.080885844962, 4259.552746961586, 4404.559544045634, 4463.174312752087, 4494.235979883428, 4777.689450185727, 3823.464714939855, 3868.168343806095, 3932.1545867638597, 3945.447637330776, 3955.723099383016, 1275.3686924972199, 1291.3285091752236, 1292.7479141567492, 1301.4533895763802, 1308.1366298243113, 793.2067932067932, 893.9195472407384, 894.2756367342473, 923.2337160157053, 928.661038720862, 5560.555155587544, 5600.915986260209, 5608.663480191201, 5650.350209725934, 5690.715464226772, 883.9469631822111, 924.9815003700023, 929.1266209762802, 964.5804075227298, 980.7057882635181, 3597.514335564665, 3827.6363745444137, 3831.023089112314, 3866.284737323604, 3944.881653550398, 9651.372660777028, 9891.159251463563, 9906.950465247628, 10008.79982400348, 10009.949950250202, 9495.572699228413, 9973.401595904124, 9981.500924953723, 10007.199424046059, 10128.59485620567, 7679.924810526531, 7843.647035883285, 7846.568438735924, 7916.327112195528, 7931.127575966639, 4639.095376401704, 5665.85835354103, 5691.032524470767, 5699.23060386859, 5822.155787410887, 9265.490398028172, 9444.858327125236, 9456.243500520079, 9469.384490008128, 9471.19494842946, 7754.651040703069, 9431.481268530297, 9443.905560944302, 9453.621855125994, 9500.524973751422, 7159.821004474929, 7212.170600381023, 7233.963830180815, 7267.127944646676, 7299.890501642586, 7829.491083079582, 7861.174576669596, 7961.283484486193, 7966.243206895336, 7973.760787176394, 7047.929520704727, 7183.138023437221, 7223.277672232734, 7234.421246300389, 7304.269573042653, 6080.2399700037495, 6988.8951665724035, 7027.367536921702, 7069.9646501767165, 7131.25121862197, 6624.701888414937, 6674.799756007327, 6702.564333318319, 6711.0, 6733.831654208684, 4815.181419158681, 4832.734199619054, 4862.902741945212, 4884.340614017062, 4897.608191344755, 4805.9038819224115, 4829.855104346875, 4898.828541001048, 4950.430700469492, 4972.5276098770555], "value": 4417.209196830932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [243.83662945826293, 297.51802080629386, 299.1668204051715, 302.30922342447514, 306.74541126791416, 5199.428062913076, 5292.576593872491, 5334.119870221413, 5406.702391426059, 5416.458354164586, 4548.590626843584, 5051.873703157423, 5297.311349524566, 5332.280142180804, 5351.638414692024, 3189.282411457421, 3868.678792724371, 3964.623360780721, 4047.392891066349, 4053.2298863215897, 3602.6670132051177, 3939.8424063037446, 4049.4330793688905, 4066.512018557777, 4120.846163074329, 4023.7384570002855, 4036.8385264589383, 4046.4132700758373, 4056.817443215062, 4074.6740260779065, 3984.023914141025, 4001.698598656106, 4034.458291276477, 4064.9390259146135, 4069.9389509157386, 2812.3531587734733, 3079.7844150909445, 3451.87918422854, 3506.842192101336, 3560.537130173087, 3937.7046721495717, 4376.094647392572, 4983.92845538211, 4994.650374473788, 5112.872178195537, 3737.607551207111, 4043.474348334727, 4586.885327866797, 4614.0, 4625.653076019278, 4859.271109333593, 5306.787728490855, 5606.579506536985, 5614.550835933115, 5625.465580769861, 3751.249750050001, 3852.3836186210074, 3874.6512813846607, 3893.1824316893203, 3900.258950799339, 5852.0, 5871.178035075093, 5872.941270587282, 5880.852978675524, 5900.7934722284945, 3654.3970244909824, 3869.187470631143, 3935.5670876203594, 3945.585713500099, 3982.820773065219, 3165.6201255848987, 3662.8901132966053, 3705.8332375043187, 4051.534073581517, 4053.5946405359227, 3775.9056023599082, 4531.728096314232, 4557.065801510682, 4562.224421848294, 4571.497135315112, 4872.9512704873205, 5402.756875940592, 5656.123300888369, 5667.287926408209, 5677.0, 1041.6979076068008, 1101.823708206683, 1107.789519991199, 1108.2740804772886, 1121.657894342217, 653.3107571512005, 772.1622538358671, 841.6801615386114, 845.5053793530731, 877.6752601537472, 4369.759663218553, 4374.540673229329, 5012.523810238022, 5074.893919023638, 5076.847694569169, 4591.0, 4879.096937322288, 5178.730811525157, 5539.750711218005, 5582.934314303652, 4145.854895078658, 4318.956810431919, 4853.49038350968, 5049.843847595253, 5076.0, 2422.1833624781416, 2608.8695565221665, 2616.659834221539, 2755.870093261753, 2904.4481548506137, 4738.431388233365, 5274.446183150714, 5455.987155430071, 5594.16799492349, 5647.661140331593, 4351.521332653406, 4956.157453232959, 5138.869448721275, 5583.581231407661, 5599.7480113394995, 4413.44831896013, 4865.659403841697, 5044.369453818273, 5120.156743572311, 5330.748243571418, 4503.437070366204, 5018.698878067327, 5027.396712394389, 5110.729133354582, 5297.17893726473, 4977.502249774993, 5021.447640759587, 5193.454687257935, 5392.649477783932, 5414.675119492843, 5568.0, 5603.411641777555, 5619.943800561942, 5649.406812284651, 5664.688442135722, 3215.4694475411293, 3538.1517878107343, 3634.9818250908575, 3661.6887564556246, 3693.095191678056, 4744.715317080986, 5146.8604151466825, 5165.328507294028, 5401.756920938646, 5463.093887870192, 4779.808807647794, 5263.157894736799, 5301.390340110936, 5320.882614650966, 5350.946490535045, 4948.208286674115, 5141.665791723526, 5145.331106956221, 5323.813666521653, 5326.334208223972, 4612.30815377696, 5132.358455193101, 5254.842354729364, 5296.41739408657, 5427.937383794291, 5570.749316280858, 5621.494065534122, 5636.577256705846, 5653.434656534314, 5663.122216056518, 5234.842954711365, 5453.545904342982, 5466.0, 5485.835424937259, 5507.807226747044], "value": 3920.4707334603477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8833809914216, 672.1161672400796, 692.2489099327233, 752.7992851402012, 791.9366450683946, 13873.098248613845, 14557.999999999987, 14686.485972990948, 14757.409703611856, 15625.609359766011, 14584.635384115376, 14916.776248356256, 14938.32777525014, 14940.103593784354, 14959.102453852776, 790.5809920742001, 813.9552324622143, 816.4978538198994, 816.9591520423985, 819.115355416152, 641.791417789218, 656.2715385921623, 784.4234487651601, 798.2735710503443, 809.0291650019971, 699.5767560625825, 843.8396704626132, 845.9027211870653, 847.2036285891273, 850.345234169689, 708.2492557888629, 830.1449507007792, 836.9163083691612, 845.1506236232547, 846.817934144162, 520.3521615588579, 601.978930737422, 619.6591874469069, 621.7699451203039, 621.9129321894939, 10758.246922715412, 14013.159210447406, 14207.0, 14209.928950355183, 14214.502492412716, 13130.0, 13181.802272965913, 13337.599872003855, 13351.599452016455, 13626.250556219404, 9258.259339252843, 10918.399488028155, 10968.287061340987, 11482.368469734245, 11541.538338466451, 3601.873934412283, 3683.116052147492, 3734.309152806712, 3750.1749615084636, 3852.287326844543, 68404.97392539115, 69416.0, 88313.0, 91459.08540914571, 92760.0, 10463.319884207654, 10493.89814069527, 10533.789324213472, 10571.260011799253, 10594.099501542301, 19671.704924426143, 19764.0, 19821.10805013778, 19970.001499924947, 20020.799792001893, 7398.0, 7457.179710231871, 7560.130584982688, 7654.081510218809, 7771.572563509061, 4264.7654379009455, 4284.935725964113, 4313.162720242356, 4365.995820961197, 4375.496817865923, 3419.692227699519, 3505.4741788731385, 3535.9823200884343, 3677.9448308275396, 3852.5569559500454, 653.3205466315075, 696.6551556979327, 700.2787129256874, 719.7408932784193, 720.0854914258862, 620.7485968182893, 639.4053530216943, 641.1792905081503, 645.2901808011244, 675.3853992866468, 7756.340711039512, 8760.8685869712, 8835.895513060867, 9059.954700226588, 9103.362764606547, 623.8689875126274, 650.6649075726004, 655.5574986883835, 661.5435349608755, 665.3134304537973, 4025.0742329264435, 4152.688548358825, 4258.0, 4645.396098507173, 4821.2045012573235, 63941.081767547046, 63983.0, 64514.03228951569, 94775.0, 101781.49109254406, 88989.11010889937, 93129.5343523278, 94110.58834117494, 96111.51944240373, 96427.03572964181, 79012.20987790164, 79916.0, 81401.0, 82719.7592036108, 84668.57665711633, 9098.681546145854, 9503.429794212369, 9510.0, 9533.237341012564, 9557.569909353957, 42963.0, 51449.228261576856, 53676.19485707796, 54526.0, 56296.87406251934, 72950.63524682343, 76243.61878190574, 77331.0, 78754.60622697079, 79347.80978285446, 11952.880471195176, 11998.760024799281, 12287.324197169242, 12503.624891253277, 12519.374031298581, 11522.596709115141, 13429.328533573478, 13967.790483142559, 14053.929730351283, 14385.387033987041, 9527.57125929321, 12058.819117713418, 12531.812022819848, 12802.0, 13603.047786654839, 10152.746181345525, 12336.198147120409, 12791.976641868441, 12918.547850825176, 13303.26832024248, 12360.381980901098, 12514.874851251736, 13093.869061309266, 13198.406071726988, 13416.463341466622, 11088.33469991803, 11223.71940701489, 11261.099112070851, 11504.712382190512, 11540.192186546861, 11163.44182790841, 11207.327560346404, 11478.770424591628, 11490.94254528722, 11520.078393728314], "value": 7146.178720270602, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 143.0, 178.0, 150.0, 119.0, 119.0, 118.0, 118.0, 117.0, 119.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 117.0, 111.0, 152.0, 108.0, 126.0, 143.0, 99.0, 179.0, 142.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 187.0, 196.0, 198.0, 228.0, 225.0, 196.0, 196.0, 190.0, 195.0], "value": 200.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 59.0, 85.0, 61.0, 61.0, 60.0, 60.0, 77.0, 58.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 89.0, 72.0, 68.0, 69.0, 85.0, 68.0, 69.0, 89.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 93.0, 88.0, 91.0, 87.0, 92.0, 110.0, 93.0, 90.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 137.0, 99.0, 98.0, 98.0, 98.0, 98.0, 98.0, 98.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 88.0, 88.0, 94.0, 90.0, 89.0, 93.0, 88.0, 89.0], "value": 90.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 59.0, 61.0, 62.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 71.0, 77.0, 69.0, 68.0, 71.0, 71.0, 73.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 96.0, 108.0, 102.0, 108.0, 81.0, 107.0, 103.0, 108.0], "value": 98.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 167.0, 155.0, 147.0, 149.0, 154.0, 150.0, 150.0, 250.0, 182.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 209.0, 175.0, 172.0, 180.0, 227.0, 229.0, 180.0, 177.0], "value": 189.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 85.0, 89.0, 88.0, 74.0, 66.0, 92.0, 92.0, 87.0], "value": 81.6, "unit": "score"}]}]} 08:07:42 INFO - Return code: 0 08:07:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:43 ERROR - # TBPL SUCCESS # 08:07:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:43 INFO - 2016-12-02 08:07:43.053 screenresolution[1660:10884] starting screenresolution argv=screenresolution get 08:07:43 INFO - 2016-12-02 08:07:43.056 screenresolution[1660:10884] Display 0: 1600x1200x32@60 08:07:43 INFO - 2016-12-02 08:07:43.062 screenresolution[1661:10887] starting screenresolution argv=screenresolution list 08:07:43 INFO - Available Modes on Display 0 08:07:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:43 INFO - Intel Iris: 08:07:43 INFO - Chipset Model: Intel Iris 08:07:43 INFO - Type: GPU 08:07:43 INFO - Bus: Built-In 08:07:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:43 INFO - Vendor: Intel (0x8086) 08:07:43 INFO - Device ID: 0x0a2e 08:07:43 INFO - Revision ID: 0x0009 08:07:43 INFO - Displays: 08:07:43 INFO - Display: 08:07:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:43 INFO - Display Serial Number: 1600x1200 60 08:07:43 INFO - Main Display: Yes 08:07:43 INFO - Mirror: Off 08:07:43 INFO - Online: Yes 08:07:43 INFO - Rotation: Supported 08:07:43 INFO - Return code: 0 08:07:43 INFO - Running post-action listener: _resource_record_post_action 08:07:43 INFO - [mozharness: 2016-12-02 16:07:43.305044Z] Finished run-tests step (success) 08:07:43 INFO - Running post-run listener: _resource_record_post_run 08:07:43 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 39377408; Write bytes: 659223040; Read time: 434; Write time: 1880 08:07:43 INFO - TinderboxPrint: CPU usage
54.4% 08:07:43 INFO - TinderboxPrint: I/O read bytes / time
39,377,408 / 434 08:07:43 INFO - TinderboxPrint: I/O write bytes / time
659,223,040 / 1,880 08:07:43 INFO - TinderboxPrint: CPU idle
2,208.8 (45.6%) 08:07:43 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 08:07:43 INFO - TinderboxPrint: CPU user
1,657.4 (34.2%) 08:07:43 INFO - TinderboxPrint: Swap in / out
387,846,144 / 0 08:07:43 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 348088832; Write bytes: 345761792; Read time: 28013; Write time: 609 08:07:43 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35473920; Write bytes: 306080256; Read time: 350; Write time: 1240 08:07:43 INFO - Running post-run listener: _upload_blobber_files 08:07:43 INFO - Blob upload gear active. 08:07:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:45 INFO - (blobuploader) - INFO - Done attempting. 08:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:48 INFO - (blobuploader) - INFO - Done attempting. 08:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:51 INFO - (blobuploader) - INFO - Done attempting. 08:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:51 INFO - Return code: 0 08:07:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ddad7c90d47d21b1b5dc464ca730f07ffe4a96ccef9d926adafbf55979a8a909ba35eadffe37b0ac2d03638741d8b6d1567c9f4951245b13568670310bd555a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d178d1382d9544dfba7900788dcdd3c13b9731995330df13bc924915c433992c9703baf6310df2f1c05104f252c1f70b6d4b51cd66e6a666c1a5afd88701b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7dc5753565224a3272f15366857535c4b1cd39606ed08214454fe8469b13fadf93cec7d649bffd107e708f8de53362af3df075d3a3725ef3b610ed8711a07ea"} 08:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:51 INFO - Contents: 08:07:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ddad7c90d47d21b1b5dc464ca730f07ffe4a96ccef9d926adafbf55979a8a909ba35eadffe37b0ac2d03638741d8b6d1567c9f4951245b13568670310bd555a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d178d1382d9544dfba7900788dcdd3c13b9731995330df13bc924915c433992c9703baf6310df2f1c05104f252c1f70b6d4b51cd66e6a666c1a5afd88701b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7dc5753565224a3272f15366857535c4b1cd39606ed08214454fe8469b13fadf93cec7d649bffd107e708f8de53362af3df075d3a3725ef3b610ed8711a07ea"} 08:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:51 INFO - Copying logs to upload dir... 08:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.198108 ========= master_lag: 3.94 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-12-02 08:07:55.470807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 08:07:55.482051) ========= 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.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ddad7c90d47d21b1b5dc464ca730f07ffe4a96ccef9d926adafbf55979a8a909ba35eadffe37b0ac2d03638741d8b6d1567c9f4951245b13568670310bd555a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d178d1382d9544dfba7900788dcdd3c13b9731995330df13bc924915c433992c9703baf6310df2f1c05104f252c1f70b6d4b51cd66e6a666c1a5afd88701b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7dc5753565224a3272f15366857535c4b1cd39606ed08214454fe8469b13fadf93cec7d649bffd107e708f8de53362af3df075d3a3725ef3b610ed8711a07ea"} build_url:https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011717 build_url: 'https://queue.taskcluster.net/v1/task/IhNSalOkRy63yyW1e150Uw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ddad7c90d47d21b1b5dc464ca730f07ffe4a96ccef9d926adafbf55979a8a909ba35eadffe37b0ac2d03638741d8b6d1567c9f4951245b13568670310bd555a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d178d1382d9544dfba7900788dcdd3c13b9731995330df13bc924915c433992c9703baf6310df2f1c05104f252c1f70b6d4b51cd66e6a666c1a5afd88701b9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7dc5753565224a3272f15366857535c4b1cd39606ed08214454fe8469b13fadf93cec7d649bffd107e708f8de53362af3df075d3a3725ef3b610ed8711a07ea"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 08:07:55.534211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 08:07:55.534513) ========= 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.FZa82J0fkS/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.p6S0Paeewc/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005135 ========= master_lag: 1.50 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 08:07:57.043364) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-12-02 08:07:57.043653) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-12-02 08:08:01.767543) ========= ========= Total master_lag: 5.60 =========