builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0136 starttime: 1483467769.09 results: success (0) buildid: 20170103084739 builduid: 6453a320796e4292a2ec330409f59c6c revision: b32127935d3835505115e296afd745a302367b7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.092533) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.092928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.093225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.120529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.120792) ========= 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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-03 10:22:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-01-03 10:22:49 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155215 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.301515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.301800) ========= 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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.026749 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:49.350566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 10:22:49.350874) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b32127935d3835505115e296afd745a302367b7f --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 b32127935d3835505115e296afd745a302367b7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-03 10:22:49,446 truncating revision to first 12 chars 2017-01-03 10:22:49,446 Setting DEBUG logging. 2017-01-03 10:22:49,446 attempt 1/10 2017-01-03 10:22:49,446 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b32127935d38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-03 10:22:51,104 unpacking tar archive at: mozilla-aurora-b32127935d38/testing/mozharness/ program finished with exit code 0 elapsedTime=1.924990 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-03 10:22:51.298815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:51.299141) ========= script_repo_revision: b32127935d3835505115e296afd745a302367b7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:51.299542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:51.299810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-03 10:22:51.319535) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-03 10:22:51.319913) ========= /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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:22:51 INFO - MultiFileLogger online at 20170103 10:22:51 in /builds/slave/test 10:22:51 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 10:22:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:22:51 INFO - {'append_to_log': False, 10:22:51 INFO - 'base_work_dir': '/builds/slave/test', 10:22:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:22:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:22:51 INFO - 'branch': 'Mozilla-Aurora', 10:22:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:22:51 INFO - 'config_files': ('talos/mac_config.py',), 10:22:51 INFO - 'default_actions': ('clobber', 10:22:51 INFO - 'read-buildbot-config', 10:22:51 INFO - 'download-and-extract', 10:22:51 INFO - 'populate-webroot', 10:22:51 INFO - 'create-virtualenv', 10:22:51 INFO - 'install', 10:22:51 INFO - 'run-tests'), 10:22:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:22:51 INFO - 'download_minidump_stackwalk': True, 10:22:51 INFO - 'download_symbols': 'ondemand', 10:22:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:22:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:22:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:22:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:22:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:22:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:22:51 INFO - 'installer_path': 'installer.exe', 10:22:51 INFO - 'log_level': 'info', 10:22:51 INFO - 'log_name': 'talos', 10:22:51 INFO - 'log_to_console': True, 10:22:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:22:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:22:51 INFO - 'opt_config_files': (), 10:22:51 INFO - 'pip_index': False, 10:22:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:22:51 INFO - 'cmd': ('bash', 10:22:51 INFO - '-c', 10:22:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:22:51 INFO - 'enabled': True, 10:22:51 INFO - 'halt_on_failure': False, 10:22:51 INFO - 'name': 'check_screen_resolution'},), 10:22:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:22:51 INFO - 'cmd': ('bash', 10:22:51 INFO - '-c', 10:22:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:22:51 INFO - 'enabled': True, 10:22:51 INFO - 'halt_on_failure': False, 10:22:51 INFO - 'name': 'check_screen_resolution'},), 10:22:51 INFO - 'run_cmd_checks_enabled': True, 10:22:51 INFO - 'sps_profile': False, 10:22:51 INFO - 'sps_profile_interval': 0, 10:22:51 INFO - 'suite': 'dromaeojs-e10s', 10:22:51 INFO - 'system_bits': '32', 10:22:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:22:51 INFO - 'title': 't-yosemite-r7-0136', 10:22:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:22:51 INFO - 'use_talos_json': True, 10:22:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:22:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:22:51 INFO - 'work_dir': 'build'} 10:22:51 INFO - [mozharness: 2017-01-03 18:22:51.524297Z] Running clobber step. 10:22:51 INFO - Running pre-action listener: _resource_record_pre_action 10:22:51 INFO - Running main action method: clobber 10:22:51 INFO - rmtree: /builds/slave/test/build 10:22:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:22:53 INFO - Running post-action listener: _resource_record_post_action 10:22:53 INFO - [mozharness: 2017-01-03 18:22:53.848729Z] Finished clobber step (success) 10:22:53 INFO - [mozharness: 2017-01-03 18:22:53.848895Z] Running read-buildbot-config step. 10:22:53 INFO - Running pre-action listener: _resource_record_pre_action 10:22:53 INFO - Running main action method: read_buildbot_config 10:22:53 INFO - Using buildbot properties: 10:22:53 INFO - { 10:22:53 INFO - "project": "", 10:22:53 INFO - "product": "firefox", 10:22:53 INFO - "script_repo_revision": "production", 10:22:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:22:53 INFO - "repository": "", 10:22:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:22:53 INFO - "buildid": "20170103084739", 10:22:53 INFO - "pgo_build": "False", 10:22:53 INFO - "basedir": "/builds/slave/test", 10:22:53 INFO - "buildnumber": 9, 10:22:53 INFO - "slavename": "t-yosemite-r7-0136", 10:22:53 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:22:53 INFO - "platform": "yosemite_r7", 10:22:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:22:53 INFO - "branch": "mozilla-aurora", 10:22:53 INFO - "repo_path": "releases/mozilla-aurora", 10:22:53 INFO - "revision": "b32127935d3835505115e296afd745a302367b7f", 10:22:53 INFO - "stage_platform": "macosx64", 10:22:53 INFO - "builduid": "6453a320796e4292a2ec330409f59c6c", 10:22:53 INFO - "slavebuilddir": "test" 10:22:53 INFO - } 10:22:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:22:53 INFO - Running post-action listener: _resource_record_post_action 10:22:53 INFO - [mozharness: 2017-01-03 18:22:53.853082Z] Finished read-buildbot-config step (success) 10:22:53 INFO - [mozharness: 2017-01-03 18:22:53.853249Z] Running download-and-extract step. 10:22:53 INFO - Running pre-action listener: _resource_record_pre_action 10:22:53 INFO - Running main action method: download_and_extract 10:22:53 INFO - mkdir: /builds/slave/test/build/tests 10:22:53 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')]} 10:22:53 INFO - trying https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:22:53 INFO - Downloading https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/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 10:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/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 10:22:57 INFO - Downloaded 1199 bytes. 10:22:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:22:57 INFO - Using the following test package requirements: 10:22:57 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:22:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:22:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:22:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'jsshell-mac.zip'], 10:22:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:22:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:22:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:22:57 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:22:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:22:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:22:57 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:22:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:22:58 INFO - Http code: 200 10:22:58 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:22:58 INFO - x-amz-cf-id: pL6ExrGZxOdA6iSfGXCR7tBQZJutNSyuFCMkv8H7nhGgZrXzb3J6Nw== 10:22:58 INFO - x-amz-version-id: KqtfbX.tstUaZpwBNJvw3rG1rpmTsFkr 10:22:58 INFO - Expected file size: 16269813 10:22:58 INFO - Obtained file size: 16269813 10:23:05 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 10:23:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:23:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:23:05 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:23:05 INFO - Http code: 200 10:23:05 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 10:23:05 INFO - x-amz-cf-id: p5maFNbsXg341HiWw3j2pghsP1kTjsi1FtTdqOduC4gRU4NRIRnK0w== 10:23:05 INFO - x-amz-version-id: KqtfbX.tstUaZpwBNJvw3rG1rpmTsFkr 10:23:06 INFO - Expected file size: 16269813 10:23:06 INFO - Obtained file size: 16269813 10:23:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:23:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:23:12 INFO - Fetch https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:23:13 INFO - Http code: 200 10:23:13 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 10:23:13 INFO - x-amz-cf-id: oNFkRbZPXuSvtIGlkhNfMxV7mGCtQJIgWFY35JuVz150NWKd1C-eVg== 10:23:13 INFO - x-amz-version-id: Uuel9ljD2yyeJNt3jmBqxIScXKd329Pc 10:23:13 INFO - Expected file size: 14409038 10:23:13 INFO - Obtained file size: 14409038 10:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:13 INFO - trying https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:13 INFO - Downloading https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:23:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/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 10:23:16 INFO - Downloaded 109827227 bytes. 10:23:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:16 INFO - mkdir: /builds/slave/test/properties 10:23:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:23:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:23:16 INFO - Contents: 10:23:16 INFO - build_url:https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:23:17 INFO - Running post-action listener: _resource_record_post_action 10:23:17 INFO - Running post-action listener: set_extra_try_arguments 10:23:17 INFO - [mozharness: 2017-01-03 18:23:17.418814Z] Finished download-and-extract step (success) 10:23:17 INFO - [mozharness: 2017-01-03 18:23:17.418908Z] Running populate-webroot step. 10:23:17 INFO - Running pre-action listener: _resource_record_pre_action 10:23:17 INFO - Running main action method: populate_webroot 10:23:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:23:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:23:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:23:17 INFO - '--tppagecycles', 10:23:17 INFO - '7'], 10:23:17 INFO - 'tests': ['tsvgm']}}, 10:23:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:23:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:23:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:23:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:23:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['damp', 'tps']}, 10:23:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'tests': ['damp', 'tps']}, 10:23:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['dromaeo_dom']}, 10:23:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:23:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['basic_compositor_video']}, 10:23:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:23:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['a11yr', 10:23:17 INFO - 'ts_paint', 10:23:17 INFO - 'tpaint', 10:23:17 INFO - 'sessionrestore', 10:23:17 INFO - 'sessionrestore_no_auto_restore', 10:23:17 INFO - 'tabpaint']}, 10:23:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['tsvgx', 10:23:17 INFO - 'tsvgr_opacity', 10:23:17 INFO - 'tart', 10:23:17 INFO - 'tscrollx', 10:23:17 INFO - 'cart']}, 10:23:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:23:17 INFO - 'tsvgr_opacity', 10:23:17 INFO - 'tart', 10:23:17 INFO - 'tscrollx', 10:23:17 INFO - 'cart']}, 10:23:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'talos_options': ['--disable-e10s'], 10:23:17 INFO - 'tests': ['tp5o']}, 10:23:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'tests': ['tp5o']}, 10:23:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'talos_options': ['--disable-e10s', 10:23:17 INFO - '--xperf_path', 10:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:17 INFO - 'tests': ['tp5n']}, 10:23:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:17 INFO - 'talos_options': ['--xperf_path', 10:23:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:17 INFO - 'tests': ['tp5n']}}, 10:23:17 INFO - 'talos.zip': {'path': '', 10:23:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:23:17 INFO - Running post-action listener: _resource_record_post_action 10:23:17 INFO - [mozharness: 2017-01-03 18:23:17.437945Z] Finished populate-webroot step (success) 10:23:17 INFO - [mozharness: 2017-01-03 18:23:17.438079Z] Running create-virtualenv step. 10:23:17 INFO - Running pre-action listener: _resource_record_pre_action 10:23:17 INFO - Running main action method: create_virtualenv 10:23:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:23:17 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 10:23:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:23:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:23:17 INFO - Using real prefix '/tools/python27' 10:23:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:23:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:23:21 INFO - Installing pip.................done. 10:23:21 INFO - Return code: 0 10:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:23:21 INFO - Reading from file tmpfile_stdout 10:23:21 INFO - Output received: 10:23:21 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) 10:23:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:21 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:21 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 10:23:21 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 10:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:21 INFO - 'HOME': '/Users/cltbld', 10:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:21 INFO - 'LOGNAME': 'cltbld', 10:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:21 INFO - 'MOZ_NO_REMOTE': '1', 10:23:21 INFO - 'NO_EM_RESTART': '1', 10:23:21 INFO - 'PAGER': '/bin/cat', 10:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:21 INFO - 'PWD': '/builds/slave/test', 10:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:21 INFO - 'SHELL': '/bin/bash', 10:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:21 INFO - 'USER': 'cltbld', 10:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:21 INFO - 'XPC_FLAGS': '0x0', 10:23:21 INFO - 'XPC_SERVICE_NAME': '0', 10:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:21 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 10:23:21 INFO - Cleaning up... 10:23:21 INFO - Return code: 0 10:23:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:21 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:21 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 10:23:21 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 10:23:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:21 INFO - 'HOME': '/Users/cltbld', 10:23:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:21 INFO - 'LOGNAME': 'cltbld', 10:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:21 INFO - 'MOZ_NO_REMOTE': '1', 10:23:21 INFO - 'NO_EM_RESTART': '1', 10:23:21 INFO - 'PAGER': '/bin/cat', 10:23:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:21 INFO - 'PWD': '/builds/slave/test', 10:23:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:21 INFO - 'SHELL': '/bin/bash', 10:23:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:21 INFO - 'USER': 'cltbld', 10:23:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:21 INFO - 'XPC_FLAGS': '0x0', 10:23:21 INFO - 'XPC_SERVICE_NAME': '0', 10:23:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:22 INFO - Downloading/unpacking psutil>=3.1.1 10:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:23:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:25 INFO - Installing collected packages: psutil 10:23:25 INFO - Running setup.py install for psutil 10:23:26 INFO - building 'psutil._psutil_osx' extension 10:23:26 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 10:23:26 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 10:23:26 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 10:23:26 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 10:23:26 INFO - building 'psutil._psutil_posix' extension 10:23:26 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 10:23:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:23:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:23:26 INFO - ^ 10:23:27 INFO - 1 warning generated. 10:23:27 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 10:23:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:27 INFO - Successfully installed psutil 10:23:27 INFO - Cleaning up... 10:23:27 INFO - Return code: 0 10:23:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:23:27 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')]} 10:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:27 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')]} 10:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:27 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:27 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 10:23:27 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 10:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:27 INFO - 'HOME': '/Users/cltbld', 10:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:27 INFO - 'LOGNAME': 'cltbld', 10:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:27 INFO - 'MOZ_NO_REMOTE': '1', 10:23:27 INFO - 'NO_EM_RESTART': '1', 10:23:27 INFO - 'PAGER': '/bin/cat', 10:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:27 INFO - 'PWD': '/builds/slave/test', 10:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:27 INFO - 'SHELL': '/bin/bash', 10:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:27 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:27 INFO - 'USER': 'cltbld', 10:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:27 INFO - 'XPC_FLAGS': '0x0', 10:23:27 INFO - 'XPC_SERVICE_NAME': '0', 10:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:23:30 INFO - Installing collected packages: mozsystemmonitor 10:23:30 INFO - Running setup.py install for mozsystemmonitor 10:23:30 INFO - Successfully installed mozsystemmonitor 10:23:30 INFO - Cleaning up... 10:23:30 INFO - Return code: 0 10:23:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:30 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:30 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 10:23:30 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 10:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:30 INFO - 'HOME': '/Users/cltbld', 10:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:30 INFO - 'LOGNAME': 'cltbld', 10:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:30 INFO - 'MOZ_NO_REMOTE': '1', 10:23:30 INFO - 'NO_EM_RESTART': '1', 10:23:30 INFO - 'PAGER': '/bin/cat', 10:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:30 INFO - 'PWD': '/builds/slave/test', 10:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:30 INFO - 'SHELL': '/bin/bash', 10:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:30 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:30 INFO - 'USER': 'cltbld', 10:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:30 INFO - 'XPC_FLAGS': '0x0', 10:23:30 INFO - 'XPC_SERVICE_NAME': '0', 10:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:30 INFO - Downloading/unpacking jsonschema==2.5.1 10:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:23:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:23:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:23:33 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 10:23:33 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 10:23:33 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 10:23:33 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 10:23:33 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 10:23:33 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 10:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 10:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:23:33 INFO - warning: no files found matching '*.txt' 10:23:33 INFO - no previously-included directories found matching 'build' 10:23:33 INFO - no previously-included directories found matching 'dist' 10:23:33 INFO - no previously-included directories found matching '.git*' 10:23:33 INFO - Installing collected packages: jsonschema, functools32 10:23:33 INFO - Running setup.py install for functools32 10:23:33 INFO - warning: no files found matching '*.txt' 10:23:33 INFO - no previously-included directories found matching 'build' 10:23:33 INFO - no previously-included directories found matching 'dist' 10:23:33 INFO - no previously-included directories found matching '.git*' 10:23:33 INFO - Successfully installed jsonschema functools32 10:23:33 INFO - Cleaning up... 10:23:34 INFO - Return code: 0 10:23:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:23:34 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')]} 10:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:34 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')]} 10:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:34 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:34 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 10:23:34 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 10:23:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:34 INFO - 'HOME': '/Users/cltbld', 10:23:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:34 INFO - 'LOGNAME': 'cltbld', 10:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:34 INFO - 'MOZ_NO_REMOTE': '1', 10:23:34 INFO - 'NO_EM_RESTART': '1', 10:23:34 INFO - 'PAGER': '/bin/cat', 10:23:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:34 INFO - 'PWD': '/builds/slave/test', 10:23:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:34 INFO - 'SHELL': '/bin/bash', 10:23:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:34 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:34 INFO - 'USER': 'cltbld', 10:23:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:34 INFO - 'XPC_FLAGS': '0x0', 10:23:34 INFO - 'XPC_SERVICE_NAME': '0', 10:23:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:23:34 INFO - Cleaning up... 10:23:34 INFO - Return code: 0 10:23:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:23:34 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')]} 10:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:34 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')]} 10:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:34 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:34 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 10:23:34 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 10:23:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:34 INFO - 'HOME': '/Users/cltbld', 10:23:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:34 INFO - 'LOGNAME': 'cltbld', 10:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:34 INFO - 'MOZ_NO_REMOTE': '1', 10:23:34 INFO - 'NO_EM_RESTART': '1', 10:23:34 INFO - 'PAGER': '/bin/cat', 10:23:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:34 INFO - 'PWD': '/builds/slave/test', 10:23:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:34 INFO - 'SHELL': '/bin/bash', 10:23:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:34 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:34 INFO - 'USER': 'cltbld', 10:23:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:34 INFO - 'XPC_FLAGS': '0x0', 10:23:34 INFO - 'XPC_SERVICE_NAME': '0', 10:23:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:34 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 10:23:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:23:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:23:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:37 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 10:23:38 INFO - Downloading docopt-0.6.1.tar.gz 10:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:23:38 INFO - Installing collected packages: blobuploader, requests, docopt 10:23:38 INFO - Running setup.py install for blobuploader 10:23:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:23:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:23:38 INFO - Running setup.py install for requests 10:23:39 INFO - Running setup.py install for docopt 10:23:39 INFO - Successfully installed blobuploader requests docopt 10:23:39 INFO - Cleaning up... 10:23:39 INFO - Return code: 0 10:23:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:39 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')]} 10:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:39 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')]} 10:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:39 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:39 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 10:23:39 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 10:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:39 INFO - 'HOME': '/Users/cltbld', 10:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:39 INFO - 'LOGNAME': 'cltbld', 10:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:39 INFO - 'MOZ_NO_REMOTE': '1', 10:23:39 INFO - 'NO_EM_RESTART': '1', 10:23:39 INFO - 'PAGER': '/bin/cat', 10:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:39 INFO - 'PWD': '/builds/slave/test', 10:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:39 INFO - 'SHELL': '/bin/bash', 10:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:39 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:39 INFO - 'USER': 'cltbld', 10:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:39 INFO - 'XPC_FLAGS': '0x0', 10:23:39 INFO - 'XPC_SERVICE_NAME': '0', 10:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-AQdGbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-wz1ciA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cUiOk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:39 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kn1G70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4P54Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-IrqPCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-_Oc1Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-JC8QG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-DZtPMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Sj52Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4NB4Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EezuQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:40 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-lFYmcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-8DNNtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4f7AoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-f_E4lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:41 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ekc386-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:23:41 INFO - Running setup.py install for manifestparser 10:23:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:23:41 INFO - Running setup.py install for mozcrash 10:23:41 INFO - Running setup.py install for mozdebug 10:23:41 INFO - Running setup.py install for mozdevice 10:23:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Running setup.py install for mozfile 10:23:42 INFO - Running setup.py install for mozhttpd 10:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Running setup.py install for mozinfo 10:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Running setup.py install for mozInstall 10:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Running setup.py install for mozleak 10:23:42 INFO - Running setup.py install for mozlog 10:23:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:23:42 INFO - Running setup.py install for moznetwork 10:23:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Running setup.py install for mozprocess 10:23:43 INFO - Running setup.py install for mozprofile 10:23:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Running setup.py install for mozrunner 10:23:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Running setup.py install for mozscreenshot 10:23:43 INFO - Running setup.py install for moztest 10:23:43 INFO - Running setup.py install for mozversion 10:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:23:43 INFO - Cleaning up... 10:23:43 INFO - Return code: 0 10:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:44 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:44 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 10:23:44 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 10:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:44 INFO - 'HOME': '/Users/cltbld', 10:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:44 INFO - 'LOGNAME': 'cltbld', 10:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:44 INFO - 'MOZ_NO_REMOTE': '1', 10:23:44 INFO - 'NO_EM_RESTART': '1', 10:23:44 INFO - 'PAGER': '/bin/cat', 10:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:44 INFO - 'PWD': '/builds/slave/test', 10:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:44 INFO - 'SHELL': '/bin/bash', 10:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:44 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:44 INFO - 'USER': 'cltbld', 10:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:44 INFO - 'XPC_FLAGS': '0x0', 10:23:44 INFO - 'XPC_SERVICE_NAME': '0', 10:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-pysArF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-oEdQug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-dDLvhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-LOJwBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-xTDgC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-pr_LR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:44 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)) 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:44 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-4Nnqv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-bdVlMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-sjzOad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-V4FdM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-8jfCpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-YoGk2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-vcEZHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7QIRCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-yY3qJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:45 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)) 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:45 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-ixYz2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:46 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-uOPXjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:46 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)) 10:23:46 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)) 10:23:46 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)) 10:23:46 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)) 10:23:46 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)) 10:23:46 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)) 10:23:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:46 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 10:23:48 INFO - Downloading blessings-1.6.tar.gz 10:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:23:48 INFO - Installing collected packages: blessings 10:23:48 INFO - Running setup.py install for blessings 10:23:49 INFO - Successfully installed blessings 10:23:49 INFO - Cleaning up... 10:23:49 INFO - Return code: 0 10:23:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:49 INFO - Reading from file tmpfile_stdout 10:23:49 INFO - Current package versions: 10:23:49 INFO - blessings == 1.6 10:23:49 INFO - blobuploader == 1.2.4 10:23:49 INFO - docopt == 0.6.1 10:23:49 INFO - functools32 == 3.2.3-2 10:23:49 INFO - jsonschema == 2.5.1 10:23:49 INFO - manifestparser == 1.1 10:23:49 INFO - mozInstall == 1.12 10:23:49 INFO - mozcrash == 1.0 10:23:49 INFO - mozdebug == 0.1 10:23:49 INFO - mozdevice == 0.48 10:23:49 INFO - mozfile == 1.2 10:23:49 INFO - mozhttpd == 0.7 10:23:49 INFO - mozinfo == 0.9 10:23:49 INFO - mozleak == 0.1 10:23:49 INFO - mozlog == 3.4 10:23:49 INFO - moznetwork == 0.27 10:23:49 INFO - mozprocess == 0.23 10:23:49 INFO - mozprofile == 0.28 10:23:49 INFO - mozrunner == 6.13 10:23:49 INFO - mozscreenshot == 0.1 10:23:49 INFO - mozsystemmonitor == 0.3 10:23:49 INFO - moztest == 0.8 10:23:49 INFO - mozversion == 1.4 10:23:49 INFO - psutil == 3.1.1 10:23:49 INFO - requests == 1.2.3 10:23:49 INFO - wsgiref == 0.1.2 10:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:49 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')]} 10:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:49 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')]} 10:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:49 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:49 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 10:23:49 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 10:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:49 INFO - 'HOME': '/Users/cltbld', 10:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:49 INFO - 'LOGNAME': 'cltbld', 10:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:49 INFO - 'MOZ_NO_REMOTE': '1', 10:23:49 INFO - 'NO_EM_RESTART': '1', 10:23:49 INFO - 'PAGER': '/bin/cat', 10:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:49 INFO - 'PWD': '/builds/slave/test', 10:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:49 INFO - 'SHELL': '/bin/bash', 10:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:49 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:49 INFO - 'USER': 'cltbld', 10:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:49 INFO - 'XPC_FLAGS': '0x0', 10:23:49 INFO - 'XPC_SERVICE_NAME': '0', 10:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 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)) 10:23:49 INFO - Cleaning up... 10:23:49 INFO - Return code: 0 10:23:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:23:49 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')]} 10:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:49 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')]} 10:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:49 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 0x106880490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067f6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd3b498ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, '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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 10:23:49 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 10:23:49 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 10:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:49 INFO - 'HOME': '/Users/cltbld', 10:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:49 INFO - 'LOGNAME': 'cltbld', 10:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:49 INFO - 'MOZ_NO_REMOTE': '1', 10:23:49 INFO - 'NO_EM_RESTART': '1', 10:23:49 INFO - 'PAGER': '/bin/cat', 10:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:49 INFO - 'PWD': '/builds/slave/test', 10:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:49 INFO - 'SHELL': '/bin/bash', 10:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:23:49 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:49 INFO - 'USER': 'cltbld', 10:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:49 INFO - 'XPC_FLAGS': '0x0', 10:23:49 INFO - 'XPC_SERVICE_NAME': '0', 10:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:23:49 INFO - Cleaning up... 10:23:49 INFO - Return code: 0 10:23:49 INFO - Running post-action listener: _resource_record_post_action 10:23:49 INFO - Running post-action listener: _start_resource_monitoring 10:23:49 INFO - Starting resource monitoring. 10:23:49 INFO - [mozharness: 2017-01-03 18:23:49.964055Z] Finished create-virtualenv step (success) 10:23:49 INFO - [mozharness: 2017-01-03 18:23:49.965077Z] Running install step. 10:23:49 INFO - Running pre-action listener: _resource_record_pre_action 10:23:49 INFO - Running main action method: install 10:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:50 INFO - Reading from file tmpfile_stdout 10:23:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:23:50 INFO - Reading from file tmpfile_stdout 10:23:50 INFO - Output received: 10:23:50 INFO - Usage: mozinstall [options] installer 10:23:50 INFO - Options: 10:23:50 INFO - -h, --help show this help message and exit 10:23:50 INFO - -d DEST, --destination=DEST 10:23:50 INFO - Directory to install application into. [default: 10:23:50 INFO - "/builds/slave/test"] 10:23:50 INFO - --app=APP Application being installed. [default: firefox] 10:23:50 INFO - mkdir: /builds/slave/test/build/application 10:23:50 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'] 10:23:50 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 10:24:21 INFO - Reading from file tmpfile_stdout 10:24:21 INFO - Output received: 10:24:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:24:21 INFO - Running post-action listener: _resource_record_post_action 10:24:21 INFO - [mozharness: 2017-01-03 18:24:21.207346Z] Finished install step (success) 10:24:21 INFO - [mozharness: 2017-01-03 18:24:21.207506Z] Running run-tests step. 10:24:21 INFO - Running pre-action listener: _resource_record_pre_action 10:24:21 INFO - Running main action method: run_tests 10:24:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:24:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:24:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:24:21 INFO - 2017-01-03 10:24:21.222 screenresolution[1632:8009] starting screenresolution argv=screenresolution get 10:24:21 INFO - 2017-01-03 10:24:21.224 screenresolution[1632:8009] Display 0: 1600x1200x32@60 10:24:21 INFO - 2017-01-03 10:24:21.230 screenresolution[1633:8011] starting screenresolution argv=screenresolution list 10:24:21 INFO - Available Modes on Display 0 10:24:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:24:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:24:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:24:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:24:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:24:21 INFO - Intel Iris: 10:24:21 INFO - Chipset Model: Intel Iris 10:24:21 INFO - Type: GPU 10:24:21 INFO - Bus: Built-In 10:24:21 INFO - VRAM (Dynamic, Max): 1536 MB 10:24:21 INFO - Vendor: Intel (0x8086) 10:24:21 INFO - Device ID: 0x0a2e 10:24:21 INFO - Revision ID: 0x0009 10:24:21 INFO - Displays: 10:24:21 INFO - Display: 10:24:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:24:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:24:21 INFO - Display Serial Number: 1600x1200 60 10:24:21 INFO - Main Display: Yes 10:24:21 INFO - Mirror: Off 10:24:21 INFO - Online: Yes 10:24:21 INFO - Rotation: Supported 10:24:21 INFO - Return code: 0 10:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:24:21 INFO - Python 2.7.3 10:24:21 INFO - Return code: 0 10:24:21 INFO - grabbing minidump binary from tooltool 10:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:24:21 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 0x106694d30>, '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 0x1064fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10668cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:24:21 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 10:24:21 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 10:24:21 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 10:24:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:24:21 INFO - Return code: 0 10:24:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:24:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:24:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:24:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:24:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:24:21 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/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 10:24:21 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/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --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 10:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ySy4zfTgN0/Render', 10:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:21 INFO - 'HOME': '/Users/cltbld', 10:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:21 INFO - 'LOGNAME': 'cltbld', 10:24:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:24:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:21 INFO - 'MOZ_NO_REMOTE': '1', 10:24:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:24:21 INFO - 'NO_EM_RESTART': '1', 10:24:21 INFO - 'PAGER': '/bin/cat', 10:24:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:21 INFO - 'PWD': '/builds/slave/test', 10:24:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:21 INFO - 'SHELL': '/bin/bash', 10:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AtRYZa4oYi/Listeners', 10:24:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 10:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:21 INFO - 'USER': 'cltbld', 10:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:21 INFO - 'XPC_FLAGS': '0x0', 10:24:21 INFO - 'XPC_SERVICE_NAME': '0', 10:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:21 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/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--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 10:24:21 INFO - mozversion application_buildid: 20170103084739 10:24:21 INFO - mozversion application_changeset: b32127935d3835505115e296afd745a302367b7f 10:24:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:24:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:24:21 INFO - mozversion application_name: Firefox 10:24:21 INFO - mozversion application_remotingname: firefox-dev 10:24:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:24:21 INFO - mozversion application_vendor: Mozilla 10:24:21 INFO - mozversion application_version: 52.0a2 10:24:21 INFO - mozversion platform_buildid: 20170103084739 10:24:21 INFO - mozversion platform_changeset: b32127935d3835505115e296afd745a302367b7f 10:24:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:24:21 INFO - mozversion platform_version: 52.0a2 10:24:21 INFO - using testdate: 1483467861 10:24:21 INFO - actual date: 1483467861 10:24:21 INFO - starting webserver on 'localhost:49248' 10:24:21 INFO - SUITE-START | Running 2 tests 10:24:21 INFO - TEST-START | dromaeo_css 10:24:21 INFO - operating with platform_type : mac_ 10:24:21 INFO - Initialising browser for dromaeo_css test... 10:24:21 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpa8u26X/profile http://localhost:49248/getInfo.html) 10:24:25 INFO - PROCESS | 1643 | 2017-01-03 10:24:25.011 plugin-container[1645:8193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 10:24:25 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:25 INFO - PROCESS | 1643 | 2017-01-03 10:24:25.014 plugin-container[1645:8193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 10:24:25 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:25 INFO - PROCESS | 1643 | 2017-01-03 10:24:25.014 plugin-container[1645:8193] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:24:25 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 10:24:25 INFO - PROCESS | 1643 | colorDepth:24 10:24:25 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 10:24:25 INFO - PROCESS | 1643 | __metrics 10:24:25 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:24:25 INFO - TEST-INFO | 1643: exit 0 10:24:25 INFO - Browser initialized. 10:24:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:24:25 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpa8u26X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:28 INFO - PROCESS | 1647 | 2017-01-03 10:24:28.442 plugin-container[1648:8328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:24:28 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:28 INFO - PROCESS | 1647 | 2017-01-03 10:24:28.443 plugin-container[1648:8328] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x842f, name = 'com.apple.CFPasteboardClient' 10:24:28 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:24:28 INFO - PROCESS | 1647 | 2017-01-03 10:24:28.443 plugin-container[1648:8328] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:24:38 INFO - PROCESS | 1647 | RSS: Main: 229511168 10:24:38 INFO - PROCESS | 1647 | 10:25:27 INFO - PROCESS | 1647 | 1483467927736 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] 10:27:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 10:27:42 INFO - PROCESS | 1647 | RSS: Main: 234090496 10:27:42 INFO - PROCESS | 1647 | 10:30:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 10:30:45 INFO - PROCESS | 1647 | RSS: Main: 243265536 10:30:45 INFO - PROCESS | 1647 | 10:33:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 10:33:48 INFO - PROCESS | 1647 | RSS: Main: 246644736 10:33:48 INFO - PROCESS | 1647 | 10:36:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 10:36:50 INFO - PROCESS | 1647 | RSS: Main: 249450496 10:36:50 INFO - PROCESS | 1647 | 10:39:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 10:39:54 INFO - PROCESS | 1647 | RSS: Main: 252915712 10:39:54 INFO - PROCESS | 1647 | 10:42:56 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 10:42:57 INFO - PROCESS | 1647 | RSS: Main: 254496768 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | __start_tp_report 10:42:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 10:42:57 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 10:42:57 INFO - PROCESS | 1647 | |i|pagename|runs| 10:42:57 INFO - PROCESS | 1647 | |0;dojo.html;2779.4163225722596;3301.6038075430943;3410.164509695125;3412.6246112927556;3452.292280082583;5801.883962320751;5821.563382746301;5833.270841144857;5882.529397648189;5901.409859014097;4903.338049363335;5781.566382521307;5930.347661757203;5942.078977758443;5970.970145149279;5237.139884404575;5301.231321458386;5302.125149350371;5356.196570514415;5366.838994830161;5251.081060814361;5285.603579731516;5287.550558202557;5363.8122665706705;5380;4325.805338759764;5120.231965205212;5181.740912954338;5220.321358223445;5325.866853328678;5182.404023537266;5227.8170264040955;5270.7628156733035;5291.444398338158;5291.761870715827;4395.406620106277;5220.660657057279;5239.921401178985;5268.60485463588;5299.576033917316;5618.325800903876;5749.770009199627;5790.623609465413;5844.795432159854;5886.558508111866;5137.255098010804;5491.780328786884;5955.196048533479;6256.96871515644;6262.434391402149;6248.125262463259;6260.40526150015;6285.8742825143245;6300.936990630081;6307.653079080649;5772.989726797794;5860.267466566722;5874.295084589877;5913.02435098204;5937.851553711105;6331.588446750947;6390.137331460286;6417.39034791694;6436.292007879129;6450.548461607643;6144.893919094606;6167.722452489649;6170.5372097092;6171.413715697002;6176.722047507873;6120.66336351496;6134.263888333428;6229.813105606839;6236.937630623635;6250.4374606285655;4726.291056341576;4963.429205641325;5167.819126330561;6058.515318774487;6289.24529056507;5141.791678955443;6227.06594010902;6232.688365581703;6245.313015568284;6256.436920677161;4186.979065104716;4830.203016502238;4981.775820088104;4986.077575648516;4988.426330971912;3812.370958791824;4217.873463796091;4445.110977804452;4469.9776501117285;4492.528284530077;5595.21666966625;5821.893840170354;5987.940120598738;5988.520918326523;5997.850053748692;5100.6429549931145;6173.8456538586;6220.688965551704;6236.968815155895;6281.403266689748;5825.300963884361;6035.7283922223605;6055.273367195877;6065.878682426327;6100.938990610126;4492.865214043584;5460.208269800856;5463.289772329651;5482.8081017165005;5485.204645326485;6183.84540386485;6201.81394558155;6210.099535567408;6329.715162817776;6337.271213810471;6254.562180647311;6269.905951410641;6278.717457714322;6312.905306420315;6317.557770955989;5843.503302219359;6034.487068599218;6165.753369865155;6311.96844015777;6320.747170113144;6122.794608433986;6162.568620196723;6178.1659475971965;6220.098085777628;6270.623762574261;6135.417135372132;6251.437370636482;6258.311585725658;6271;6286.339934306832;4558.931616025829;6136.815895523141;6174.567780255339;6196.008638617799;6220.409061139185;6094.542909281733;6099.664518451527;6125.9693701531205;6126.1423400724825;6145.754169833157;5995.760169593167;6034.517238620988;6064.514838812973;6081.1486391906055;6090.69546522681;6142.232220972379;6185.103160041859;6207.410296021871;6222.533310001678;6245.781397651061;5880.029795083763;5934.465898069195;6060.818175454743;6088.51291896656;6136.417040381157 10:42:57 INFO - PROCESS | 1647 | |1;ext.html;443.32393100521705;463.3721307628166;496.49853647815695;519.1589624807812;530.3821048478524;38498.615013849856;39785.602143978555;39997.80001099994;42537.57462425375;42631;41575.58424415755;41851;41973.37039944396;42090.15819683612;42091;9321.440713557175;9455.81088378232;9463.57413916372;9479.47862867542;9487.52562371882;9438;9492.81014379712;9520.904790952105;9524.333296669236;9543.522823858813;9492.288078394113;9493.0981556752;9530.332876698634;9535.52322383878;9550.426974381524;9451.33840631156;9486.478243696594;9518.762030949212;9525.761855953622;9531.475768832712;9341.579628916716;9414.811703765887;9422.104900034486;9430.245580353556;9440.386374885678;39230.21539569221;39366.015849603704;39404;39482.60517394847;39495.60504394948;3279.918002049944;3358.1604598850286;3372.9156771080675;3530.9823450882836;3614.1868079681863;28563.857180713963;29590;30467.085987420192;30502.54246186309;31153.065408037794;2648.3776312566533;2796.1192224449233;3071.831049292288;3167.8891238806764;3191.7446604271604;379731;411952;495289;506327;506524;56310.43689563052;56475.71762141245;56565.71717141388;56595.15107273394;56708.71645641745;57488;57579;62018.0697289541;62167.68916155481;62749;14372.928135359256;15886.046837189806;16021.59946001336;16087.597810054842;16107.19464026794;11851.46668399924;12616.369181540886;12630.368481576068;12699.746005080031;12751.744965100646;16783.2447539861;17158.31366745341;17199.484015479557;17265.223064962105;17278.395256165975;6770.763023294161;6789.6605169741315;6814.761483348059;6830.59016459014;6900.930990690129;838.9580520973927;846.3398549131687;993.572763711611;1053.599632139782;1073.7798751255973;28419.721112549985;29000;29289.56065659017;29854;29870.40259194804;853.5220276645099;931.0642803981955;1025.3284098915221;1030;1082.4858192358724;13756.86243137576;14886.957912945989;15167.544973650587;15611.297491612904;15978.840211597968;597486;615118;617864;619006;619343;57397.71301143467;58337;58394;58418.831623367296;58511;1382.5990462765685;1386.1890793885489;1414.031388498861;1416.4971435140376;1421.232534431416;29738.70261297446;30312.54531182078;31193.220169495944;31250;31730.365392691554;50399.74800125976;51480;51591;51615.74192129015;51765.22352164796;377097;472120;472568.637156812;474964;475473.2452675429;39424.605753942094;41088.1782364357;42100.789496052326;42386.364204537575;44412.333814992155;44902.55097448984;44932.65202043944;45349.09301814011;45389;45953.62139135831;27357.86321068382;29502.524873756654;37239;37398.5040598373;39216.60783392244;28549.857250714445;38784;39011.829645110694;39297.60702392939;40164.39753403643;37588;37720.24559508849;38363.61636383712;38547.42178867263;38676;33610.83194584012;34476.655233447345;34905.65094349126;35130.82434587811;35470.29059418849;22681.659775103715;24354.878225609467;25766.87116564405;25857.319274247115;26023.219303420927 10:42:57 INFO - PROCESS | 1647 | |2;jquery.html;361.55348145040875;375.9774413535188;382.2870346803211;383.13985103442775;397.9950624672701;18389.54026149347;19514.512137196576;19598.216071357147;19976.300829470973;20219.898900505512;15531.922340388282;18659.440216793482;18931;19274.614507709837;19719.309824156157;5149.098907691148;5374.946250537503;5537.0863807471715;5809.622374545662;5843.18195452637;5594.748236329375;5761.078227483604;5768.798092066779;5768.884622307552;5774.480296773289;4775.4985726498735;5599.132134519156;5741.540676745871;5755.079187330028;5791.565632577553;5842.182094506751;6004.879902401927;6018.3981601839905;6023.427774361407;6026.63840169589;5653.830385088454;5808.59339846211;5835.883282334329;5847.7953271635715;5882.852843695481;12601.684957876034;12730.23618582888;12837.871621283854;13034;13066;2268.6597010448563;2350.788429041377;2366.0654041653625;2526.2295000024983;2722.9591556126675;9668.806623867553;9687.41875487473;9745.31782775206;10028.89971100287;10174.44040577768;1765.1703699261327;1786.802842095799;1829.9176537055864;1834.257125864027;1844.6587381334496;97139;129383.41233175284;134169;139709.99999999898;142102;19562.60874782525;20002.09990550429;20313.390598282076;20933;21782.910854457532;35098.82450587731;35717.8214108933;35721;35733.28533429317;35890.28219435597;10610.09814165789;10852.620158294421;10879.238453308351;10916.454177291103;10994.945025274823;7787.637163496479;8415.579221038923;8841.690540831169;8868.201861832466;9007;9664.661736839176;9752.902470975341;9838.16375608067;9872.555734991942;9893.565433012316;3866.815249384089;3872.1674839909556;3876.5541962674088;3970.6029397060065;4062.1469491407133;807.4186585658316;833.2167762303536;872.1235158665501;918.4213945214606;929.3958926697566;19912.203511859654;20516;20639.896800516202;20678.586428271352;20776.48058798542;887.3078998381272;913.4610579757842;917.6329468212634;947.554649314821;991.2169386184834;8252.422330436812;10652.360858348524;10782.676519704264;10877.456127193767;10940.343579385262;435278;462034;463112;560598;617353;126863;126988;129821;130127;135927;969.709087273815;970.4565443351746;1026.7227848480868;1028.0695970147028;1029.4029462911494;17614.823851761317;17899.642007160044;18299.81700182981;18339.266429342675;18493.90753046226;54372.45627543832;54389;55747.72126139343;56722.43277567172;57295;74239;76828;77003.61498192474;80109;82434;7879.645415956181;7958.403119765925;8064.717734879251;8128.227818357246;8223.424360294723;11864;12333;12395.070369722127;12603.558875439683;12712.427940742504;9229.123233292827;10625.309354891908;10666.2400703883;11010.834837477605;11069.446527673423;8688.304935605263;9710.854337184806;10541;10544.736381590521;10844.295120817122;8516.914830851612;11235.831462527905;11240.83138752903;11265.324080555192;11445.626524816742;6903.689333979883;7769.611519423893;7946.245106714853;8116.350691944748;8281.585920704061;8825.69110081144;10784.730381740519;10817.945910270399;10937.671869843918;11096 10:42:57 INFO - PROCESS | 1647 | |3;mootools.html;1380.0891411668294;1488.4418343121329;1625.9593510162244;1737.2877120380647;1792.399546152039;7458.664360103795;7754.651040703167;8028.478148920316;8507.234348908598;8525.78685532862;7890;8264.421490495668;8292.585370731455;8293.626786794593;8302.83394332113;2306.5041016181517;2308.0652335804025;2328.464453175771;2335.4628435459854;2336.707911511061;2315.9536809263805;2343.789058984691;2350.7766762157567;2355.1286024170995;2360.6223004319313;1903.6954087346028;2126.170793390579;2187.9015444304964;2256.684064231009;2274.8521346112534;2291.4385975436044;2297.931062068141;2319.721633403994;2321.0251694288354;2323.93028209154;2276.5674521840797;2283.851549649284;2292.495650956787;2294.73610534789;2299.8965046572944;8268.586570671503;8363.080061193265;8384.03583587889;8392.24469797715;8398.916010839874;5029.245613158056;5187.922181167285;5193.37679478465;5202.583793296527;5204.5576126028955;3265.5591495148087;3336.215989242526;3576.266865292635;3597.1366871950804;3608.1520842601967;1041.8176819056634;1054.9060115670388;1082.99458502707;1093.7101668057971;1103.6027030269177;9072.818543629157;10789.568417263301;10851.077658398966;10868.891311086867;10878.782424351468;4188.602082802129;4458.35353873693;4584.4957054723955;4648.83729069481;4669.299605059268;8889.377743557889;9384.8592271116;9404.858927116098;9461.337706360626;9469.621215151317;5193.506616871391;5197.324347834833;5198.662086964335;5205.947940520547;5206.453322401169;3955.1891862168186;4218.514870789837;4291.485021797404;4715.646326525524;4778.307145463958;3780.4896338994436;3823.5220597425323;3861.9806900965314;3899.3760998240714;3932.5477570079233;1260.1431026901794;1260.7667581497453;1260.8928241099609;1264.9494020239272;1277.5720133755297;796.7450415866867;861.8965724113021;888.8222355528791;909.4997751236793;911.2618778789202;4797;5611.186377975171;5757.971210143923;5769.134629805562;5899.587028907935;731.5903094267227;775.4068137874418;870.4472659861034;893.4728510179026;958.6500927161675;3834.69322454203;3841.4237864320576;3849.191669749384;3857.556381016219;3866.149447121629;9868.407895526292;10161.441120738282;10232.437215953045;10244.334118282288;10328.948355258175;9382.577783999737;10173.949130254301;10230.795384092276;10232.079112879728;10240.692779216635;7166.211716711157;7430.479866409408;7648.617569121521;7920.841583168304;7921.683132674743;5606.803761868315;5675.716214189357;5726.141078838207;5824.15549745293;5921.2006379138265;9120.49837258957;9184.494852782895;9207.953960230425;9351.719448416557;9365.812683746422;9442.10300021497;9506.809863802824;9577.329586928849;9595.47224902637;9622.37454565451;6318.778842740666;6325.240971083499;7177.6052317120975;7192.065031545865;7318.780436586911;7973.960130199312;8017.5991200438575;8059.717909873127;8071.677132914618;8077.87883181741;7045.401140902875;7190.352868241884;7195.964020179866;7221.350078492961;7288.562686238843;7002.050934867998;7075;7143.6428178591905;7192.316729910859;7230.385417239593;6694.330566943267;6697.933020669926;6771.762988295386;6774.187097548326;6787.287334829969;4726.858194254178;4740.336352910526;4757.690750101232;4789.521047895322;4795.688280261911;4593.6554758392585;4597.080583883304;4631.536846315342;4748.287756836502;4846.885216400177 10:42:57 INFO - PROCESS | 1647 | |4;prototype.html;302.1148036253777;304.611620184265;309.70732657638536;312.57801967344074;315.73478278246284;4230.513490948538;5178.741062946857;5313;5365.7585408656605;5577.498025177733;4573;4814.975925120379;4875.951240487594;5377.704226267554;5381.973090134544;3361.613414457332;3371.342588195303;4086.6730661547003;4122.855700050499;4142.772147531885;3369.4777309517062;3957.8021098944937;4106.7125301228925;4110.342345224764;4121.8969525761795;3513.5432393788774;3990.5211374635082;4035.4955630546183;4052.1895620875944;4063.2889244382263;3670.9082272943124;4033.657139143176;4039.8788036358956;4069.4302797608357;4072.7963601819793;3362.4788157835574;3420.3843308204514;3539.433690609516;3547.2728090741334;3560.1633616100194;4397.670174736908;4831.275308703723;5073.868975030496;5128.589712822965;5141.203113517411;3881.7476864003747;3987.641112299907;4117.382392641128;4549.973273652808;4556.248219043854;4884.095202870883;5266.920996185022;5548.112302031655;5592.412796656374;5601.831945041615;2997.4005198960076;3547.822608869572;3775.848966041355;3797.9810100949317;3810.8856734298015;5851.941480585182;5855.184892683239;5862.589618726691;5885.293764748215;5893.911591326134;3818.4654148419245;3841.615838416136;3862.266169427856;3871.7289789715014;3875.9612403876163;3790.981045094757;3914.530256369197;3933.272344616255;3960.6435420812263;3964.920701585952;3557.7865328080397;3733.8238454886623;4023.657989070903;4129.410177081845;4572.88567785808;4888.9755551222015;4912.582430493377;5068.923966140511;5608.411116832755;5640.900024495266;1072.0458791675414;1227.1777908801125;1240.9379531023412;1260.684828792802;1277.8404496401051;738.7303634173595;748.7425412381674;813.5362843179331;860.5439117267858;872.5942436766807;4594.931076033862;4927.408710954708;4963.6277279204205;4966.255061740768;4971.701697898137;4593.63250939924;5017;5213.175388613955;5457.699826509501;5475.233467314579;4385.583369579948;4432.645388368923;4871.610271178297;4934.383202099738;4976.701397916137;2529.3929456930205;2558.2453176313034;2848.273690209025;2848.643919510061;2871.25347409675;4962.578180854595;5583.330000399978;5628.452175651647;5679.971600141973;5722.570807189478;4595.356650068926;5153.793848246103;5391.35303763543;5513.558915286768;5531.957423417104;5210.348706411699;5229.535135783191;5938.168656388109;6031.788887388921;6069.2110025696375;5782.236417892583;5796.768129274782;5807.796727114531;5812.68030258323;5828.388019258086;4661.627069834473;5191.792328306826;5652.943470565407;5679.5172410345585;5758.2514273144225;4789.281607758864;4960.007998400262;5655.915161272666;5808.76764929415;5933.169356290209;3733.3839916413485;3869.6130386961077;3895.941560876646;3900.9077458311717;3915.650609634197;5551.417101204315;5765.711714414347;5773.874094551522;5778.971105144447;5840.766369345179;4902.676277405009;5147.510986456281;5234.633575649668;5626.634268772516;5633.957662862009;5636.323641163087;5655.547556195576;5686.43135686428;5700.686462244616;5714.514266287246;5230;5279.788808447619;5417.485338892799;5527.2538207341495;5544;4679.485256621837;4941.629377796751;5190.299309593157;5607.971960140173;5610.905873354656;5475.835724928259;5483.506484416422;5497.890042199214;5520.779168833363;5606.411326810626 10:42:57 INFO - PROCESS | 1647 | |5;yui.html;623.4856243599027;683.330336270455;686.4714170089035;689.5173378634955;755.267390631088;14101.294935253234;14727.116373017627;14944.252787360616;15100.169490678036;15191.088534687913;13245.933770331136;13466.192028478274;13633.727325453485;13664.795028074563;13671.316434178301;778.462860626169;805.7341077444459;809.3646487507308;809.7773112394079;809.9190080991913;636.9172007639;660.0396423204251;798.349345283595;825.0800357601262;829;855.8972923249219;858.2790456016944;858.5235194467068;858.935579831512;862.0689655172399;834.5410024486539;854.0520022774715;854.086127843208;854.2439940652505;855.8844555984924;516.5144763921938;634.6890023888261;636.5862189576766;636.8407898025494;638.4923985431593;13363.398647060905;13843.723125537434;13924.746772790397;13975.091619044832;13985;12977.416016279196;13313.40089695966;13403.664908377272;13487.730245395136;13555.661108472268;10446.843297350546;10652.786944261148;10655.307405018726;10744.570217191382;11078.556857725682;3637.181634132299;3675.6691897729065;3696.075981004749;3697.242065376591;3747.9437808432895;70117.64941175262;78235;80844.59577702073;88677.11322886817;92416;8708.78228044304;10218.591256349811;10291.691249262534;10342.431166285927;10375.584976601003;16258.51224463268;19106.808931910782;19752.3086691968;20423.183072676926;20507.58984820295;7614.58119803405;7749.4575379724;7783.995857563888;7792.805179870548;7898.407619428566;3612.674859262679;3705.888823335304;4229.577042295808;4308.827646894089;4381.6494680425485;2374.786269235777;3068.47835867903;3147.7639177061355;3173.5557022016937;3254.5118232264876;639.9840003999938;657.3722095398882;658.9209294884548;666.2338310942455;673.8147009572407;522.4227228911998;560.4087687489738;593.5696619950587;603.0110618585524;649.233903993283;7388.224236455095;8193.71322003727;9236.676716314896;9365.62537498506;9396.718098457057;565.2595100418465;597.4205021129497;626.5520153090562;667.0661074495745;672.5661948043485;4327.394164816865;4380.123975204971;4491.416115904912;4503.909921801545;4606.723596584216;97617.02382976079;116143.41928290474;120836;124700;124985.37507312406;100381;101222;101401;103469.48265258776;104555;88409;89626.10373896308;90932.99999999868;92194.53902730443;92353.07646923579;8619.051904290649;8863;8887.955560222157;8966.402100614554;8967;46129;46323.305150423446;57315.42684573101;57624.423755761905;58794;46844.7657761709;52415.73792131015;65423.67288163719;69595.65202173957;70938;11026.944865275622;12051.457684404048;12725.427355768827;12751.234925904475;12994.155379900276;11897.82153267719;12718.427670755023;14160.716785664436;14335.211563364115;14820.703585928437;11788.4695188715;12371.62885113412;12511.374431278582;12631.431585578855;12939.935300323437;12779.61661150167;12888.48446062147;13269.203847769164;13293.867061329263;13358.225258684177;12665.620031399072;12817.423215955117;13159.802602961156;13210.075294729277;13768.036237463282;10498.370097794157;10715.571377144826;11226.4386780659;11312.9434352831;11456.968872801155;11253.493592788507;11338.60314888975;11549.307041577533;11588.826167607662;11594.884051159717 10:42:57 INFO - PROCESS | 1647 | __end_tp_report 10:42:57 INFO - PROCESS | 1647 | __start_cc_report 10:42:57 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,374 10:42:57 INFO - PROCESS | 1647 | __end_cc_report 10:42:57 INFO - PROCESS | 1647 | __startTimestamp1483468977007__endTimestamp 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | ------- Summary: start ------- 10:42:57 INFO - PROCESS | 1647 | Number of tests: 6 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5709.54 Median:5995.76 stddev:705.55 (11.8%) stddev-sans-first:669.23 10:42:57 INFO - PROCESS | 1647 | Values: 2779.4 3301.6 3410.2 3412.6 3452.3 5801.9 5821.6 5833.3 5882.5 5901.4 4903.3 5781.6 5930.3 5942.1 5971.0 5237.1 5301.2 5302.1 5356.2 5366.8 5251.1 5285.6 5287.6 5363.8 5380.0 4325.8 5120.2 5181.7 5220.3 5325.9 5182.4 5227.8 5270.8 5291.4 5291.8 4395.4 5220.7 5239.9 5268.6 5299.6 5618.3 5749.8 5790.6 5844.8 5886.6 5137.3 5491.8 5955.2 6257.0 6262.4 6248.1 6260.4 6285.9 6300.9 6307.7 5773.0 5860.3 5874.3 5913.0 5937.9 6331.6 6390.1 6417.4 6436.3 6450.5 6144.9 6167.7 6170.5 6171.4 6176.7 6120.7 6134.3 6229.8 6236.9 6250.4 4726.3 4963.4 5167.8 6058.5 6289.2 5141.8 6227.1 6232.7 6245.3 6256.4 4187.0 4830.2 4981.8 4986.1 4988.4 3812.4 4217.9 4445.1 4470.0 4492.5 5595.2 5821.9 5987.9 5988.5 5997.9 5100.6 6173.8 6220.7 6237.0 6281.4 5825.3 6035.7 6055.3 6065.9 6100.9 4492.9 5460.2 5463.3 5482.8 5485.2 6183.8 6201.8 6210.1 6329.7 6337.3 6254.6 6269.9 6278.7 6312.9 6317.6 5843.5 6034.5 6165.8 6312.0 6320.7 6122.8 6162.6 6178.2 6220.1 6270.6 6135.4 6251.4 6258.3 6271.0 6286.3 4558.9 6136.8 6174.6 6196.0 6220.4 6094.5 6099.7 6126.0 6126.1 6145.8 5995.8 6034.5 6064.5 6081.1 6090.7 6142.2 6185.1 6207.4 6222.5 6245.8 5880.0 5934.5 6060.8 6088.5 6136.4 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:65224.19 Median:40626.29 stddev:137592.86 (338.7%) stddev-sans-first:137892.88 10:42:57 INFO - PROCESS | 1647 | Values: 443.3 463.4 496.5 519.2 530.4 38498.6 39785.6 39997.8 42537.6 42631.0 41575.6 41851.0 41973.4 42090.2 42091.0 9321.4 9455.8 9463.6 9479.5 9487.5 9438.0 9492.8 9520.9 9524.3 9543.5 9492.3 9493.1 9530.3 9535.5 9550.4 9451.3 9486.5 9518.8 9525.8 9531.5 9341.6 9414.8 9422.1 9430.2 9440.4 39230.2 39366.0 39404.0 39482.6 39495.6 3279.9 3358.2 3372.9 3531.0 3614.2 28563.9 29590.0 30467.1 30502.5 31153.1 2648.4 2796.1 3071.8 3167.9 3191.7 379731.0 411952.0 495289.0 506327.0 506524.0 56310.4 56475.7 56565.7 56595.2 56708.7 57488.0 57579.0 62018.1 62167.7 62749.0 14372.9 15886.0 16021.6 16087.6 16107.2 11851.5 12616.4 12630.4 12699.7 12751.7 16783.2 17158.3 17199.5 17265.2 17278.4 6770.8 6789.7 6814.8 6830.6 6900.9 839.0 846.3 993.6 1053.6 1073.8 28419.7 29000.0 29289.6 29854.0 29870.4 853.5 931.1 1025.3 1030.0 1082.5 13756.9 14887.0 15167.5 15611.3 15978.8 597486.0 615118.0 617864.0 619006.0 619343.0 57397.7 58337.0 58394.0 58418.8 58511.0 1382.6 1386.2 1414.0 1416.5 1421.2 29738.7 30312.5 31193.2 31250.0 31730.4 50399.7 51480.0 51591.0 51615.7 51765.2 377097.0 472120.0 472568.6 474964.0 475473.2 39424.6 41088.2 42100.8 42386.4 44412.3 44902.6 44932.7 45349.1 45389.0 45953.6 27357.9 29502.5 37239.0 37398.5 39216.6 28549.9 38784.0 39011.8 39297.6 40164.4 37588.0 37720.2 38363.6 38547.4 38676.0 33610.8 34476.7 34905.7 35130.8 35470.3 22681.7 24354.9 25766.9 25857.3 26023.2 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:33471.74 Median:382.71 stddev:86820.40 (22685.5%) stddev-sans-first:87028.36 10:42:57 INFO - PROCESS | 1647 | Values: 361.6 376.0 382.3 383.1 398.0 18389.5 19514.5 19598.2 19976.3 20219.9 15531.9 18659.4 18931.0 19274.6 19719.3 5149.1 5374.9 5537.1 5809.6 5843.2 5594.7 5761.1 5768.8 5768.9 5774.5 4775.5 5599.1 5741.5 5755.1 5791.6 5842.2 6004.9 6018.4 6023.4 6026.6 5653.8 5808.6 5835.9 5847.8 5882.9 12601.7 12730.2 12837.9 13034.0 13066.0 2268.7 2350.8 2366.1 2526.2 2723.0 9668.8 9687.4 9745.3 10028.9 10174.4 1765.2 1786.8 1829.9 1834.3 1844.7 97139.0 129383.4 134169.0 139710.0 142102.0 19562.6 20002.1 20313.4 20933.0 21782.9 35098.8 35717.8 35721.0 35733.3 35890.3 10610.1 10852.6 10879.2 10916.5 10994.9 7787.6 8415.6 8841.7 8868.2 9007.0 9664.7 9752.9 9838.2 9872.6 9893.6 3866.8 3872.2 3876.6 3970.6 4062.1 807.4 833.2 872.1 918.4 929.4 19912.2 20516.0 20639.9 20678.6 20776.5 887.3 913.5 917.6 947.6 991.2 8252.4 10652.4 10782.7 10877.5 10940.3 435278.0 462034.0 463112.0 560598.0 617353.0 126863.0 126988.0 129821.0 130127.0 135927.0 969.7 970.5 1026.7 1028.1 1029.4 17614.8 17899.6 18299.8 18339.3 18493.9 54372.5 54389.0 55747.7 56722.4 57295.0 74239.0 76828.0 77003.6 80109.0 82434.0 7879.6 7958.4 8064.7 8128.2 8223.4 11864.0 12333.0 12395.1 12603.6 12712.4 9229.1 10625.3 10666.2 11010.8 11069.4 8688.3 9710.9 10541.0 10544.7 10844.3 8516.9 11235.8 11240.8 11265.3 11445.6 6903.7 7769.6 7946.2 8116.4 8281.6 8825.7 10784.7 10817.9 10937.7 11096.0 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5426.05 Median:5193.44 stddev:2973.16 (57.2%) stddev-sans-first:2965.95 10:42:57 INFO - PROCESS | 1647 | Values: 1380.1 1488.4 1626.0 1737.3 1792.4 7458.7 7754.7 8028.5 8507.2 8525.8 7890.0 8264.4 8292.6 8293.6 8302.8 2306.5 2308.1 2328.5 2335.5 2336.7 2316.0 2343.8 2350.8 2355.1 2360.6 1903.7 2126.2 2187.9 2256.7 2274.9 2291.4 2297.9 2319.7 2321.0 2323.9 2276.6 2283.9 2292.5 2294.7 2299.9 8268.6 8363.1 8384.0 8392.2 8398.9 5029.2 5187.9 5193.4 5202.6 5204.6 3265.6 3336.2 3576.3 3597.1 3608.2 1041.8 1054.9 1083.0 1093.7 1103.6 9072.8 10789.6 10851.1 10868.9 10878.8 4188.6 4458.4 4584.5 4648.8 4669.3 8889.4 9384.9 9404.9 9461.3 9469.6 5193.5 5197.3 5198.7 5205.9 5206.5 3955.2 4218.5 4291.5 4715.6 4778.3 3780.5 3823.5 3862.0 3899.4 3932.5 1260.1 1260.8 1260.9 1264.9 1277.6 796.7 861.9 888.8 909.5 911.3 4797.0 5611.2 5758.0 5769.1 5899.6 731.6 775.4 870.4 893.5 958.7 3834.7 3841.4 3849.2 3857.6 3866.1 9868.4 10161.4 10232.4 10244.3 10328.9 9382.6 10173.9 10230.8 10232.1 10240.7 7166.2 7430.5 7648.6 7920.8 7921.7 5606.8 5675.7 5726.1 5824.2 5921.2 9120.5 9184.5 9208.0 9351.7 9365.8 9442.1 9506.8 9577.3 9595.5 9622.4 6318.8 6325.2 7177.6 7192.1 7318.8 7974.0 8017.6 8059.7 8071.7 8077.9 7045.4 7190.4 7196.0 7221.4 7288.6 7002.1 7075.0 7143.6 7192.3 7230.4 6694.3 6697.9 6771.8 6774.2 6787.3 4726.9 4740.3 4757.7 4789.5 4795.7 4593.7 4597.1 4631.5 4748.3 4846.9 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4440.31 Median:4938.01 stddev:1388.77 (28.1%) stddev-sans-first:1357.49 10:42:57 INFO - PROCESS | 1647 | Values: 302.1 304.6 309.7 312.6 315.7 4230.5 5178.7 5313.0 5365.8 5577.5 4573.0 4815.0 4876.0 5377.7 5382.0 3361.6 3371.3 4086.7 4122.9 4142.8 3369.5 3957.8 4106.7 4110.3 4121.9 3513.5 3990.5 4035.5 4052.2 4063.3 3670.9 4033.7 4039.9 4069.4 4072.8 3362.5 3420.4 3539.4 3547.3 3560.2 4397.7 4831.3 5073.9 5128.6 5141.2 3881.7 3987.6 4117.4 4550.0 4556.2 4884.1 5266.9 5548.1 5592.4 5601.8 2997.4 3547.8 3775.8 3798.0 3810.9 5851.9 5855.2 5862.6 5885.3 5893.9 3818.5 3841.6 3862.3 3871.7 3876.0 3791.0 3914.5 3933.3 3960.6 3964.9 3557.8 3733.8 4023.7 4129.4 4572.9 4889.0 4912.6 5068.9 5608.4 5640.9 1072.0 1227.2 1240.9 1260.7 1277.8 738.7 748.7 813.5 860.5 872.6 4594.9 4927.4 4963.6 4966.3 4971.7 4593.6 5017.0 5213.2 5457.7 5475.2 4385.6 4432.6 4871.6 4934.4 4976.7 2529.4 2558.2 2848.3 2848.6 2871.3 4962.6 5583.3 5628.5 5680.0 5722.6 4595.4 5153.8 5391.4 5513.6 5532.0 5210.3 5229.5 5938.2 6031.8 6069.2 5782.2 5796.8 5807.8 5812.7 5828.4 4661.6 5191.8 5652.9 5679.5 5758.3 4789.3 4960.0 5655.9 5808.8 5933.2 3733.4 3869.6 3895.9 3900.9 3915.7 5551.4 5765.7 5773.9 5779.0 5840.8 4902.7 5147.5 5234.6 5626.6 5634.0 5636.3 5655.5 5686.4 5700.7 5714.5 5230.0 5279.8 5417.5 5527.3 5544.0 4679.5 4941.6 5190.3 5608.0 5610.9 5475.8 5483.5 5497.9 5520.8 5606.4 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:20433.55 Median:4269.20 stddev:30643.03 (717.8%) stddev-sans-first:30692.89 10:42:57 INFO - PROCESS | 1647 | Values: 623.5 683.3 686.5 689.5 755.3 14101.3 14727.1 14944.3 15100.2 15191.1 13245.9 13466.2 13633.7 13664.8 13671.3 778.5 805.7 809.4 809.8 809.9 636.9 660.0 798.3 825.1 829.0 855.9 858.3 858.5 858.9 862.1 834.5 854.1 854.1 854.2 855.9 516.5 634.7 636.6 636.8 638.5 13363.4 13843.7 13924.7 13975.1 13985.0 12977.4 13313.4 13403.7 13487.7 13555.7 10446.8 10652.8 10655.3 10744.6 11078.6 3637.2 3675.7 3696.1 3697.2 3747.9 70117.6 78235.0 80844.6 88677.1 92416.0 8708.8 10218.6 10291.7 10342.4 10375.6 16258.5 19106.8 19752.3 20423.2 20507.6 7614.6 7749.5 7784.0 7792.8 7898.4 3612.7 3705.9 4229.6 4308.8 4381.6 2374.8 3068.5 3147.8 3173.6 3254.5 640.0 657.4 658.9 666.2 673.8 522.4 560.4 593.6 603.0 649.2 7388.2 8193.7 9236.7 9365.6 9396.7 565.3 597.4 626.6 667.1 672.6 4327.4 4380.1 4491.4 4503.9 4606.7 97617.0 116143.4 120836.0 124700.0 124985.4 100381.0 101222.0 101401.0 103469.5 104555.0 88409.0 89626.1 90933.0 92194.5 92353.1 8619.1 8863.0 8888.0 8966.4 8967.0 46129.0 46323.3 57315.4 57624.4 58794.0 46844.8 52415.7 65423.7 69595.7 70938.0 11026.9 12051.5 12725.4 12751.2 12994.2 11897.8 12718.4 14160.7 14335.2 14820.7 11788.5 12371.6 12511.4 12631.4 12939.9 12779.6 12888.5 13269.2 13293.9 13358.2 12665.6 12817.4 13159.8 13210.1 13768.0 10498.4 10715.6 11226.4 11312.9 11457.0 11253.5 11338.6 11549.3 11588.8 11594.9 10:42:57 INFO - PROCESS | 1647 | -------- Summary: end -------- 10:42:57 INFO - PROCESS | 1647 | 10:42:57 INFO - TEST-INFO | 1647: exit 0 10:42:57 INFO - TEST-OK | dromaeo_css | took 1115853ms 10:42:57 INFO - TEST-START | kraken 10:42:57 INFO - operating with platform_type : mac_ 10:42:57 INFO - Initialising browser for kraken test... 10:42:57 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpchv2qA/profile http://localhost:49248/getInfo.html) 10:43:00 INFO - PROCESS | 1656 | 2017-01-03 10:43:00.654 plugin-container[1657:10474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 10:43:00 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:00 INFO - PROCESS | 1656 | 2017-01-03 10:43:00.658 plugin-container[1657:10474] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 10:43:00 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:00 INFO - PROCESS | 1656 | 2017-01-03 10:43:00.658 plugin-container[1657:10474] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:43:00 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:43:00 INFO - PROCESS | 1656 | colorDepth:24 10:43:00 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:43:00 INFO - PROCESS | 1656 | __metrics 10:43:00 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:43:01 INFO - TEST-INFO | 1656: exit 0 10:43:01 INFO - Browser initialized. 10:43:01 INFO - Running cycle 1/1 for kraken test... 10:43:01 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpchv2qA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:43:04 INFO - PROCESS | 1658 | 2017-01-03 10:43:04.149 plugin-container[1659:10598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 10:43:04 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:04 INFO - PROCESS | 1658 | 2017-01-03 10:43:04.149 plugin-container[1659:10598] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x421b, name = 'com.apple.CFPasteboardClient' 10:43:04 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:43:04 INFO - PROCESS | 1658 | 2017-01-03 10:43:04.149 plugin-container[1659:10598] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:43:13 INFO - PROCESS | 1658 | RSS: Main: 229572608 10:43:13 INFO - PROCESS | 1658 | 10:43:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 10:43:17 INFO - PROCESS | 1658 | RSS: Main: 241623040 10:43:17 INFO - PROCESS | 1658 | 10:43:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 10:43:20 INFO - PROCESS | 1658 | RSS: Main: 249131008 10:43:20 INFO - PROCESS | 1658 | 10:43:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 10:43:24 INFO - PROCESS | 1658 | RSS: Main: 252796928 10:43:24 INFO - PROCESS | 1658 | 10:43:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 10:43:27 INFO - PROCESS | 1658 | RSS: Main: 254341120 10:43:27 INFO - PROCESS | 1658 | 10:43:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:43:29 INFO - PROCESS | 1658 | RSS: Main: 254181376 10:43:29 INFO - PROCESS | 1658 | 10:43:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 10:43:33 INFO - PROCESS | 1658 | RSS: Main: 258785280 10:43:33 INFO - PROCESS | 1658 | 10:43:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 10:43:36 INFO - PROCESS | 1658 | RSS: Main: 258715648 10:43:36 INFO - PROCESS | 1658 | 10:43:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 10:43:40 INFO - PROCESS | 1658 | RSS: Main: 258207744 10:43:40 INFO - PROCESS | 1658 | 10:43:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:43:42 INFO - PROCESS | 1658 | RSS: Main: 257089536 10:43:42 INFO - PROCESS | 1658 | 10:43:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:43:45 INFO - PROCESS | 1658 | RSS: Main: 257159168 10:43:45 INFO - PROCESS | 1658 | 10:43:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:43:48 INFO - PROCESS | 1658 | RSS: Main: 257167360 10:43:48 INFO - PROCESS | 1658 | 10:43:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:43:52 INFO - PROCESS | 1658 | RSS: Main: 257171456 10:43:52 INFO - PROCESS | 1658 | 10:43:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:43:55 INFO - PROCESS | 1658 | RSS: Main: 257564672 10:43:55 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 10:43:57 INFO - PROCESS | 1658 | RSS: Main: 259248128 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | __start_tp_report 10:43:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:43:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:43:57 INFO - PROCESS | 1658 | |i|pagename|runs| 10:43:57 INFO - PROCESS | 1658 | |0;ai-astar;106;115;115;118;115;115;116;116;117;116 10:43:57 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;111;110;142;96;132;146;146;154;111 10:43:57 INFO - PROCESS | 1658 | |2;audio-dft;186;202;196;197;197;195;196;195;200;197 10:43:57 INFO - PROCESS | 1658 | |3;audio-fft;83;59;61;85;62;61;60;72;70;65 10:43:57 INFO - PROCESS | 1658 | |4;audio-oscillator;85;72;88;71;72;70;87;69;72;95 10:43:57 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;85;113;131;99;87;88;101;88;85 10:43:57 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;96;95;119;97;95;95;97;101;95 10:43:57 INFO - PROCESS | 1658 | |7;imaging-desaturate;93;78;122;79;120;93;89;140;131;142 10:43:57 INFO - PROCESS | 1658 | |8;json-parse-financial;57;56;57;57;60;60;61;62;77;92 10:43:57 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;69;74;71;77;77;76;71;73;72;72 10:43:57 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;85;75;109;76;97;105;105;108;101;87 10:43:57 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;151;125;152;159;163;145;155;222;162 10:43:57 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;190;158;240;236;206;167;166;164;165;169 10:43:57 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;63;70;60;59;62;63;58;58;81;83 10:43:57 INFO - PROCESS | 1658 | __end_tp_report 10:43:57 INFO - PROCESS | 1658 | __start_cc_report 10:43:57 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,979 10:43:57 INFO - PROCESS | 1658 | __end_cc_report 10:43:57 INFO - PROCESS | 1658 | __startTimestamp1483469037624__endTimestamp 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:43:57 INFO - PROCESS | 1658 | Number of tests: 14 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:3.28 (2.8%) stddev-sans-first:1.05 10:43:57 INFO - PROCESS | 1658 | Values: 106.0 115.0 115.0 118.0 115.0 115.0 116.0 116.0 117.0 116.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:144.00 stddev:20.13 (14.0%) stddev-sans-first:20.80 10:43:57 INFO - PROCESS | 1658 | Values: 142.0 111.0 110.0 142.0 96.0 132.0 146.0 146.0 154.0 111.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:196.10 Median:197.00 stddev:4.18 (2.1%) stddev-sans-first:2.33 10:43:57 INFO - PROCESS | 1658 | Values: 186.0 202.0 196.0 197.0 197.0 195.0 196.0 195.0 200.0 197.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.80 Median:67.50 stddev:9.55 (14.2%) stddev-sans-first:8.40 10:43:57 INFO - PROCESS | 1658 | Values: 83.0 59.0 61.0 85.0 62.0 61.0 60.0 72.0 70.0 65.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.50 stddev:9.55 (12.2%) stddev-sans-first:9.80 10:43:57 INFO - PROCESS | 1658 | Values: 85.0 72.0 88.0 71.0 72.0 70.0 87.0 69.0 72.0 95.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:87.50 stddev:15.13 (17.3%) stddev-sans-first:15.73 10:43:57 INFO - PROCESS | 1658 | Values: 88.0 85.0 113.0 131.0 99.0 87.0 88.0 101.0 88.0 85.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:95.00 stddev:7.44 (7.8%) stddev-sans-first:7.79 10:43:57 INFO - PROCESS | 1658 | Values: 95.0 96.0 95.0 119.0 97.0 95.0 95.0 97.0 101.0 95.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:108.70 Median:78.50 stddev:24.94 (31.8%) stddev-sans-first:25.79 10:43:57 INFO - PROCESS | 1658 | Values: 93.0 78.0 122.0 79.0 120.0 93.0 89.0 140.0 131.0 142.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:60.50 stddev:11.59 (19.2%) stddev-sans-first:12.02 10:43:57 INFO - PROCESS | 1658 | Values: 57.0 56.0 57.0 57.0 60.0 60.0 61.0 62.0 77.0 92.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.50 stddev:2.74 (3.7%) stddev-sans-first:2.45 10:43:57 INFO - PROCESS | 1658 | Values: 69.0 74.0 71.0 77.0 77.0 76.0 71.0 73.0 72.0 72.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:75.50 stddev:13.04 (17.3%) stddev-sans-first:13.34 10:43:57 INFO - PROCESS | 1658 | Values: 85.0 75.0 109.0 76.0 97.0 105.0 105.0 108.0 101.0 87.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:157.00 stddev:25.49 (16.2%) stddev-sans-first:26.16 10:43:57 INFO - PROCESS | 1658 | Values: 139.0 151.0 125.0 152.0 159.0 163.0 145.0 155.0 222.0 162.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.10 Median:179.50 stddev:30.90 (17.2%) stddev-sans-first:32.74 10:43:57 INFO - PROCESS | 1658 | Values: 190.0 158.0 240.0 236.0 206.0 167.0 166.0 164.0 165.0 169.0 10:43:57 INFO - PROCESS | 1658 | 10:43:57 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:63.00 stddev:9.29 (14.7%) stddev-sans-first:9.80 10:43:57 INFO - PROCESS | 1658 | Values: 63.0 70.0 60.0 59.0 62.0 63.0 58.0 58.0 81.0 83.0 10:43:57 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:43:57 INFO - PROCESS | 1658 | 10:43:58 INFO - TEST-INFO | 1658: exit 0 10:43:58 INFO - TEST-OK | kraken | took 60997ms 10:43:58 INFO - SUITE-END | took 1176s 10:43:58 INFO - Completed test suite (00:19:36) 10:43:58 INFO - javascript benchmark 10:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.318388695927, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2779.4163225722596, 3301.6038075430943, 3410.164509695125, 3412.6246112927556, 3452.292280082583, 5801.883962320751, 5821.563382746301, 5833.270841144857, 5882.529397648189, 5901.409859014097, 4903.338049363335, 5781.566382521307, 5930.347661757203, 5942.078977758443, 5970.970145149279, 5237.139884404575, 5301.231321458386, 5302.125149350371, 5356.196570514415, 5366.838994830161, 5251.081060814361, 5285.603579731516, 5287.550558202557, 5363.8122665706705, 5380.0, 4325.805338759764, 5120.231965205212, 5181.740912954338, 5220.321358223445, 5325.866853328678, 5182.404023537266, 5227.8170264040955, 5270.7628156733035, 5291.444398338158, 5291.761870715827, 4395.406620106277, 5220.660657057279, 5239.921401178985, 5268.60485463588, 5299.576033917316, 5618.325800903876, 5749.770009199627, 5790.623609465413, 5844.795432159854, 5886.558508111866, 5137.255098010804, 5491.780328786884, 5955.196048533479, 6256.96871515644, 6262.434391402149, 6248.125262463259, 6260.40526150015, 6285.8742825143245, 6300.936990630081, 6307.653079080649, 5772.989726797794, 5860.267466566722, 5874.295084589877, 5913.02435098204, 5937.851553711105, 6331.588446750947, 6390.137331460286, 6417.39034791694, 6436.292007879129, 6450.548461607643, 6144.893919094606, 6167.722452489649, 6170.5372097092, 6171.413715697002, 6176.722047507873, 6120.66336351496, 6134.263888333428, 6229.813105606839, 6236.937630623635, 6250.4374606285655, 4726.291056341576, 4963.429205641325, 5167.819126330561, 6058.515318774487, 6289.24529056507, 5141.791678955443, 6227.06594010902, 6232.688365581703, 6245.313015568284, 6256.436920677161, 4186.979065104716, 4830.203016502238, 4981.775820088104, 4986.077575648516, 4988.426330971912, 3812.370958791824, 4217.873463796091, 4445.110977804452, 4469.9776501117285, 4492.528284530077, 5595.21666966625, 5821.893840170354, 5987.940120598738, 5988.520918326523, 5997.850053748692, 5100.6429549931145, 6173.8456538586, 6220.688965551704, 6236.968815155895, 6281.403266689748, 5825.300963884361, 6035.7283922223605, 6055.273367195877, 6065.878682426327, 6100.938990610126, 4492.865214043584, 5460.208269800856, 5463.289772329651, 5482.8081017165005, 5485.204645326485, 6183.84540386485, 6201.81394558155, 6210.099535567408, 6329.715162817776, 6337.271213810471, 6254.562180647311, 6269.905951410641, 6278.717457714322, 6312.905306420315, 6317.557770955989, 5843.503302219359, 6034.487068599218, 6165.753369865155, 6311.96844015777, 6320.747170113144, 6122.794608433986, 6162.568620196723, 6178.1659475971965, 6220.098085777628, 6270.623762574261, 6135.417135372132, 6251.437370636482, 6258.311585725658, 6271.0, 6286.339934306832, 4558.931616025829, 6136.815895523141, 6174.567780255339, 6196.008638617799, 6220.409061139185, 6094.542909281733, 6099.664518451527, 6125.9693701531205, 6126.1423400724825, 6145.754169833157, 5995.760169593167, 6034.517238620988, 6064.514838812973, 6081.1486391906055, 6090.69546522681, 6142.232220972379, 6185.103160041859, 6207.410296021871, 6222.533310001678, 6245.781397651061, 5880.029795083763, 5934.465898069195, 6060.818175454743, 6088.51291896656, 6136.417040381157], "value": 5664.674143111325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.32393100521705, 463.3721307628166, 496.49853647815695, 519.1589624807812, 530.3821048478524, 38498.615013849856, 39785.602143978555, 39997.80001099994, 42537.57462425375, 42631.0, 41575.58424415755, 41851.0, 41973.37039944396, 42090.15819683612, 42091.0, 9321.440713557175, 9455.81088378232, 9463.57413916372, 9479.47862867542, 9487.52562371882, 9438.0, 9492.81014379712, 9520.904790952105, 9524.333296669236, 9543.522823858813, 9492.288078394113, 9493.0981556752, 9530.332876698634, 9535.52322383878, 9550.426974381524, 9451.33840631156, 9486.478243696594, 9518.762030949212, 9525.761855953622, 9531.475768832712, 9341.579628916716, 9414.811703765887, 9422.104900034486, 9430.245580353556, 9440.386374885678, 39230.21539569221, 39366.015849603704, 39404.0, 39482.60517394847, 39495.60504394948, 3279.918002049944, 3358.1604598850286, 3372.9156771080675, 3530.9823450882836, 3614.1868079681863, 28563.857180713963, 29590.0, 30467.085987420192, 30502.54246186309, 31153.065408037794, 2648.3776312566533, 2796.1192224449233, 3071.831049292288, 3167.8891238806764, 3191.7446604271604, 379731.0, 411952.0, 495289.0, 506327.0, 506524.0, 56310.43689563052, 56475.71762141245, 56565.71717141388, 56595.15107273394, 56708.71645641745, 57488.0, 57579.0, 62018.0697289541, 62167.68916155481, 62749.0, 14372.928135359256, 15886.046837189806, 16021.59946001336, 16087.597810054842, 16107.19464026794, 11851.46668399924, 12616.369181540886, 12630.368481576068, 12699.746005080031, 12751.744965100646, 16783.2447539861, 17158.31366745341, 17199.484015479557, 17265.223064962105, 17278.395256165975, 6770.763023294161, 6789.6605169741315, 6814.761483348059, 6830.59016459014, 6900.930990690129, 838.9580520973927, 846.3398549131687, 993.572763711611, 1053.599632139782, 1073.7798751255973, 28419.721112549985, 29000.0, 29289.56065659017, 29854.0, 29870.40259194804, 853.5220276645099, 931.0642803981955, 1025.3284098915221, 1030.0, 1082.4858192358724, 13756.86243137576, 14886.957912945989, 15167.544973650587, 15611.297491612904, 15978.840211597968, 597486.0, 615118.0, 617864.0, 619006.0, 619343.0, 57397.71301143467, 58337.0, 58394.0, 58418.831623367296, 58511.0, 1382.5990462765685, 1386.1890793885489, 1414.031388498861, 1416.4971435140376, 1421.232534431416, 29738.70261297446, 30312.54531182078, 31193.220169495944, 31250.0, 31730.365392691554, 50399.74800125976, 51480.0, 51591.0, 51615.74192129015, 51765.22352164796, 377097.0, 472120.0, 472568.637156812, 474964.0, 475473.2452675429, 39424.605753942094, 41088.1782364357, 42100.789496052326, 42386.364204537575, 44412.333814992155, 44902.55097448984, 44932.65202043944, 45349.09301814011, 45389.0, 45953.62139135831, 27357.86321068382, 29502.524873756654, 37239.0, 37398.5040598373, 39216.60783392244, 28549.857250714445, 38784.0, 39011.829645110694, 39297.60702392939, 40164.39753403643, 37588.0, 37720.24559508849, 38363.61636383712, 38547.42178867263, 38676.0, 33610.83194584012, 34476.655233447345, 34905.65094349126, 35130.82434587811, 35470.29059418849, 22681.659775103715, 24354.878225609467, 25766.87116564405, 25857.319274247115, 26023.219303420927], "value": 19606.8437615724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.55348145040875, 375.9774413535188, 382.2870346803211, 383.13985103442775, 397.9950624672701, 18389.54026149347, 19514.512137196576, 19598.216071357147, 19976.300829470973, 20219.898900505512, 15531.922340388282, 18659.440216793482, 18931.0, 19274.614507709837, 19719.309824156157, 5149.098907691148, 5374.946250537503, 5537.0863807471715, 5809.622374545662, 5843.18195452637, 5594.748236329375, 5761.078227483604, 5768.798092066779, 5768.884622307552, 5774.480296773289, 4775.4985726498735, 5599.132134519156, 5741.540676745871, 5755.079187330028, 5791.565632577553, 5842.182094506751, 6004.879902401927, 6018.3981601839905, 6023.427774361407, 6026.63840169589, 5653.830385088454, 5808.59339846211, 5835.883282334329, 5847.7953271635715, 5882.852843695481, 12601.684957876034, 12730.23618582888, 12837.871621283854, 13034.0, 13066.0, 2268.6597010448563, 2350.788429041377, 2366.0654041653625, 2526.2295000024983, 2722.9591556126675, 9668.806623867553, 9687.41875487473, 9745.31782775206, 10028.89971100287, 10174.44040577768, 1765.1703699261327, 1786.802842095799, 1829.9176537055864, 1834.257125864027, 1844.6587381334496, 97139.0, 129383.41233175284, 134169.0, 139709.99999999898, 142102.0, 19562.60874782525, 20002.09990550429, 20313.390598282076, 20933.0, 21782.910854457532, 35098.82450587731, 35717.8214108933, 35721.0, 35733.28533429317, 35890.28219435597, 10610.09814165789, 10852.620158294421, 10879.238453308351, 10916.454177291103, 10994.945025274823, 7787.637163496479, 8415.579221038923, 8841.690540831169, 8868.201861832466, 9007.0, 9664.661736839176, 9752.902470975341, 9838.16375608067, 9872.555734991942, 9893.565433012316, 3866.815249384089, 3872.1674839909556, 3876.5541962674088, 3970.6029397060065, 4062.1469491407133, 807.4186585658316, 833.2167762303536, 872.1235158665501, 918.4213945214606, 929.3958926697566, 19912.203511859654, 20516.0, 20639.896800516202, 20678.586428271352, 20776.48058798542, 887.3078998381272, 913.4610579757842, 917.6329468212634, 947.554649314821, 991.2169386184834, 8252.422330436812, 10652.360858348524, 10782.676519704264, 10877.456127193767, 10940.343579385262, 435278.0, 462034.0, 463112.0, 560598.0, 617353.0, 126863.0, 126988.0, 129821.0, 130127.0, 135927.0, 969.709087273815, 970.4565443351746, 1026.7227848480868, 1028.0695970147028, 1029.4029462911494, 17614.823851761317, 17899.642007160044, 18299.81700182981, 18339.266429342675, 18493.90753046226, 54372.45627543832, 54389.0, 55747.72126139343, 56722.43277567172, 57295.0, 74239.0, 76828.0, 77003.61498192474, 80109.0, 82434.0, 7879.645415956181, 7958.403119765925, 8064.717734879251, 8128.227818357246, 8223.424360294723, 11864.0, 12333.0, 12395.070369722127, 12603.558875439683, 12712.427940742504, 9229.123233292827, 10625.309354891908, 10666.2400703883, 11010.834837477605, 11069.446527673423, 8688.304935605263, 9710.854337184806, 10541.0, 10544.736381590521, 10844.295120817122, 8516.914830851612, 11235.831462527905, 11240.83138752903, 11265.324080555192, 11445.626524816742, 6903.689333979883, 7769.611519423893, 7946.245106714853, 8116.350691944748, 8281.585920704061, 8825.69110081144, 10784.730381740519, 10817.945910270399, 10937.671869843918, 11096.0], "value": 10079.004310525586, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.0891411668294, 1488.4418343121329, 1625.9593510162244, 1737.2877120380647, 1792.399546152039, 7458.664360103795, 7754.651040703167, 8028.478148920316, 8507.234348908598, 8525.78685532862, 7890.0, 8264.421490495668, 8292.585370731455, 8293.626786794593, 8302.83394332113, 2306.5041016181517, 2308.0652335804025, 2328.464453175771, 2335.4628435459854, 2336.707911511061, 2315.9536809263805, 2343.789058984691, 2350.7766762157567, 2355.1286024170995, 2360.6223004319313, 1903.6954087346028, 2126.170793390579, 2187.9015444304964, 2256.684064231009, 2274.8521346112534, 2291.4385975436044, 2297.931062068141, 2319.721633403994, 2321.0251694288354, 2323.93028209154, 2276.5674521840797, 2283.851549649284, 2292.495650956787, 2294.73610534789, 2299.8965046572944, 8268.586570671503, 8363.080061193265, 8384.03583587889, 8392.24469797715, 8398.916010839874, 5029.245613158056, 5187.922181167285, 5193.37679478465, 5202.583793296527, 5204.5576126028955, 3265.5591495148087, 3336.215989242526, 3576.266865292635, 3597.1366871950804, 3608.1520842601967, 1041.8176819056634, 1054.9060115670388, 1082.99458502707, 1093.7101668057971, 1103.6027030269177, 9072.818543629157, 10789.568417263301, 10851.077658398966, 10868.891311086867, 10878.782424351468, 4188.602082802129, 4458.35353873693, 4584.4957054723955, 4648.83729069481, 4669.299605059268, 8889.377743557889, 9384.8592271116, 9404.858927116098, 9461.337706360626, 9469.621215151317, 5193.506616871391, 5197.324347834833, 5198.662086964335, 5205.947940520547, 5206.453322401169, 3955.1891862168186, 4218.514870789837, 4291.485021797404, 4715.646326525524, 4778.307145463958, 3780.4896338994436, 3823.5220597425323, 3861.9806900965314, 3899.3760998240714, 3932.5477570079233, 1260.1431026901794, 1260.7667581497453, 1260.8928241099609, 1264.9494020239272, 1277.5720133755297, 796.7450415866867, 861.8965724113021, 888.8222355528791, 909.4997751236793, 911.2618778789202, 4797.0, 5611.186377975171, 5757.971210143923, 5769.134629805562, 5899.587028907935, 731.5903094267227, 775.4068137874418, 870.4472659861034, 893.4728510179026, 958.6500927161675, 3834.69322454203, 3841.4237864320576, 3849.191669749384, 3857.556381016219, 3866.149447121629, 9868.407895526292, 10161.441120738282, 10232.437215953045, 10244.334118282288, 10328.948355258175, 9382.577783999737, 10173.949130254301, 10230.795384092276, 10232.079112879728, 10240.692779216635, 7166.211716711157, 7430.479866409408, 7648.617569121521, 7920.841583168304, 7921.683132674743, 5606.803761868315, 5675.716214189357, 5726.141078838207, 5824.15549745293, 5921.2006379138265, 9120.49837258957, 9184.494852782895, 9207.953960230425, 9351.719448416557, 9365.812683746422, 9442.10300021497, 9506.809863802824, 9577.329586928849, 9595.47224902637, 9622.37454565451, 6318.778842740666, 6325.240971083499, 7177.6052317120975, 7192.065031545865, 7318.780436586911, 7973.960130199312, 8017.5991200438575, 8059.717909873127, 8071.677132914618, 8077.87883181741, 7045.401140902875, 7190.352868241884, 7195.964020179866, 7221.350078492961, 7288.562686238843, 7002.050934867998, 7075.0, 7143.6428178591905, 7192.316729910859, 7230.385417239593, 6694.330566943267, 6697.933020669926, 6771.762988295386, 6774.187097548326, 6787.287334829969, 4726.858194254178, 4740.336352910526, 4757.690750101232, 4789.521047895322, 4795.688280261911, 4593.6554758392585, 4597.080583883304, 4631.536846315342, 4748.287756836502, 4846.885216400177], "value": 4394.451558508269, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.1148036253777, 304.611620184265, 309.70732657638536, 312.57801967344074, 315.73478278246284, 4230.513490948538, 5178.741062946857, 5313.0, 5365.7585408656605, 5577.498025177733, 4573.0, 4814.975925120379, 4875.951240487594, 5377.704226267554, 5381.973090134544, 3361.613414457332, 3371.342588195303, 4086.6730661547003, 4122.855700050499, 4142.772147531885, 3369.4777309517062, 3957.8021098944937, 4106.7125301228925, 4110.342345224764, 4121.8969525761795, 3513.5432393788774, 3990.5211374635082, 4035.4955630546183, 4052.1895620875944, 4063.2889244382263, 3670.9082272943124, 4033.657139143176, 4039.8788036358956, 4069.4302797608357, 4072.7963601819793, 3362.4788157835574, 3420.3843308204514, 3539.433690609516, 3547.2728090741334, 3560.1633616100194, 4397.670174736908, 4831.275308703723, 5073.868975030496, 5128.589712822965, 5141.203113517411, 3881.7476864003747, 3987.641112299907, 4117.382392641128, 4549.973273652808, 4556.248219043854, 4884.095202870883, 5266.920996185022, 5548.112302031655, 5592.412796656374, 5601.831945041615, 2997.4005198960076, 3547.822608869572, 3775.848966041355, 3797.9810100949317, 3810.8856734298015, 5851.941480585182, 5855.184892683239, 5862.589618726691, 5885.293764748215, 5893.911591326134, 3818.4654148419245, 3841.615838416136, 3862.266169427856, 3871.7289789715014, 3875.9612403876163, 3790.981045094757, 3914.530256369197, 3933.272344616255, 3960.6435420812263, 3964.920701585952, 3557.7865328080397, 3733.8238454886623, 4023.657989070903, 4129.410177081845, 4572.88567785808, 4888.9755551222015, 4912.582430493377, 5068.923966140511, 5608.411116832755, 5640.900024495266, 1072.0458791675414, 1227.1777908801125, 1240.9379531023412, 1260.684828792802, 1277.8404496401051, 738.7303634173595, 748.7425412381674, 813.5362843179331, 860.5439117267858, 872.5942436766807, 4594.931076033862, 4927.408710954708, 4963.6277279204205, 4966.255061740768, 4971.701697898137, 4593.63250939924, 5017.0, 5213.175388613955, 5457.699826509501, 5475.233467314579, 4385.583369579948, 4432.645388368923, 4871.610271178297, 4934.383202099738, 4976.701397916137, 2529.3929456930205, 2558.2453176313034, 2848.273690209025, 2848.643919510061, 2871.25347409675, 4962.578180854595, 5583.330000399978, 5628.452175651647, 5679.971600141973, 5722.570807189478, 4595.356650068926, 5153.793848246103, 5391.35303763543, 5513.558915286768, 5531.957423417104, 5210.348706411699, 5229.535135783191, 5938.168656388109, 6031.788887388921, 6069.2110025696375, 5782.236417892583, 5796.768129274782, 5807.796727114531, 5812.68030258323, 5828.388019258086, 4661.627069834473, 5191.792328306826, 5652.943470565407, 5679.5172410345585, 5758.2514273144225, 4789.281607758864, 4960.007998400262, 5655.915161272666, 5808.76764929415, 5933.169356290209, 3733.3839916413485, 3869.6130386961077, 3895.941560876646, 3900.9077458311717, 3915.650609634197, 5551.417101204315, 5765.711714414347, 5773.874094551522, 5778.971105144447, 5840.766369345179, 4902.676277405009, 5147.510986456281, 5234.633575649668, 5626.634268772516, 5633.957662862009, 5636.323641163087, 5655.547556195576, 5686.43135686428, 5700.686462244616, 5714.514266287246, 5230.0, 5279.788808447619, 5417.485338892799, 5527.2538207341495, 5544.0, 4679.485256621837, 4941.629377796751, 5190.299309593157, 5607.971960140173, 5610.905873354656, 5475.835724928259, 5483.506484416422, 5497.890042199214, 5520.779168833363, 5606.411326810626], "value": 3993.3919074575733, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.4856243599027, 683.330336270455, 686.4714170089035, 689.5173378634955, 755.267390631088, 14101.294935253234, 14727.116373017627, 14944.252787360616, 15100.169490678036, 15191.088534687913, 13245.933770331136, 13466.192028478274, 13633.727325453485, 13664.795028074563, 13671.316434178301, 778.462860626169, 805.7341077444459, 809.3646487507308, 809.7773112394079, 809.9190080991913, 636.9172007639, 660.0396423204251, 798.349345283595, 825.0800357601262, 829.0, 855.8972923249219, 858.2790456016944, 858.5235194467068, 858.935579831512, 862.0689655172399, 834.5410024486539, 854.0520022774715, 854.086127843208, 854.2439940652505, 855.8844555984924, 516.5144763921938, 634.6890023888261, 636.5862189576766, 636.8407898025494, 638.4923985431593, 13363.398647060905, 13843.723125537434, 13924.746772790397, 13975.091619044832, 13985.0, 12977.416016279196, 13313.40089695966, 13403.664908377272, 13487.730245395136, 13555.661108472268, 10446.843297350546, 10652.786944261148, 10655.307405018726, 10744.570217191382, 11078.556857725682, 3637.181634132299, 3675.6691897729065, 3696.075981004749, 3697.242065376591, 3747.9437808432895, 70117.64941175262, 78235.0, 80844.59577702073, 88677.11322886817, 92416.0, 8708.78228044304, 10218.591256349811, 10291.691249262534, 10342.431166285927, 10375.584976601003, 16258.51224463268, 19106.808931910782, 19752.3086691968, 20423.183072676926, 20507.58984820295, 7614.58119803405, 7749.4575379724, 7783.995857563888, 7792.805179870548, 7898.407619428566, 3612.674859262679, 3705.888823335304, 4229.577042295808, 4308.827646894089, 4381.6494680425485, 2374.786269235777, 3068.47835867903, 3147.7639177061355, 3173.5557022016937, 3254.5118232264876, 639.9840003999938, 657.3722095398882, 658.9209294884548, 666.2338310942455, 673.8147009572407, 522.4227228911998, 560.4087687489738, 593.5696619950587, 603.0110618585524, 649.233903993283, 7388.224236455095, 8193.71322003727, 9236.676716314896, 9365.62537498506, 9396.718098457057, 565.2595100418465, 597.4205021129497, 626.5520153090562, 667.0661074495745, 672.5661948043485, 4327.394164816865, 4380.123975204971, 4491.416115904912, 4503.909921801545, 4606.723596584216, 97617.02382976079, 116143.41928290474, 120836.0, 124700.0, 124985.37507312406, 100381.0, 101222.0, 101401.0, 103469.48265258776, 104555.0, 88409.0, 89626.10373896308, 90932.99999999868, 92194.53902730443, 92353.07646923579, 8619.051904290649, 8863.0, 8887.955560222157, 8966.402100614554, 8967.0, 46129.0, 46323.305150423446, 57315.42684573101, 57624.423755761905, 58794.0, 46844.7657761709, 52415.73792131015, 65423.67288163719, 69595.65202173957, 70938.0, 11026.944865275622, 12051.457684404048, 12725.427355768827, 12751.234925904475, 12994.155379900276, 11897.82153267719, 12718.427670755023, 14160.716785664436, 14335.211563364115, 14820.703585928437, 11788.4695188715, 12371.62885113412, 12511.374431278582, 12631.431585578855, 12939.935300323437, 12779.61661150167, 12888.48446062147, 13269.203847769164, 13293.867061329263, 13358.225258684177, 12665.620031399072, 12817.423215955117, 13159.802602961156, 13210.075294729277, 13768.036237463282, 10498.370097794157, 10715.571377144826, 11226.4386780659, 11312.9434352831, 11456.968872801155, 11253.493592788507, 11338.60314888975, 11549.307041577533, 11588.826167607662, 11594.884051159717], "value": 7140.162501064507, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 115.0, 118.0, 115.0, 115.0, 116.0, 116.0, 117.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 110.0, 142.0, 96.0, 132.0, 146.0, 146.0, 154.0, 111.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 202.0, 196.0, 197.0, 197.0, 195.0, 196.0, 195.0, 200.0, 197.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 61.0, 85.0, 62.0, 61.0, 60.0, 72.0, 70.0, 65.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 88.0, 71.0, 72.0, 70.0, 87.0, 69.0, 72.0, 95.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 113.0, 131.0, 99.0, 87.0, 88.0, 101.0, 88.0, 85.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 119.0, 97.0, 95.0, 95.0, 97.0, 101.0, 95.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 78.0, 122.0, 79.0, 120.0, 93.0, 89.0, 140.0, 131.0, 142.0], "value": 108.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 60.0, 60.0, 61.0, 62.0, 77.0, 92.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 71.0, 77.0, 77.0, 76.0, 71.0, 73.0, 72.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 109.0, 76.0, 97.0, 105.0, 105.0, 108.0, 101.0, 87.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 151.0, 125.0, 152.0, 159.0, 163.0, 145.0, 155.0, 222.0, 162.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 158.0, 240.0, 236.0, 206.0, 167.0, 166.0, 164.0, 165.0, 169.0], "value": 186.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 60.0, 59.0, 62.0, 63.0, 58.0, 58.0, 81.0, 83.0], "value": 65.7, "unit": "score"}]}]} 10:43:58 INFO - Return code: 0 10:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:43:58 ERROR - # TBPL SUCCESS # 10:43:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:43:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:43:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:43:58 INFO - 2017-01-03 10:43:58.955 screenresolution[1663:10979] starting screenresolution argv=screenresolution get 10:43:58 INFO - 2017-01-03 10:43:58.957 screenresolution[1663:10979] Display 0: 1600x1200x32@60 10:43:58 INFO - 2017-01-03 10:43:58.964 screenresolution[1664:10982] starting screenresolution argv=screenresolution list 10:43:58 INFO - Available Modes on Display 0 10:43:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:43:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:43:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:43:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:43:59 INFO - Intel Iris: 10:43:59 INFO - Chipset Model: Intel Iris 10:43:59 INFO - Type: GPU 10:43:59 INFO - Bus: Built-In 10:43:59 INFO - VRAM (Dynamic, Max): 1536 MB 10:43:59 INFO - Vendor: Intel (0x8086) 10:43:59 INFO - Device ID: 0x0a2e 10:43:59 INFO - Revision ID: 0x0009 10:43:59 INFO - Displays: 10:43:59 INFO - Display: 10:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:43:59 INFO - Display Serial Number: 1600x1200 60 10:43:59 INFO - Main Display: Yes 10:43:59 INFO - Mirror: Off 10:43:59 INFO - Online: Yes 10:43:59 INFO - Rotation: Supported 10:43:59 INFO - Return code: 0 10:43:59 INFO - Running post-action listener: _resource_record_post_action 10:43:59 INFO - [mozharness: 2017-01-03 18:43:59.208340Z] Finished run-tests step (success) 10:43:59 INFO - Running post-run listener: _resource_record_post_run 10:43:59 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 34439680; Write bytes: 656325632; Read time: 316; Write time: 1929 10:43:59 INFO - TinderboxPrint: CPU usage
54.1% 10:43:59 INFO - TinderboxPrint: I/O read bytes / time
34,439,680 / 316 10:43:59 INFO - TinderboxPrint: I/O write bytes / time
656,325,632 / 1,929 10:43:59 INFO - TinderboxPrint: CPU idle
2,216.6 (45.9%) 10:43:59 INFO - TinderboxPrint: CPU system
974.6 (20.2%) 10:43:59 INFO - TinderboxPrint: CPU user
1,642.5 (34.0%) 10:43:59 INFO - TinderboxPrint: Swap in / out
379,850,752 / 0 10:43:59 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 348301824; Write bytes: 345638912; Read time: 26778; Write time: 682 10:43:59 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30155264; Write bytes: 303412224; Read time: 286; Write time: 1218 10:43:59 INFO - Running post-run listener: _upload_blobber_files 10:43:59 INFO - Blob upload gear active. 10:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:43:59 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 10:43:59 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'] 10:43:59 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 10:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:01 INFO - (blobuploader) - INFO - Done attempting. 10:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:02 INFO - (blobuploader) - INFO - Done attempting. 10:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:44:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:44:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:44:04 INFO - (blobuploader) - INFO - Done attempting. 10:44:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:44:04 INFO - Return code: 0 10:44:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:44:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:44:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a058b4dbfef61d0eff5b547c06bfef3049a32f77a00b5235ac4470a12d11f8144a2b71280a63bebf53b6ff7df28c3da4b5009f32c28c00a209d29a9fb39f3471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c582f0a148ac7163b6b9850b4e513605f234af8a0f738923a30936a0498844fba6ec0b1bdae8bdea321c00ffeba74528e8bdbf9016b7a5c90840f6fdac6b839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f9519d9c96d0ec9358c8ec87d1c32bf309b8b54f7e06b6b0beabea82ef9c82295466ac83768e5c8dc6121e9034e19318e60b1c9233e966cd82b7f81be34be72"} 10:44:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:44:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:44:04 INFO - Contents: 10:44:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a058b4dbfef61d0eff5b547c06bfef3049a32f77a00b5235ac4470a12d11f8144a2b71280a63bebf53b6ff7df28c3da4b5009f32c28c00a209d29a9fb39f3471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c582f0a148ac7163b6b9850b4e513605f234af8a0f738923a30936a0498844fba6ec0b1bdae8bdea321c00ffeba74528e8bdbf9016b7a5c90840f6fdac6b839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f9519d9c96d0ec9358c8ec87d1c32bf309b8b54f7e06b6b0beabea82ef9c82295466ac83768e5c8dc6121e9034e19318e60b1c9233e966cd82b7f81be34be72"} 10:44:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:44:04 INFO - Copying logs to upload dir... 10:44:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:44:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.200600 ========= master_lag: 2.69 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-03 10:44:07.209974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:07.211229) ========= 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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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/a058b4dbfef61d0eff5b547c06bfef3049a32f77a00b5235ac4470a12d11f8144a2b71280a63bebf53b6ff7df28c3da4b5009f32c28c00a209d29a9fb39f3471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c582f0a148ac7163b6b9850b4e513605f234af8a0f738923a30936a0498844fba6ec0b1bdae8bdea321c00ffeba74528e8bdbf9016b7a5c90840f6fdac6b839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f9519d9c96d0ec9358c8ec87d1c32bf309b8b54f7e06b6b0beabea82ef9c82295466ac83768e5c8dc6121e9034e19318e60b1c9233e966cd82b7f81be34be72"} build_url:https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010387 build_url: 'https://queue.taskcluster.net/v1/task/aF3LurOET0apXm7P4FTt2Q/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/a058b4dbfef61d0eff5b547c06bfef3049a32f77a00b5235ac4470a12d11f8144a2b71280a63bebf53b6ff7df28c3da4b5009f32c28c00a209d29a9fb39f3471", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c582f0a148ac7163b6b9850b4e513605f234af8a0f738923a30936a0498844fba6ec0b1bdae8bdea321c00ffeba74528e8bdbf9016b7a5c90840f6fdac6b839", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f9519d9c96d0ec9358c8ec87d1c32bf309b8b54f7e06b6b0beabea82ef9c82295466ac83768e5c8dc6121e9034e19318e60b1c9233e966cd82b7f81be34be72"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:07.253079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:07.253434) ========= 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.ySy4zfTgN0/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.AtRYZa4oYi/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005120 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-03 10:44:07.301930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 10:44:07.302259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-03 10:44:07.856414) ========= ========= Total master_lag: 2.83 =========