builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1485973250.71 results: success (0) buildid: 20170201074109 builduid: e435f4adfb3a4a929de186600de872fb revision: 44777332a82750e2440b88f61a8db6b463377665 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.710401) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.710815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.711085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.738750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.739015) ========= 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.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-02-01 10:20:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2017-02-01 10:20:50 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.895507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.895814) ========= 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.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.025268 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:50.947010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 10:20:50.950402) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44777332a82750e2440b88f61a8db6b463377665 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 44777332a82750e2440b88f61a8db6b463377665 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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-02-01 10:20:51,058 truncating revision to first 12 chars 2017-02-01 10:20:51,058 Setting DEBUG logging. 2017-02-01 10:20:51,058 attempt 1/10 2017-02-01 10:20:51,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/44777332a827?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 10:20:52,829 unpacking tar archive at: mozilla-beta-44777332a827/testing/mozharness/ program finished with exit code 0 elapsedTime=2.049049 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-01 10:20:53.025908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:53.026319) ========= script_repo_revision: 44777332a82750e2440b88f61a8db6b463377665 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:53.026708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:53.026973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 10:20:53.046254) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 10:20:53.046534) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:20:53 INFO - MultiFileLogger online at 20170201 10:20:53 in /builds/slave/test 10:20:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:20:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:53 INFO - {'append_to_log': False, 10:20:53 INFO - 'base_work_dir': '/builds/slave/test', 10:20:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:20:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:53 INFO - 'branch': 'Mozilla-Beta', 10:20:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:53 INFO - 'config_files': ('talos/mac_config.py',), 10:20:53 INFO - 'default_actions': ('clobber', 10:20:53 INFO - 'read-buildbot-config', 10:20:53 INFO - 'download-and-extract', 10:20:53 INFO - 'populate-webroot', 10:20:53 INFO - 'create-virtualenv', 10:20:53 INFO - 'install', 10:20:53 INFO - 'run-tests'), 10:20:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:53 INFO - 'download_minidump_stackwalk': True, 10:20:53 INFO - 'download_symbols': 'ondemand', 10:20:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:53 INFO - 'installer_path': 'installer.exe', 10:20:53 INFO - 'log_level': 'info', 10:20:53 INFO - 'log_name': 'talos', 10:20:53 INFO - 'log_to_console': True, 10:20:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:20:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:20:53 INFO - 'opt_config_files': (), 10:20:53 INFO - 'pip_index': False, 10:20:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:20:53 INFO - 'cmd': ('bash', 10:20:53 INFO - '-c', 10:20:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:20:53 INFO - 'enabled': True, 10:20:53 INFO - 'halt_on_failure': False, 10:20:53 INFO - 'name': 'check_screen_resolution'},), 10:20:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:20:53 INFO - 'cmd': ('bash', 10:20:53 INFO - '-c', 10:20:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:20:53 INFO - 'enabled': True, 10:20:53 INFO - 'halt_on_failure': False, 10:20:53 INFO - 'name': 'check_screen_resolution'},), 10:20:53 INFO - 'run_cmd_checks_enabled': True, 10:20:53 INFO - 'sps_profile': False, 10:20:53 INFO - 'sps_profile_interval': 0, 10:20:53 INFO - 'suite': 'dromaeojs-e10s', 10:20:53 INFO - 'system_bits': '32', 10:20:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:53 INFO - 'title': 't-yosemite-r7-0220', 10:20:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:53 INFO - 'use_talos_json': True, 10:20:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:53 INFO - 'work_dir': 'build'} 10:20:53 INFO - [mozharness: 2017-02-01 18:20:53.264009Z] Running clobber step. 10:20:53 INFO - Running pre-action listener: _resource_record_pre_action 10:20:53 INFO - Running main action method: clobber 10:20:53 INFO - rmtree: /builds/slave/test/build 10:20:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:55 INFO - Running post-action listener: _resource_record_post_action 10:20:55 INFO - [mozharness: 2017-02-01 18:20:55.636494Z] Finished clobber step (success) 10:20:55 INFO - [mozharness: 2017-02-01 18:20:55.636797Z] Running read-buildbot-config step. 10:20:55 INFO - Running pre-action listener: _resource_record_pre_action 10:20:55 INFO - Running main action method: read_buildbot_config 10:20:55 INFO - Using buildbot properties: 10:20:55 INFO - { 10:20:55 INFO - "project": "", 10:20:55 INFO - "product": "firefox", 10:20:55 INFO - "script_repo_revision": "production", 10:20:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:20:55 INFO - "repository": "", 10:20:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:20:55 INFO - "buildid": "20170201074109", 10:20:55 INFO - "pgo_build": "False", 10:20:55 INFO - "basedir": "/builds/slave/test", 10:20:55 INFO - "buildnumber": 3, 10:20:55 INFO - "slavename": "t-yosemite-r7-0220", 10:20:55 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:20:55 INFO - "platform": "yosemite_r7", 10:20:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:20:55 INFO - "branch": "mozilla-beta", 10:20:55 INFO - "repo_path": "releases/mozilla-beta", 10:20:55 INFO - "revision": "44777332a82750e2440b88f61a8db6b463377665", 10:20:55 INFO - "stage_platform": "macosx64", 10:20:55 INFO - "builduid": "e435f4adfb3a4a929de186600de872fb", 10:20:55 INFO - "slavebuilddir": "test" 10:20:55 INFO - } 10:20:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:20:55 INFO - Running post-action listener: _resource_record_post_action 10:20:55 INFO - [mozharness: 2017-02-01 18:20:55.640795Z] Finished read-buildbot-config step (success) 10:20:55 INFO - [mozharness: 2017-02-01 18:20:55.640914Z] Running download-and-extract step. 10:20:55 INFO - Running pre-action listener: _resource_record_pre_action 10:20:55 INFO - Running main action method: download_and_extract 10:20:55 INFO - mkdir: /builds/slave/test/build/tests 10:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:55 INFO - trying https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:20:55 INFO - Downloading https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 10:20:56 INFO - Downloaded 1165 bytes. 10:20:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:20:56 INFO - Using the following test package requirements: 10:20:56 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:20:56 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:20:56 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:20:56 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:20:56 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:20:56 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:20:56 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:20:56 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:20:56 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:20:56 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:20:56 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:20:56 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:20:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:20:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:20:56 INFO - Fetch https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:20:57 INFO - Http code: 200 10:20:57 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:20:57 INFO - x-amz-cf-id: k_vt8bPb1mJDbPV1b1qeYG11kpLs8l3tF_Xfa0B4NYaellnPC2mBkQ== 10:20:57 INFO - x-amz-version-id: E4Ktm60NN5YJLopkA4FGY5VIMvr6O6Y. 10:20:57 INFO - Expected file size: 16090565 10:20:57 INFO - Obtained file size: 16090565 10:21:04 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:21:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:21:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:21:04 INFO - Fetch https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:21:05 INFO - Http code: 200 10:21:05 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 10:21:05 INFO - x-amz-cf-id: mFnPkN4DjT85MeLK_xtmbzV-unl85j0MjSAghlaDXHG2VAy3hzyXAg== 10:21:05 INFO - x-amz-version-id: E4Ktm60NN5YJLopkA4FGY5VIMvr6O6Y. 10:21:05 INFO - Expected file size: 16090565 10:21:05 INFO - Obtained file size: 16090565 10:21:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:21:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:21:11 INFO - Fetch https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:21:12 INFO - Http code: 200 10:21:12 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 10:21:12 INFO - x-amz-cf-id: fHsRXkFvrvuI9KhRYQxEFxBRFngijrDB9j85-QCthYwJY5mGtTgPMA== 10:21:12 INFO - x-amz-version-id: mg1k6M01XUc64TknUN2y2PWt3h.btEPn 10:21:12 INFO - Expected file size: 14403005 10:21:12 INFO - Obtained file size: 14403005 10:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:12 INFO - trying https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:21:12 INFO - Downloading https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:21:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 10:21:15 INFO - Downloaded 82136604 bytes. 10:21:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:21:15 INFO - mkdir: /builds/slave/test/properties 10:21:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:21:15 INFO - Writing to file /builds/slave/test/properties/build_url 10:21:15 INFO - Contents: 10:21:15 INFO - build_url:https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:21:15 INFO - Running post-action listener: _resource_record_post_action 10:21:15 INFO - Running post-action listener: set_extra_try_arguments 10:21:15 INFO - [mozharness: 2017-02-01 18:21:15.758557Z] Finished download-and-extract step (success) 10:21:15 INFO - [mozharness: 2017-02-01 18:21:15.758718Z] Running populate-webroot step. 10:21:15 INFO - Running pre-action listener: _resource_record_pre_action 10:21:15 INFO - Running main action method: populate_webroot 10:21:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:21:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:21:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:21:15 INFO - '--tppagecycles', 10:21:15 INFO - '7'], 10:21:15 INFO - 'tests': ['tsvgm']}}, 10:21:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:21:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:21:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:21:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:21:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:21:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['damp', 'tps']}, 10:21:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'tests': ['damp', 'tps']}, 10:21:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['dromaeo_dom']}, 10:21:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:21:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['basic_compositor_video']}, 10:21:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:21:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'other-e10s': {'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['a11yr', 10:21:15 INFO - 'ts_paint', 10:21:15 INFO - 'tpaint', 10:21:15 INFO - 'sessionrestore', 10:21:15 INFO - 'sessionrestore_no_auto_restore', 10:21:15 INFO - 'tabpaint']}, 10:21:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['tsvgx', 10:21:15 INFO - 'tsvgr_opacity', 10:21:15 INFO - 'tart', 10:21:15 INFO - 'tscrollx', 10:21:15 INFO - 'cart']}, 10:21:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:21:15 INFO - 'tsvgr_opacity', 10:21:15 INFO - 'tart', 10:21:15 INFO - 'tscrollx', 10:21:15 INFO - 'cart']}, 10:21:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'talos_options': ['--disable-e10s'], 10:21:15 INFO - 'tests': ['tp5o']}, 10:21:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'tests': ['tp5o']}, 10:21:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'talos_options': ['--disable-e10s', 10:21:15 INFO - '--xperf_path', 10:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:15 INFO - 'tests': ['tp5n']}, 10:21:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:21:15 INFO - 'talos_options': ['--xperf_path', 10:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:21:15 INFO - 'tests': ['tp5n']}}, 10:21:15 INFO - 'talos.zip': {'path': '', 10:21:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:21:15 INFO - Running post-action listener: _resource_record_post_action 10:21:15 INFO - [mozharness: 2017-02-01 18:21:15.777354Z] Finished populate-webroot step (success) 10:21:15 INFO - [mozharness: 2017-02-01 18:21:15.777464Z] Running create-virtualenv step. 10:21:15 INFO - Running pre-action listener: _resource_record_pre_action 10:21:15 INFO - Running main action method: create_virtualenv 10:21:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:21:15 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:21:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:21:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:21:15 INFO - Using real prefix '/tools/python27' 10:21:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:21:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:21:19 INFO - Installing pip.................done. 10:21:19 INFO - Return code: 0 10:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:21:19 INFO - Reading from file tmpfile_stdout 10:21:19 INFO - Output received: 10:21:19 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:21:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:19 INFO - 'HOME': '/Users/cltbld', 10:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:19 INFO - 'LOGNAME': 'cltbld', 10:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:19 INFO - 'MOZ_NO_REMOTE': '1', 10:21:19 INFO - 'NO_EM_RESTART': '1', 10:21:19 INFO - 'PAGER': '/bin/cat', 10:21:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:19 INFO - 'PWD': '/builds/slave/test', 10:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:19 INFO - 'SHELL': '/bin/bash', 10:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:19 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:19 INFO - 'USER': 'cltbld', 10:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:19 INFO - 'XPC_FLAGS': '0x0', 10:21:19 INFO - 'XPC_SERVICE_NAME': '0', 10:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:20 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:21:20 INFO - Cleaning up... 10:21:20 INFO - Return code: 0 10:21:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:20 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:20 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:21:20 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:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:20 INFO - 'HOME': '/Users/cltbld', 10:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:20 INFO - 'LOGNAME': 'cltbld', 10:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:20 INFO - 'MOZ_NO_REMOTE': '1', 10:21:20 INFO - 'NO_EM_RESTART': '1', 10:21:20 INFO - 'PAGER': '/bin/cat', 10:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:20 INFO - 'PWD': '/builds/slave/test', 10:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:20 INFO - 'SHELL': '/bin/bash', 10:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:20 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:20 INFO - 'USER': 'cltbld', 10:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:20 INFO - 'XPC_FLAGS': '0x0', 10:21:20 INFO - 'XPC_SERVICE_NAME': '0', 10:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:20 INFO - Downloading/unpacking psutil>=3.1.1 10:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:20 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:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:21:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:23 INFO - Installing collected packages: psutil 10:21:23 INFO - Running setup.py install for psutil 10:21:23 INFO - building 'psutil._psutil_osx' extension 10:21:23 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:21:24 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:21:24 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:21:24 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:21:24 INFO - building 'psutil._psutil_posix' extension 10:21:24 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:21:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:21:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:21:24 INFO - ^ 10:21:24 INFO - 1 warning generated. 10:21:24 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:21:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:21:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:21:24 INFO - Successfully installed psutil 10:21:24 INFO - Cleaning up... 10:21:25 INFO - Return code: 0 10:21:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:25 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:25 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:21:25 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:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:25 INFO - 'HOME': '/Users/cltbld', 10:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:25 INFO - 'LOGNAME': 'cltbld', 10:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:25 INFO - 'MOZ_NO_REMOTE': '1', 10:21:25 INFO - 'NO_EM_RESTART': '1', 10:21:25 INFO - 'PAGER': '/bin/cat', 10:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:25 INFO - 'PWD': '/builds/slave/test', 10:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:25 INFO - 'SHELL': '/bin/bash', 10:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:25 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:25 INFO - 'USER': 'cltbld', 10:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:25 INFO - 'XPC_FLAGS': '0x0', 10:21:25 INFO - 'XPC_SERVICE_NAME': '0', 10:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:21:28 INFO - Installing collected packages: mozsystemmonitor 10:21:28 INFO - Running setup.py install for mozsystemmonitor 10:21:28 INFO - Successfully installed mozsystemmonitor 10:21:28 INFO - Cleaning up... 10:21:28 INFO - Return code: 0 10:21:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:21:28 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:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 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:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:28 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:28 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:21:28 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:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:28 INFO - 'HOME': '/Users/cltbld', 10:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:28 INFO - 'LOGNAME': 'cltbld', 10:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:28 INFO - 'MOZ_NO_REMOTE': '1', 10:21:28 INFO - 'NO_EM_RESTART': '1', 10:21:28 INFO - 'PAGER': '/bin/cat', 10:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:28 INFO - 'PWD': '/builds/slave/test', 10:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:28 INFO - 'SHELL': '/bin/bash', 10:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:28 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:28 INFO - 'USER': 'cltbld', 10:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:28 INFO - 'XPC_FLAGS': '0x0', 10:21:28 INFO - 'XPC_SERVICE_NAME': '0', 10:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:28 INFO - Downloading/unpacking jsonschema==2.5.1 10:21:28 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:21:28 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:21:28 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:21:28 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:21:28 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:21:28 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:21:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:21:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:21:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:31 INFO - warning: no files found matching '*.txt' 10:21:31 INFO - no previously-included directories found matching 'build' 10:21:31 INFO - no previously-included directories found matching 'dist' 10:21:31 INFO - no previously-included directories found matching '.git*' 10:21:31 INFO - Installing collected packages: jsonschema, functools32 10:21:31 INFO - Running setup.py install for functools32 10:21:31 INFO - warning: no files found matching '*.txt' 10:21:31 INFO - no previously-included directories found matching 'build' 10:21:31 INFO - no previously-included directories found matching 'dist' 10:21:31 INFO - no previously-included directories found matching '.git*' 10:21:31 INFO - Successfully installed jsonschema functools32 10:21:31 INFO - Cleaning up... 10:21:31 INFO - Return code: 0 10:21:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:31 INFO - 'HOME': '/Users/cltbld', 10:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:31 INFO - 'LOGNAME': 'cltbld', 10:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:31 INFO - 'MOZ_NO_REMOTE': '1', 10:21:31 INFO - 'NO_EM_RESTART': '1', 10:21:31 INFO - 'PAGER': '/bin/cat', 10:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:31 INFO - 'PWD': '/builds/slave/test', 10:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:31 INFO - 'SHELL': '/bin/bash', 10:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:31 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:31 INFO - 'USER': 'cltbld', 10:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:31 INFO - 'XPC_FLAGS': '0x0', 10:21:31 INFO - 'XPC_SERVICE_NAME': '0', 10:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:21:32 INFO - Cleaning up... 10:21:32 INFO - Return code: 0 10:21:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:32 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:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:32 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:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:32 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:32 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:21:32 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:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:32 INFO - 'HOME': '/Users/cltbld', 10:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:32 INFO - 'LOGNAME': 'cltbld', 10:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:32 INFO - 'MOZ_NO_REMOTE': '1', 10:21:32 INFO - 'NO_EM_RESTART': '1', 10:21:32 INFO - 'PAGER': '/bin/cat', 10:21:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:32 INFO - 'PWD': '/builds/slave/test', 10:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:32 INFO - 'SHELL': '/bin/bash', 10:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:32 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:32 INFO - 'USER': 'cltbld', 10:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:32 INFO - 'XPC_FLAGS': '0x0', 10:21:32 INFO - 'XPC_SERVICE_NAME': '0', 10:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:32 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:36 INFO - Downloading docopt-0.6.1.tar.gz 10:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:36 INFO - Running setup.py install for blobuploader 10:21:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:36 INFO - Running setup.py install for requests 10:21:37 INFO - Running setup.py install for docopt 10:21:37 INFO - Successfully installed blobuploader requests docopt 10:21:37 INFO - Cleaning up... 10:21:37 INFO - Return code: 0 10:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:37 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:37 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:21:37 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:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:37 INFO - 'HOME': '/Users/cltbld', 10:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:37 INFO - 'LOGNAME': 'cltbld', 10:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:37 INFO - 'MOZ_NO_REMOTE': '1', 10:21:37 INFO - 'NO_EM_RESTART': '1', 10:21:37 INFO - 'PAGER': '/bin/cat', 10:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:37 INFO - 'PWD': '/builds/slave/test', 10:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:37 INFO - 'SHELL': '/bin/bash', 10:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:37 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:37 INFO - 'USER': 'cltbld', 10:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:37 INFO - 'XPC_FLAGS': '0x0', 10:21:37 INFO - 'XPC_SERVICE_NAME': '0', 10:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:37 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-A7QBJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:37 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9d2v1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:37 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-7PoSVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-DNt6ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-douFF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-HIA4kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hqeZ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zdl93c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-anzgoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gHk4Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qJwWUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-0WzaHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:38 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VbMRPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-StXuub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-axCsm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SDB6M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:39 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-bgYdH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:39 INFO - Running setup.py install for manifestparser 10:21:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:39 INFO - Running setup.py install for mozcrash 10:21:39 INFO - Running setup.py install for mozdebug 10:21:39 INFO - Running setup.py install for mozdevice 10:21:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Running setup.py install for mozfile 10:21:40 INFO - Running setup.py install for mozhttpd 10:21:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Running setup.py install for mozinfo 10:21:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Running setup.py install for mozInstall 10:21:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:40 INFO - Running setup.py install for mozleak 10:21:40 INFO - Running setup.py install for mozlog 10:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Running setup.py install for moznetwork 10:21:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Running setup.py install for mozprocess 10:21:41 INFO - Running setup.py install for mozprofile 10:21:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Running setup.py install for mozrunner 10:21:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:41 INFO - Running setup.py install for mozscreenshot 10:21:41 INFO - Running setup.py install for moztest 10:21:41 INFO - Running setup.py install for mozversion 10:21:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:42 INFO - Cleaning up... 10:21:42 INFO - Return code: 0 10:21:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:42 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:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:42 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:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:42 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:42 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:21:42 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:21:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:42 INFO - 'HOME': '/Users/cltbld', 10:21:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:42 INFO - 'LOGNAME': 'cltbld', 10:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:42 INFO - 'MOZ_NO_REMOTE': '1', 10:21:42 INFO - 'NO_EM_RESTART': '1', 10:21:42 INFO - 'PAGER': '/bin/cat', 10:21:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:42 INFO - 'PWD': '/builds/slave/test', 10:21:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:42 INFO - 'SHELL': '/bin/bash', 10:21:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:42 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:42 INFO - 'USER': 'cltbld', 10:21:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:42 INFO - 'XPC_FLAGS': '0x0', 10:21:42 INFO - 'XPC_SERVICE_NAME': '0', 10:21:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XUBPOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9XHKpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-YGAPsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TxWjWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RPTqRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZQdFmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:42 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:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:42 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-GmLYet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-IriJ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-v6khP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KGCGpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MkUnUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-yjoZGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1Hxoy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-PXQsGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VtDuax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:43 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:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:43 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-z6ABcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:44 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:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:44 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gvrApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:44 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:21:44 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:21:44 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:21:44 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:21:44 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:21:44 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:21:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:44 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:21:44 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:21:44 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:21:44 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:21:44 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:21:44 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:21:47 INFO - Downloading blessings-1.6.tar.gz 10:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:47 INFO - Installing collected packages: blessings 10:21:47 INFO - Running setup.py install for blessings 10:21:47 INFO - Successfully installed blessings 10:21:47 INFO - Cleaning up... 10:21:47 INFO - Return code: 0 10:21:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:47 INFO - Reading from file tmpfile_stdout 10:21:47 INFO - Current package versions: 10:21:47 INFO - blessings == 1.6 10:21:47 INFO - blobuploader == 1.2.4 10:21:47 INFO - docopt == 0.6.1 10:21:47 INFO - functools32 == 3.2.3-2 10:21:47 INFO - jsonschema == 2.5.1 10:21:47 INFO - manifestparser == 1.1 10:21:47 INFO - mozInstall == 1.12 10:21:47 INFO - mozcrash == 1.0 10:21:47 INFO - mozdebug == 0.1 10:21:47 INFO - mozdevice == 0.48 10:21:47 INFO - mozfile == 1.2 10:21:47 INFO - mozhttpd == 0.7 10:21:47 INFO - mozinfo == 0.9 10:21:47 INFO - mozleak == 0.1 10:21:47 INFO - mozlog == 3.4 10:21:47 INFO - moznetwork == 0.27 10:21:47 INFO - mozprocess == 0.23 10:21:47 INFO - mozprofile == 0.28 10:21:47 INFO - mozrunner == 6.13 10:21:47 INFO - mozscreenshot == 0.1 10:21:47 INFO - mozsystemmonitor == 0.3 10:21:47 INFO - moztest == 0.8 10:21:47 INFO - mozversion == 1.4 10:21:47 INFO - psutil == 3.1.1 10:21:47 INFO - requests == 1.2.3 10:21:47 INFO - wsgiref == 0.1.2 10:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:48 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:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:48 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:48 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:21:48 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:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:48 INFO - 'HOME': '/Users/cltbld', 10:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:48 INFO - 'LOGNAME': 'cltbld', 10:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:48 INFO - 'MOZ_NO_REMOTE': '1', 10:21:48 INFO - 'NO_EM_RESTART': '1', 10:21:48 INFO - 'PAGER': '/bin/cat', 10:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:48 INFO - 'PWD': '/builds/slave/test', 10:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:48 INFO - 'SHELL': '/bin/bash', 10:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:48 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:48 INFO - 'USER': 'cltbld', 10:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:48 INFO - 'XPC_FLAGS': '0x0', 10:21:48 INFO - 'XPC_SERVICE_NAME': '0', 10:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 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:21:48 INFO - Cleaning up... 10:21:48 INFO - Return code: 0 10:21:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21:48 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:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:48 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:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:48 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 0x10da2d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95484c37c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, '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.pe32yXN346/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.weL8oNCvtC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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:21:48 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:21:48 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:21:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:21:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:21:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:21:48 INFO - 'HOME': '/Users/cltbld', 10:21:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:21:48 INFO - 'LOGNAME': 'cltbld', 10:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:48 INFO - 'MOZ_NO_REMOTE': '1', 10:21:48 INFO - 'NO_EM_RESTART': '1', 10:21:48 INFO - 'PAGER': '/bin/cat', 10:21:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:48 INFO - 'PWD': '/builds/slave/test', 10:21:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:21:48 INFO - 'SHELL': '/bin/bash', 10:21:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:21:48 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:21:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:21:48 INFO - 'USER': 'cltbld', 10:21:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:21:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:48 INFO - 'XPC_FLAGS': '0x0', 10:21:48 INFO - 'XPC_SERVICE_NAME': '0', 10:21:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:21:48 INFO - Cleaning up... 10:21:48 INFO - Return code: 0 10:21:48 INFO - Running post-action listener: _resource_record_post_action 10:21:48 INFO - Running post-action listener: _start_resource_monitoring 10:21:48 INFO - Starting resource monitoring. 10:21:48 INFO - [mozharness: 2017-02-01 18:21:48.723257Z] Finished create-virtualenv step (success) 10:21:48 INFO - [mozharness: 2017-02-01 18:21:48.724277Z] Running install step. 10:21:48 INFO - Running pre-action listener: _resource_record_pre_action 10:21:48 INFO - Running main action method: install 10:21:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:48 INFO - Reading from file tmpfile_stdout 10:21:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:49 INFO - Reading from file tmpfile_stdout 10:21:49 INFO - Output received: 10:21:49 INFO - Usage: mozinstall [options] installer 10:21:49 INFO - Options: 10:21:49 INFO - -h, --help show this help message and exit 10:21:49 INFO - -d DEST, --destination=DEST 10:21:49 INFO - Directory to install application into. [default: 10:21:49 INFO - "/builds/slave/test"] 10:21:49 INFO - --app=APP Application being installed. [default: firefox] 10:21:49 INFO - mkdir: /builds/slave/test/build/application 10:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:22:10 INFO - Reading from file tmpfile_stdout 10:22:10 INFO - Output received: 10:22:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:22:10 INFO - Running post-action listener: _resource_record_post_action 10:22:10 INFO - [mozharness: 2017-02-01 18:22:10.808774Z] Finished install step (success) 10:22:10 INFO - [mozharness: 2017-02-01 18:22:10.808906Z] Running run-tests step. 10:22:10 INFO - Running pre-action listener: _resource_record_pre_action 10:22:10 INFO - Running main action method: run_tests 10:22:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:22:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:22:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:22:10 INFO - 2017-02-01 10:22:10.823 screenresolution[1625:7428] starting screenresolution argv=screenresolution get 10:22:10 INFO - 2017-02-01 10:22:10.826 screenresolution[1625:7428] Display 0: 1600x1200x32@60 10:22:10 INFO - 2017-02-01 10:22:10.832 screenresolution[1626:7431] starting screenresolution argv=screenresolution list 10:22:10 INFO - Available Modes on Display 0 10:22:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:22:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:22:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:22:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:22:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:22:11 INFO - Intel Iris: 10:22:11 INFO - Chipset Model: Intel Iris 10:22:11 INFO - Type: GPU 10:22:11 INFO - Bus: Built-In 10:22:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:22:11 INFO - Vendor: Intel (0x8086) 10:22:11 INFO - Device ID: 0x0a2e 10:22:11 INFO - Revision ID: 0x0009 10:22:11 INFO - Displays: 10:22:11 INFO - Display: 10:22:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:22:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:22:11 INFO - Display Serial Number: 1600x1200 60 10:22:11 INFO - Main Display: Yes 10:22:11 INFO - Mirror: Off 10:22:11 INFO - Online: Yes 10:22:11 INFO - Rotation: Supported 10:22:11 INFO - Return code: 0 10:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:22:11 INFO - Python 2.7.3 10:22:11 INFO - Return code: 0 10:22:11 INFO - grabbing minidump binary from tooltool 10:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:22:11 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 0x10d841d30>, '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 0x10d6a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d839b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:22:11 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:22:11 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:22:11 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:22:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:22:11 INFO - Return code: 0 10:22:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:22:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:22:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:22:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:22:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pe32yXN346/Render', 10:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:22:11 INFO - 'HOME': '/Users/cltbld', 10:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:22:11 INFO - 'LOGNAME': 'cltbld', 10:22:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:22:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:22:11 INFO - 'MOZ_NO_REMOTE': '1', 10:22:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:22:11 INFO - 'NO_EM_RESTART': '1', 10:22:11 INFO - 'PAGER': '/bin/cat', 10:22:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:22:11 INFO - 'PWD': '/builds/slave/test', 10:22:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:22:11 INFO - 'SHELL': '/bin/bash', 10:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.weL8oNCvtC/Listeners', 10:22:11 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 10:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:22:11 INFO - 'USER': 'cltbld', 10:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:22:11 INFO - 'XPC_FLAGS': '0x0', 10:22:11 INFO - 'XPC_SERVICE_NAME': '0', 10:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:22:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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:22:11 INFO - mozversion application_buildid: 20170201074109 10:22:11 INFO - mozversion application_changeset: 44777332a82750e2440b88f61a8db6b463377665 10:22:11 INFO - mozversion application_display_name: Firefox 10:22:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:22:11 INFO - mozversion application_name: Firefox 10:22:11 INFO - mozversion application_remotingname: firefox 10:22:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:22:11 INFO - mozversion application_vendor: Mozilla 10:22:11 INFO - mozversion application_version: 52.0 10:22:11 INFO - mozversion platform_buildid: 20170201074109 10:22:11 INFO - mozversion platform_changeset: 44777332a82750e2440b88f61a8db6b463377665 10:22:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:22:11 INFO - mozversion platform_version: 52.0 10:22:11 INFO - using testdate: 1485973331 10:22:11 INFO - actual date: 1485973331 10:22:11 INFO - starting webserver on 'localhost:49236' 10:22:11 INFO - SUITE-START | Running 2 tests 10:22:11 INFO - TEST-START | dromaeo_css 10:22:11 INFO - operating with platform_type : mac_ 10:22:11 INFO - Initialising browser for dromaeo_css test... 10:22:11 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpZ2VydF/profile http://localhost:49236/getInfo.html) 10:22:14 INFO - PROCESS | 1636 | 2017-02-01 10:22:14.508 plugin-container[1639:7582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 10:22:14 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:14 INFO - PROCESS | 1636 | 2017-02-01 10:22:14.509 plugin-container[1639:7582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d07, name = 'com.apple.CFPasteboardClient' 10:22:14 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:14 INFO - PROCESS | 1636 | 2017-02-01 10:22:14.509 plugin-container[1639:7582] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:14 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 10:22:14 INFO - PROCESS | 1636 | colorDepth:24 10:22:14 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 10:22:14 INFO - PROCESS | 1636 | __metrics 10:22:14 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:22:15 INFO - TEST-INFO | 1636: exit 0 10:22:15 INFO - Browser initialized. 10:22:15 INFO - Running cycle 1/1 for dromaeo_css test... 10:22:15 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpZ2VydF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:17 INFO - PROCESS | 1640 | 2017-02-01 10:22:17.851 plugin-container[1641:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:22:17 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:17 INFO - PROCESS | 1640 | 2017-02-01 10:22:17.852 plugin-container[1641:7707] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8717, name = 'com.apple.CFPasteboardClient' 10:22:17 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:17 INFO - PROCESS | 1640 | 2017-02-01 10:22:17.852 plugin-container[1641:7707] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:27 INFO - PROCESS | 1640 | RSS: Main: 177483776 10:22:27 INFO - PROCESS | 1640 | 10:25:30 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:25:32 INFO - PROCESS | 1640 | RSS: Main: 181592064 10:25:32 INFO - PROCESS | 1640 | 10:28:34 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:28:34 INFO - PROCESS | 1640 | RSS: Main: 191746048 10:28:34 INFO - PROCESS | 1640 | 10:31:36 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:31:37 INFO - PROCESS | 1640 | RSS: Main: 194936832 10:31:37 INFO - PROCESS | 1640 | 10:34:38 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:34:39 INFO - PROCESS | 1640 | RSS: Main: 198029312 10:34:39 INFO - PROCESS | 1640 | 10:37:42 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:37:43 INFO - PROCESS | 1640 | RSS: Main: 199516160 10:37:43 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:40:45 INFO - PROCESS | 1640 | RSS: Main: 199524352 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | __start_tp_report 10:40:45 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 10:40:45 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 10:40:45 INFO - PROCESS | 1640 | |i|pagename|runs| 10:40:45 INFO - PROCESS | 1640 | |0;dojo.html;3592.874249401271;3595.7303202259836;3618.3486972344986;3621.1671315597428;3632.527771389719;6099.603525770822;6110.236220472435;6197.194364732584;6208.937910620893;6211.3167551569295;5933.13969474427;6081.574289799716;6154.907676384858;6175.320714721377;6217.844553886155;4580.358749775034;5480.862978425552;5481.177823326513;5511.118221084627;5547.77808887644;5530.5022547970675;5531.751071201786;5548.91676624851;5573.860653483675;5615.7472913718775;5421.9457805422035;5427.83716488504;5546.69493177875;5555.8888822223535;5559.749811258483;5444.210589464526;5476.3702174249875;5546.584006199551;5555.666660000373;5612.831615051555;5437.34751829779;5511.641743286674;5525.723713814293;5526.226328314039;5553.750081246313;5899.793507227227;6180.103884936704;6231.376862313732;6231.750729970796;6242.313345531988;6208.937910620881;6231.906521402183;6232.3144454110015;6279.215098112736;6356.110144579762;5362.651427657229;6329.303776584572;6463.385978332051;6467.870642587122;6491.448226900719;5123.38519377677;6144.600600960924;6177.382261773787;6182.196314479089;6200.286966998853;6360.9045864312075;6394.23269207698;6456.160699109179;6461;6492.383223593751;5287.68273903567;6225.3774622537385;6240.063990401385;6283.937160628335;6295.024271237966;6371.299157092716;6375;6419.45434638061;6428.260750013808;6446.387593178641;6165.660888651168;6214.005759078525;6222.12890195373;6231.937680623136;6266.843328916722;6244.75104979006;6323.430891219812;6323.525735569759;6324.272708638474;6380.649064301415;5199.428062913076;5210.452902445264;5225.6603320784025;5232.084385232569;5233.110371236899;4498.460184777848;4585.656075794329;4633.791479383436;4651.953480465152;4730.290456431563;5206.271122042917;6144.986077297196;6239.625622462576;6252.531060170505;6257.812265632038;6501.252355979028;6508.381703738232;6509.381608747161;6525;6544.3782840630065;5092.337996060563;6103.6032657877095;6191.504679625619;6237.937620623827;6240;5810.941890581124;5818.5636077294375;5819.6508209507565;5833.445822646841;5856.6486010838635;6462.127612772216;6729.360710732472;6744.5616034957575;6770.627615481098;6783.457323414016;6229.657368844757;6366.904496432465;6370.490360771035;6413.390727880844;6532.510061745293;6683.097781799589;6720.395164435225;6728.192616886005;6747.156605424322;6752.93247067523;6414.422701956846;6414.647194404352;6428.871422571428;6429.2284925807335;6435.259945106185;4659.114768194032;6064.3935606439;6373.490120790419;6459.354064593503;6497.382748638872;6150.200473938359;6325.652089135142;6328;6331.493480521639;6376.202974628171;5248.291480650063;6284.937150628435;6293.276273228637;6303;6305.1172835803945;5706.714664266853;6169.81490555284;6189.071639254148;6198.783042593487;6239.126522286974;6216.53375996793;6223.159873417031;6227.813165605039;6324.051392291193;6332.968335158294;6194.4115309045565;6254.781082662085;6256.124142619946;6259.123722678738;6281.52888533371 10:40:45 INFO - PROCESS | 1640 | |1;ext.html;468.20872725094586;534.5376249544146;549.447804956019;565.3442007271564;575.4648177195212;38162.04594885126;40926.976825579375;41015.38476922848;41076.38385424221;41209.79395103024;33658.32683346332;41605.95985100374;42274.15451690964;42284.57715422845;42298.57701422985;9543.47510886901;9654.903450965507;9698.563564639608;9726.027397260288;9761.658341958033;9697.95151024244;9713.805723885518;9757.121859032686;9819.312648114636;9825.263105267099;9798.559064842098;9804.215662747;9805.215582753362;9843.114119729224;9854.852177217348;9726.17327527161;9790.657326993593;9799.216062714966;9802.950985245065;9815.705528834147;9588.041195880425;9632.662856800049;9634.373765705206;9671;9694.982026887146;39834;39878.20243595141;40176;40264.79867600673;40284.798576007226;3592.9640703593154;3609.205974685565;4012.819423125937;4121.876343709693;4164.68764842635;27650;30018.099457016324;30395.69604303951;31078.378432431226;31518.920691059746;3241.773075884689;3323.567936168307;3329.8335083245743;3381.7970921744773;3384.5938487381427;483698;486515;489153;489198;490438;60061.498462537915;60139.398606014256;60173.39826601678;60342.69828650916;60509.39490605125;61469.770604587655;61925;61964.380356196765;62064;62336.68831655903;16408.26162822676;16618;16718.080505572067;16730.330786768394;16735.246913888903;12917.418716157796;13009.089363744448;13099.148555343872;13119.475220991053;13149.474021039052;14583.98254908067;15314.846851531565;15821;15842.28709708066;15926.601834953986;5245.475452454801;6143.84640383994;6158.291796443466;6206.968965155145;6233.688315584202;921.8847644044495;993.7118235711707;1057.4871187474068;1092.4810714910354;1103.6964834670368;26700.866495667397;30542.38915221683;30781.076567703003;31183.688163118077;31279;1002.4486532407146;1038.6883934819523;1160.158884808524;1169.5146514196683;1185.3421351150023;14467;15984.680306394039;16035.839641603668;16112.516624501284;16137.35450581987;668912;672040;672768;673515;673955;59268.70365648231;59299.40700592939;59341.10988335178;59437;59490.70254648699;1389.715108402775;1401.7266633006466;1413.3639862061907;1423.309694798022;1428.4429072661671;27329.726702732718;28180.71819281781;29418.852905735333;30245.546316804826;30397;38520.61479385282;46713.76643116899;50408;50549;50656.746716266185;555438;608125.918740807;609711;610795;611953;36611.084722882144;38058;40500.39249411202;41579.79210104051;42150.78924605357;37763.81118094392;44064.55935440605;44954.77522612366;47128;48623.75688121537;38832.61167388403;39458.2108357837;39476.80261598789;39776.60223397729;40852.79573602113;38417.4237386445;38814.4474221028;39299.41050884182;39733.80133099432;39885.80913526853;38548.229035418575;38752.80623596864;39338;39549.80225098856;40704.18591628092;32038.35923281568;34866;34902.30195396027;35161;35271.470927936614;24602;26141.73858261393;26362.736372636027;26366.674624015646;26500.867495662398 10:40:45 INFO - PROCESS | 1640 | |2;jquery.html;386.28537206168573;388.83085857651906;389.93176194166017;397.6739073959354;419.31232778243685;16279;19223.423297301088;20202.797972020275;20587.588248235046;20604.89697551512;20171;20362.490937726565;20436;20793.75237485752;20947.895260523714;5781.682007489587;6017.518598512131;6059.030555111183;6061.545384096188;6084.969575152118;5825;5905.822825315247;6026.819195424145;6048.304444988817;6115.082737589352;5802.158686990384;5894.4989675877605;5905.084711869667;5914.733836977346;5926.585139040269;4758.45277793053;5747.482726554609;5838.854028649275;5907.379725128864;5919.792807251725;5108.974455127738;5204.167333226704;5217.739113044333;5218.243354713545;5223.347081614798;24676.383090422703;24706.382340441454;24711.752882471126;25106;25302.746972530407;2257.3228031590456;2307.48081681622;2525.4696513732138;2531.974680253211;2561.2956436979794;15054.849451505454;15689.921550392175;15692.921535392365;15742.291596878167;16048.27782749779;1857.572758265593;1917.5685470769106;1946.4113974197444;1975.446874875023;1992.7110568967419;111027;115511;116511.4174429131;119408;123415.14877276849;9566.665166719271;11896.76206475883;12023.63929082129;12031.939840300742;12157.08821838348;13585.320733963263;14201.502947396792;14842.03526770778;15199.240037998277;15204.315805788767;7333.706651733871;7810.570418626917;8713.782155446037;8924.955375223211;8996.235319997873;8653.39426240157;8751.824963500694;8787.384883058125;8906.55467226636;8909.1536304051;4176.206520761046;4601.803531081943;4607.976960115178;4695.272232803921;4757.09615173116;1749.4167778160786;1804.4316040447218;1965.636357273909;1980.9900950495155;2027.1484180058007;804.2882049386335;813.8575749243859;870.9259712924472;984.8227319082633;1074.7420619051372;19616.313429029917;20704.792952070587;20740.48148796262;20899.895500522704;21174.04716787748;959.9040095990345;1026.0201507560262;1032.4682788363998;1036.1037702387532;1040.0379648824808;10514.316569422963;10946.56213751457;10966.177536684621;10975.780484390267;11009.504572294267;627068;628880;632156;634367;647476;125789.37105314415;127725.72274277324;129596.0560591592;132656;138033;939.1078475448215;972.3582435592475;994.8159590475785;995.5271246158017;997.6209040564684;18171.818281817013;18541.814581854007;18726.719099213795;18767.249310027444;19196.13617387193;55726.16410753761;56252.43747562472;56621.71689141528;57454.64725084127;57522.42477575171;58884.705576473556;79410.80883786632;81971;82483.58758206171;82554.58722706349;7971.322437592869;8235.423520353757;8304;8316.251537361666;8331.541765202972;8840.867386989328;12013.399330033639;12549.749005019667;12733.745325093261;12774.425150868048;8839.558022098741;10886.61896833607;11026.830864417781;11446.313221206754;11596.652100437;11115.83326250123;11186.552537898719;11251.606193783178;11290.266132701348;11332.773344533229;11421.714457138305;11474.541018359172;11477.483513241757;11554.76890462203;11602.767944640891;8305.83388332242;8316.376271779762;8380.664773408995;8410.579471026547;8464.153584641486;10768.62309819184;10845.891541084487;10897.564097436014;11031.448427578749;11216.495257713586 10:40:45 INFO - PROCESS | 1640 | |3;mootools.html;1254.9686257843555;1499.8350181480039;1645.5310236582577;1814.94555163345;1851.1207176591113;7661.463697541174;7920.445568810185;8192.467489613171;8638.352123590725;8659.220670139686;8156.959215203916;8443.95778021109;8447.91552084479;8539.359548033892;8560.486370817755;2373.359193017884;2391.091385273602;2399.6520504526834;2402.1832576923844;2405.9037638494437;2377.5601513720017;2411.9035238590436;2416.4200591857916;2420.5279970405777;2425.4785221177444;2359.3511784259294;2369.57347677418;2373.252425485975;2375.501144759594;2381.20229723043;2329.5690297295055;2333.0900948629965;2335.1943579465055;2358.2335740884196;2369.9052037918464;2381.30942026812;2383.6067048936907;2390.7848293653656;2403.3030421177837;2406.169871394366;8456.492610443393;8493.83012339756;8527.275181609572;8536.8719469208;8574.142585741438;5173.9223911640975;5319.069162896478;5349.786008559653;5355.116405793039;5359.839204823823;3511.455724362728;3550.7336949728615;3556.288742251534;3587.6950459211;3592.8742494012586;1064.3454275620516;1077.9191560632985;1095.5453486802967;1118.1948996722347;1134.659602119361;9759.463229522373;10361.740956476073;10954.342739435659;10968.122550195965;10993.285436446606;3813.599572044951;4695.694779839299;4746.667733258639;4757.35775670287;4824.059308434821;8164.346852251806;9485.857712134324;9556.426614403019;9563;9577.952110239405;5254.605904557174;5286.259923610698;5291.3385826771655;5312.123499622597;5313.628046036741;4373.431453910971;4384.4300240969105;4810.8797280068275;4821.879453013633;4863.465018847924;3960.6435420812263;3964.7621142731527;4003.3994900764537;4074.4499492568125;4088.0801819590356;1315.0728736240926;1317.3149962019888;1319.3930791835671;1325.204877073748;1331.1081575344542;821.6795449774593;925.0980294213223;926.4719110107309;936.6487567162314;946.711253067821;5634.633748806396;5680.97159514208;5683.431656834284;5688.06146985751;5803.941960580424;461.78526984952157;469.6946984460128;479.5971782536068;917.4036876030633;989.7773001074701;3066.892658756977;3521.454174602941;3805.923881522354;3979.243943650697;3980.3233450313514;9196.816063678689;9980.600775969026;10261.897381026243;10351.689449316533;10381.63664271762;10216.182705383551;10250.436226007492;10253.58985640566;10253.974602539687;10261.076503114755;6924.757633482804;7474.140473845578;7884.408669349822;8027.117017128111;8087.959560202161;5012.674176178537;5563.666180029211;5652.576056795839;5659;5828.825135245949;7996.960015199887;9340.859887101564;9416.199623032118;9463.526823658653;9480;9181.449113053239;9462.810743785223;9500.334976551576;9514.524273786421;9586.137247647745;6661.600303981777;6829.965850170717;6839.487038472035;7023.543469674455;7333.853322933404;7864.5281283123195;8056.154103819249;8065.798355040936;8072.273495385209;8072.515649061075;7217.4586905983315;7261.201267860637;7355.227701091522;7395.852082958419;7458.291462311072;7107.715691372287;7213.2065472799;7215.025971493781;7218.639068046682;7228.674709637974;6721.899171512334;6750.763723269662;6805.455563554805;6867.416269617139;6875.415589674733;4806.543378379049;4883.3651625288485;4950.975245123751;4965.379327584052;4993.101241776515;4843.782029808737;4909.926351104665;4932.4327702314695;4935.457099718957;4966.701997880139 10:40:45 INFO - PROCESS | 1640 | |4;prototype.html;303.62653935659125;313.4608473425708;318.94737368334216;322.37298454505964;323.87045181927226;4738.086077062599;5241.266222728821;5485.067538518451;5624.493795558394;5625.746841392137;4705.952910483942;4901.2648102784515;5083.745812709368;5175.715335656538;5493.587980901439;4109.301418758803;4187.706860519765;4191.694567987603;4239.2581298272835;4244.97877510612;3223.339215460837;3525.506429099928;3880.5731369549326;4060.045889216032;4274.935875961863;3462.342154990544;4104.220198162339;4162.063535704473;4165.875782974848;4173.707840451169;3803.904902377435;4151.605597468236;4154.293770059097;4157.62798276568;4187.706860519765;3073.631164260303;3625.2568223514118;3647.85408583659;3658.5609726832686;3665.3952097903816;4591.104734576759;4634.675572709912;5004.599632029465;5017.974910125463;5436.477786219864;4161.334186530171;4537.727736335831;4743.549362810528;4753.762311884427;4760.285957106427;5509.5675124467525;5706.343770466408;5770.913436298459;5786.768529258825;5795.5079315894145;3334.8156957193078;3496.370653282408;3589.892303230881;3812.5234345706785;3978.6817054635558;6028.372339468319;6045.342567746494;6063.484603808682;6066.332703402622;6115.571909966304;3866.8646597368956;3989.162275922089;3992.7604343739467;3996.0609256824623;3999.2201520703184;3483.529723487297;3713.3316003119157;4062.51249850014;4085.162541678949;4195.454590903163;4094.6928980326593;4654.4414670239785;4686.055287055834;4856.125897338513;4868.050730107666;4673.3690951721765;5260.395054568774;5832.941670583325;5849.356570777211;5909.556783241274;1119.485036883043;1159.646307876106;1191.314993878506;1313.356455336878;1329.2755448280711;804.7827086686561;873.7815546113471;900.7477906186278;951.5773917992507;955.2310390136007;4846.176150054499;4859.400220881882;5212.9739351303;5229.947700523022;5251.240834320545;5146.716930568779;5179.559737422286;5370.489803468664;5634.943650563524;5723.570732195102;5110.897782044338;5174.6377753557645;5195.922061169085;5246.947530524722;5257.211418287287;2560.7311232320712;2986.522156454957;2988.3126880817535;2989.980120078736;3013.1412547424316;5021.6735912165595;5327.338578743599;5340.759665815048;5677.914831277534;5684.8294551163535;5087.923681144785;5501.734601041783;5786.768529258782;5819.7012180188585;5832.504237139806;5355.955588660174;5511.118221084687;5603.467670571289;5858;5868.67722275279;5503.596582871342;5640.294963129609;5661.801836935852;5666.291713535808;5669;4759.7858096386435;4763.404574428197;5003.049420610218;5544.251526043932;5569.6936668482;5059.5952323814745;5364.946350536445;5805.680687562224;5821.70891455417;6229.719662615284;3435.8282085895107;3598.082488965297;3939.428782826417;4063.9027462585527;4072.5927407260224;5215.895682086413;5263.421023687468;5336.893262134813;5637.956977959091;6115.6330620162935;4893.748875517302;5080.822171223989;5581.218629391969;5978.730957107027;6208.9689551551955;4967.652264341606;5887.7056147193325;5959.122876293954;5969.821015329287;5985.311689155803;4569.474510431343;5624.606277560531;5672.801451949162;5717.628354156966;5798.768049277982;4510.797014134306;5867.794627188028;5888;5922.200502932222;5952.255968003999;4856.271559266138;5629.339117172302;5682.801101961411;5813.534917206698;5815.680137592304 10:40:45 INFO - PROCESS | 1640 | |5;yui.html;716.706150478304;722.2885457824045;777.0597576931912;808.6805711743862;857.7298151082408;14802.185879776607;15123.470678526253;15351.232438378078;15513.767293490579;15531.990420622651;14070.929645351784;14090.788638170436;14201.218932958684;14211.857881421183;14228.359723812428;842.5660784695887;855.4054931822386;855.8288342331527;857.3826844671858;859.1666083898608;856.3149480415674;864.1876635962176;866.7226487523964;868.8696695495695;868.9478631282112;876.5748611923212;877.5305211711735;877.534906499553;877.9209871111599;878.6485405837652;848.4781859156636;859.2953777902122;867.9913200868006;868.2533021601449;869.5391442535466;639.1690801957483;645.0678769178539;645.6481217736344;652.5790864892166;653.8953767397194;14861.851381486154;15342.309596068091;15347.923260383626;15547.222638868012;15722.29249683767;14063.929680351635;14220.786688199685;14490.855091449055;14515.564533064025;14517.564473065824;11790.705232369173;11833.704157396049;11881.524739010429;11957.342346170957;12039.819402708967;3780.7164462665137;3790.90522736931;3814.6566808987322;3829.3107240696663;3883.2039431916673;84746;95894;99044;99214;100571.49714251382;10598.947005265078;10919.508622111865;10932.890671093346;10949.781004379867;11252.15608829341;21430.892845535986;21622.567548648938;21690;21705.67441488379;21729.56540869174;7908.288254057047;7981.08217554977;7984.20157984197;8034.799130021796;8063.233992770677;4390.626796722315;4402.977985110054;4477.19410506112;4493.258612328929;4546.227141385973;3468.7051600613727;3544.149404142987;3551.662592053751;3588.5155504006625;3593.2454184621;650.5395387355418;650.8382537171127;650.853557949467;658.5554750543364;660.8810414125503;595.4759811366057;667.4893706314673;667.4993754683987;681.2574294019444;729.4529103172621;8889.977652570038;9407.576659050359;9655.889572699089;9931.900680993098;10173.338732982333;547.1027514875607;593.5311104227698;597.2504506843883;645.9580127291711;679.5684740190015;3941.7832019238645;4419;4658.790354434059;4675.812967481263;4680.859574212779;93767;110780.4460977706;110942;111319;113627.43186284015;93647;94245;95087.52456237674;96305;99559;87349.68975465374;89195;89296.553517232;91306.08693913108;92704.90123043163;8839.51382673959;8857.822843543221;8950.283977281671;8970.910290897269;9018.774530636787;52338;54785.72607136939;55111;55394.44605553893;55949.72025140011;70792.93810592742;77982;78738;81804;81833.59083204546;10777.955446085443;11382;11450.885491145315;11584.536618535165;11873.346965916957;12239.449224784728;12753.171043882117;12780.808287875876;12904.095904095904;12910.354482276036;11828.763424731285;12029.879701202875;12203.511859525519;12222.327771972627;12237.449314780679;11919.015134941683;12043;12052.397380130784;12123.151379403356;12189.878101219228;11561.190716649753;11672.416379180837;11961.820572691591;12064.879351206375;12476.688082798002;10190.898091018995;10207.897921020694;10336.586536538454;10569.097572422846;10724.73188170302;10282;10355.94822025885;10587.629432969808;10708.089812366035;11137.387443690352 10:40:45 INFO - PROCESS | 1640 | __end_tp_report 10:40:45 INFO - PROCESS | 1640 | __start_cc_report 10:40:45 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,364 10:40:45 INFO - PROCESS | 1640 | __end_cc_report 10:40:45 INFO - PROCESS | 1640 | __startTimestamp1485974445668__endTimestamp 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | ------- Summary: start ------- 10:40:45 INFO - PROCESS | 1640 | Number of tests: 6 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5963.35 Median:6222.13 stddev:651.32 (10.5%) stddev-sans-first:626.21 10:40:45 INFO - PROCESS | 1640 | Values: 3592.9 3595.7 3618.3 3621.2 3632.5 6099.6 6110.2 6197.2 6208.9 6211.3 5933.1 6081.6 6154.9 6175.3 6217.8 4580.4 5480.9 5481.2 5511.1 5547.8 5530.5 5531.8 5548.9 5573.9 5615.7 5421.9 5427.8 5546.7 5555.9 5559.7 5444.2 5476.4 5546.6 5555.7 5612.8 5437.3 5511.6 5525.7 5526.2 5553.8 5899.8 6180.1 6231.4 6231.8 6242.3 6208.9 6231.9 6232.3 6279.2 6356.1 5362.7 6329.3 6463.4 6467.9 6491.4 5123.4 6144.6 6177.4 6182.2 6200.3 6360.9 6394.2 6456.2 6461.0 6492.4 5287.7 6225.4 6240.1 6283.9 6295.0 6371.3 6375.0 6419.5 6428.3 6446.4 6165.7 6214.0 6222.1 6231.9 6266.8 6244.8 6323.4 6323.5 6324.3 6380.6 5199.4 5210.5 5225.7 5232.1 5233.1 4498.5 4585.7 4633.8 4652.0 4730.3 5206.3 6145.0 6239.6 6252.5 6257.8 6501.3 6508.4 6509.4 6525.0 6544.4 5092.3 6103.6 6191.5 6237.9 6240.0 5810.9 5818.6 5819.7 5833.4 5856.6 6462.1 6729.4 6744.6 6770.6 6783.5 6229.7 6366.9 6370.5 6413.4 6532.5 6683.1 6720.4 6728.2 6747.2 6752.9 6414.4 6414.6 6428.9 6429.2 6435.3 4659.1 6064.4 6373.5 6459.4 6497.4 6150.2 6325.7 6328.0 6331.5 6376.2 5248.3 6284.9 6293.3 6303.0 6305.1 5706.7 6169.8 6189.1 6198.8 6239.1 6216.5 6223.2 6227.8 6324.1 6333.0 6194.4 6254.8 6256.1 6259.1 6281.5 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:71902.57 Median:40602.29 stddev:158173.65 (389.6%) stddev-sans-first:158526.43 10:40:45 INFO - PROCESS | 1640 | Values: 468.2 534.5 549.4 565.3 575.5 38162.0 40927.0 41015.4 41076.4 41209.8 33658.3 41606.0 42274.2 42284.6 42298.6 9543.5 9654.9 9698.6 9726.0 9761.7 9698.0 9713.8 9757.1 9819.3 9825.3 9798.6 9804.2 9805.2 9843.1 9854.9 9726.2 9790.7 9799.2 9803.0 9815.7 9588.0 9632.7 9634.4 9671.0 9695.0 39834.0 39878.2 40176.0 40264.8 40284.8 3593.0 3609.2 4012.8 4121.9 4164.7 27650.0 30018.1 30395.7 31078.4 31518.9 3241.8 3323.6 3329.8 3381.8 3384.6 483698.0 486515.0 489153.0 489198.0 490438.0 60061.5 60139.4 60173.4 60342.7 60509.4 61469.8 61925.0 61964.4 62064.0 62336.7 16408.3 16618.0 16718.1 16730.3 16735.2 12917.4 13009.1 13099.1 13119.5 13149.5 14584.0 15314.8 15821.0 15842.3 15926.6 5245.5 6143.8 6158.3 6207.0 6233.7 921.9 993.7 1057.5 1092.5 1103.7 26700.9 30542.4 30781.1 31183.7 31279.0 1002.4 1038.7 1160.2 1169.5 1185.3 14467.0 15984.7 16035.8 16112.5 16137.4 668912.0 672040.0 672768.0 673515.0 673955.0 59268.7 59299.4 59341.1 59437.0 59490.7 1389.7 1401.7 1413.4 1423.3 1428.4 27329.7 28180.7 29418.9 30245.5 30397.0 38520.6 46713.8 50408.0 50549.0 50656.7 555438.0 608125.9 609711.0 610795.0 611953.0 36611.1 38058.0 40500.4 41579.8 42150.8 37763.8 44064.6 44954.8 47128.0 48623.8 38832.6 39458.2 39476.8 39776.6 40852.8 38417.4 38814.4 39299.4 39733.8 39885.8 38548.2 38752.8 39338.0 39549.8 40704.2 32038.4 34866.0 34902.3 35161.0 35271.5 24602.0 26141.7 26362.7 26366.7 26500.9 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:36259.89 Median:24709.07 stddev:105544.13 (427.1%) stddev-sans-first:105805.84 10:40:45 INFO - PROCESS | 1640 | Values: 386.3 388.8 389.9 397.7 419.3 16279.0 19223.4 20202.8 20587.6 20604.9 20171.0 20362.5 20436.0 20793.8 20947.9 5781.7 6017.5 6059.0 6061.5 6085.0 5825.0 5905.8 6026.8 6048.3 6115.1 5802.2 5894.5 5905.1 5914.7 5926.6 4758.5 5747.5 5838.9 5907.4 5919.8 5109.0 5204.2 5217.7 5218.2 5223.3 24676.4 24706.4 24711.8 25106.0 25302.7 2257.3 2307.5 2525.5 2532.0 2561.3 15054.8 15689.9 15692.9 15742.3 16048.3 1857.6 1917.6 1946.4 1975.4 1992.7 111027.0 115511.0 116511.4 119408.0 123415.1 9566.7 11896.8 12023.6 12031.9 12157.1 13585.3 14201.5 14842.0 15199.2 15204.3 7333.7 7810.6 8713.8 8925.0 8996.2 8653.4 8751.8 8787.4 8906.6 8909.2 4176.2 4601.8 4608.0 4695.3 4757.1 1749.4 1804.4 1965.6 1981.0 2027.1 804.3 813.9 870.9 984.8 1074.7 19616.3 20704.8 20740.5 20899.9 21174.0 959.9 1026.0 1032.5 1036.1 1040.0 10514.3 10946.6 10966.2 10975.8 11009.5 627068.0 628880.0 632156.0 634367.0 647476.0 125789.4 127725.7 129596.1 132656.0 138033.0 939.1 972.4 994.8 995.5 997.6 18171.8 18541.8 18726.7 18767.2 19196.1 55726.2 56252.4 56621.7 57454.6 57522.4 58884.7 79410.8 81971.0 82483.6 82554.6 7971.3 8235.4 8304.0 8316.3 8331.5 8840.9 12013.4 12549.7 12733.7 12774.4 8839.6 10886.6 11026.8 11446.3 11596.7 11115.8 11186.6 11251.6 11290.3 11332.8 11421.7 11474.5 11477.5 11554.8 11602.8 8305.8 8316.4 8380.7 8410.6 8464.2 10768.6 10845.9 10897.6 11031.4 11216.5 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5487.87 Median:5093.30 stddev:2976.37 (58.4%) stddev-sans-first:2967.71 10:40:45 INFO - PROCESS | 1640 | Values: 1255.0 1499.8 1645.5 1814.9 1851.1 7661.5 7920.4 8192.5 8638.4 8659.2 8157.0 8444.0 8447.9 8539.4 8560.5 2373.4 2391.1 2399.7 2402.2 2405.9 2377.6 2411.9 2416.4 2420.5 2425.5 2359.4 2369.6 2373.3 2375.5 2381.2 2329.6 2333.1 2335.2 2358.2 2369.9 2381.3 2383.6 2390.8 2403.3 2406.2 8456.5 8493.8 8527.3 8536.9 8574.1 5173.9 5319.1 5349.8 5355.1 5359.8 3511.5 3550.7 3556.3 3587.7 3592.9 1064.3 1077.9 1095.5 1118.2 1134.7 9759.5 10361.7 10954.3 10968.1 10993.3 3813.6 4695.7 4746.7 4757.4 4824.1 8164.3 9485.9 9556.4 9563.0 9578.0 5254.6 5286.3 5291.3 5312.1 5313.6 4373.4 4384.4 4810.9 4821.9 4863.5 3960.6 3964.8 4003.4 4074.4 4088.1 1315.1 1317.3 1319.4 1325.2 1331.1 821.7 925.1 926.5 936.6 946.7 5634.6 5681.0 5683.4 5688.1 5803.9 461.8 469.7 479.6 917.4 989.8 3066.9 3521.5 3805.9 3979.2 3980.3 9196.8 9980.6 10261.9 10351.7 10381.6 10216.2 10250.4 10253.6 10254.0 10261.1 6924.8 7474.1 7884.4 8027.1 8088.0 5012.7 5563.7 5652.6 5659.0 5828.8 7997.0 9340.9 9416.2 9463.5 9480.0 9181.4 9462.8 9500.3 9514.5 9586.1 6661.6 6830.0 6839.5 7023.5 7333.9 7864.5 8056.2 8065.8 8072.3 8072.5 7217.5 7261.2 7355.2 7395.9 7458.3 7107.7 7213.2 7215.0 7218.6 7228.7 6721.9 6750.8 6805.5 6867.4 6875.4 4806.5 4883.4 4951.0 4965.4 4993.1 4843.8 4909.9 4932.4 4935.5 4966.7 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4566.86 Median:5082.28 stddev:1413.41 (27.8%) stddev-sans-first:1380.68 10:40:45 INFO - PROCESS | 1640 | Values: 303.6 313.5 318.9 322.4 323.9 4738.1 5241.3 5485.1 5624.5 5625.7 4706.0 4901.3 5083.7 5175.7 5493.6 4109.3 4187.7 4191.7 4239.3 4245.0 3223.3 3525.5 3880.6 4060.0 4274.9 3462.3 4104.2 4162.1 4165.9 4173.7 3803.9 4151.6 4154.3 4157.6 4187.7 3073.6 3625.3 3647.9 3658.6 3665.4 4591.1 4634.7 5004.6 5018.0 5436.5 4161.3 4537.7 4743.5 4753.8 4760.3 5509.6 5706.3 5770.9 5786.8 5795.5 3334.8 3496.4 3589.9 3812.5 3978.7 6028.4 6045.3 6063.5 6066.3 6115.6 3866.9 3989.2 3992.8 3996.1 3999.2 3483.5 3713.3 4062.5 4085.2 4195.5 4094.7 4654.4 4686.1 4856.1 4868.1 4673.4 5260.4 5832.9 5849.4 5909.6 1119.5 1159.6 1191.3 1313.4 1329.3 804.8 873.8 900.7 951.6 955.2 4846.2 4859.4 5213.0 5229.9 5251.2 5146.7 5179.6 5370.5 5634.9 5723.6 5110.9 5174.6 5195.9 5246.9 5257.2 2560.7 2986.5 2988.3 2990.0 3013.1 5021.7 5327.3 5340.8 5677.9 5684.8 5087.9 5501.7 5786.8 5819.7 5832.5 5356.0 5511.1 5603.5 5858.0 5868.7 5503.6 5640.3 5661.8 5666.3 5669.0 4759.8 4763.4 5003.0 5544.3 5569.7 5059.6 5364.9 5805.7 5821.7 6229.7 3435.8 3598.1 3939.4 4063.9 4072.6 5215.9 5263.4 5336.9 5638.0 6115.6 4893.7 5080.8 5581.2 5978.7 6209.0 4967.7 5887.7 5959.1 5969.8 5985.3 4569.5 5624.6 5672.8 5717.6 5798.8 4510.8 5867.8 5888.0 5922.2 5952.3 4856.3 5629.3 5682.8 5813.5 5815.7 10:40:45 INFO - PROCESS | 1640 | 10:40:45 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:21033.65 Median:4485.23 stddev:30955.60 (690.2%) stddev-sans-first:31004.84 10:40:45 INFO - PROCESS | 1640 | Values: 716.7 722.3 777.1 808.7 857.7 14802.2 15123.5 15351.2 15513.8 15532.0 14070.9 14090.8 14201.2 14211.9 14228.4 842.6 855.4 855.8 857.4 859.2 856.3 864.2 866.7 868.9 868.9 876.6 877.5 877.5 877.9 878.6 848.5 859.3 868.0 868.3 869.5 639.2 645.1 645.6 652.6 653.9 14861.9 15342.3 15347.9 15547.2 15722.3 14063.9 14220.8 14490.9 14515.6 14517.6 11790.7 11833.7 11881.5 11957.3 12039.8 3780.7 3790.9 3814.7 3829.3 3883.2 84746.0 95894.0 99044.0 99214.0 100571.5 10598.9 10919.5 10932.9 10949.8 11252.2 21430.9 21622.6 21690.0 21705.7 21729.6 7908.3 7981.1 7984.2 8034.8 8063.2 4390.6 4403.0 4477.2 4493.3 4546.2 3468.7 3544.1 3551.7 3588.5 3593.2 650.5 650.8 650.9 658.6 660.9 595.5 667.5 667.5 681.3 729.5 8890.0 9407.6 9655.9 9931.9 10173.3 547.1 593.5 597.3 646.0 679.6 3941.8 4419.0 4658.8 4675.8 4680.9 93767.0 110780.4 110942.0 111319.0 113627.4 93647.0 94245.0 95087.5 96305.0 99559.0 87349.7 89195.0 89296.6 91306.1 92704.9 8839.5 8857.8 8950.3 8970.9 9018.8 52338.0 54785.7 55111.0 55394.4 55949.7 70792.9 77982.0 78738.0 81804.0 81833.6 10778.0 11382.0 11450.9 11584.5 11873.3 12239.4 12753.2 12780.8 12904.1 12910.4 11828.8 12029.9 12203.5 12222.3 12237.4 11919.0 12043.0 12052.4 12123.2 12189.9 11561.2 11672.4 11961.8 12064.9 12476.7 10190.9 10207.9 10336.6 10569.1 10724.7 10282.0 10355.9 10587.6 10708.1 11137.4 10:40:45 INFO - PROCESS | 1640 | -------- Summary: end -------- 10:40:45 INFO - PROCESS | 1640 | 10:40:46 INFO - TEST-INFO | 1640: exit 0 10:40:46 INFO - TEST-OK | dromaeo_css | took 1114832ms 10:40:46 INFO - TEST-START | kraken 10:40:46 INFO - operating with platform_type : mac_ 10:40:46 INFO - Initialising browser for kraken test... 10:40:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp8hmWEr/profile http://localhost:49236/getInfo.html) 10:40:49 INFO - PROCESS | 1652 | 2017-02-01 10:40:49.137 plugin-container[1654:10089] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 10:40:49 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:49 INFO - PROCESS | 1652 | 2017-02-01 10:40:49.138 plugin-container[1654:10089] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:40:49 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:49 INFO - PROCESS | 1652 | 2017-02-01 10:40:49.138 plugin-container[1654:10089] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:40:49 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 10:40:49 INFO - PROCESS | 1652 | colorDepth:24 10:40:49 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 10:40:49 INFO - PROCESS | 1652 | __metrics 10:40:49 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:40:50 INFO - TEST-INFO | 1652: exit 0 10:40:50 INFO - Browser initialized. 10:40:50 INFO - Running cycle 1/1 for kraken test... 10:40:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmp8hmWEr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:52 INFO - PROCESS | 1655 | 2017-02-01 10:40:52.326 plugin-container[1656:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 10:40:52 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:52 INFO - PROCESS | 1655 | 2017-02-01 10:40:52.326 plugin-container[1656:10215] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 10:40:52 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:40:52 INFO - PROCESS | 1655 | 2017-02-01 10:40:52.326 plugin-container[1656:10215] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:41:02 INFO - PROCESS | 1655 | RSS: Main: 177373184 10:41:02 INFO - PROCESS | 1655 | 10:41:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:41:05 INFO - PROCESS | 1655 | RSS: Main: 190369792 10:41:05 INFO - PROCESS | 1655 | 10:41:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:41:08 INFO - PROCESS | 1655 | RSS: Main: 199270400 10:41:08 INFO - PROCESS | 1655 | 10:41:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:41:12 INFO - PROCESS | 1655 | RSS: Main: 202223616 10:41:12 INFO - PROCESS | 1655 | 10:41:14 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:41:15 INFO - PROCESS | 1655 | RSS: Main: 203571200 10:41:15 INFO - PROCESS | 1655 | 10:41:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:41:17 INFO - PROCESS | 1655 | RSS: Main: 203599872 10:41:17 INFO - PROCESS | 1655 | 10:41:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:41:21 INFO - PROCESS | 1655 | RSS: Main: 207331328 10:41:21 INFO - PROCESS | 1655 | 10:41:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:41:24 INFO - PROCESS | 1655 | RSS: Main: 207663104 10:41:24 INFO - PROCESS | 1655 | 10:41:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:41:28 INFO - PROCESS | 1655 | RSS: Main: 207204352 10:41:28 INFO - PROCESS | 1655 | 10:41:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:41:30 INFO - PROCESS | 1655 | RSS: Main: 205971456 10:41:30 INFO - PROCESS | 1655 | 10:41:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:41:33 INFO - PROCESS | 1655 | RSS: Main: 206270464 10:41:33 INFO - PROCESS | 1655 | 10:41:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:41:36 INFO - PROCESS | 1655 | RSS: Main: 206188544 10:41:36 INFO - PROCESS | 1655 | 10:41:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:39 INFO - PROCESS | 1655 | RSS: Main: 206241792 10:41:39 INFO - PROCESS | 1655 | 10:41:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:43 INFO - PROCESS | 1655 | RSS: Main: 206561280 10:41:43 INFO - PROCESS | 1655 | 10:41:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:41:45 INFO - PROCESS | 1655 | RSS: Main: 208556032 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | __start_tp_report 10:41:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 10:41:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 10:41:45 INFO - PROCESS | 1655 | |i|pagename|runs| 10:41:45 INFO - PROCESS | 1655 | |0;ai-astar;115;170;121;116;119;125;134;119;117;118 10:41:45 INFO - PROCESS | 1655 | |1;audio-beat-detection;144;111;110;140;112;112;112;110;134;120 10:41:45 INFO - PROCESS | 1655 | |2;audio-dft;192;199;194;203;194;196;199;197;197;199 10:41:45 INFO - PROCESS | 1655 | |3;audio-fft;81;60;60;84;60;60;71;82;102;58 10:41:45 INFO - PROCESS | 1655 | |4;audio-oscillator;108;101;105;71;69;70;84;69;70;86 10:41:45 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;92;94;92;89;92;88;93;91;92;100 10:41:45 INFO - PROCESS | 1655 | |6;imaging-darkroom;147;128;98;98;97;97;98;97;112;99 10:41:45 INFO - PROCESS | 1655 | |7;imaging-desaturate;88;91;71;141;135;89;90;90;89;87 10:41:45 INFO - PROCESS | 1655 | |8;json-parse-financial;48;52;83;82;86;62;59;60;58;59 10:41:45 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;67;67;72;85;94;105;95;96;96;74 10:41:45 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;81;83;83;87;84;84;84;82;84 10:41:45 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;138;135;155;150;157;138;143;156;200;152 10:41:45 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;170;167;163;166;166;164;165;171;166;165 10:41:45 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;67;65;67;65;66;68;64;67;74 10:41:45 INFO - PROCESS | 1655 | __end_tp_report 10:41:45 INFO - PROCESS | 1655 | __start_cc_report 10:41:45 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,909 10:41:45 INFO - PROCESS | 1655 | __end_cc_report 10:41:45 INFO - PROCESS | 1655 | __startTimestamp1485974505060__endTimestamp 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | ------- Summary: start ------- 10:41:45 INFO - PROCESS | 1655 | Number of tests: 14 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:125.40 Median:120.00 stddev:16.62 (13.9%) stddev-sans-first:17.20 10:41:45 INFO - PROCESS | 1655 | Values: 115.0 170.0 121.0 116.0 119.0 125.0 134.0 119.0 117.0 118.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:116.00 stddev:13.51 (11.6%) stddev-sans-first:11.34 10:41:45 INFO - PROCESS | 1655 | Values: 144.0 111.0 110.0 140.0 112.0 112.0 112.0 110.0 134.0 120.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:197.00 Median:198.00 stddev:3.20 (1.6%) stddev-sans-first:2.83 10:41:45 INFO - PROCESS | 1655 | Values: 192.0 199.0 194.0 203.0 194.0 196.0 199.0 197.0 197.0 199.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.80 Median:65.50 stddev:14.90 (22.7%) stddev-sans-first:15.43 10:41:45 INFO - PROCESS | 1655 | Values: 81.0 60.0 60.0 84.0 60.0 60.0 71.0 82.0 102.0 58.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:70.00 stddev:16.04 (22.9%) stddev-sans-first:14.31 10:41:45 INFO - PROCESS | 1655 | Values: 108.0 101.0 105.0 71.0 69.0 70.0 84.0 69.0 70.0 86.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:92.00 stddev:3.23 (3.5%) stddev-sans-first:3.43 10:41:45 INFO - PROCESS | 1655 | Values: 92.0 94.0 92.0 89.0 92.0 88.0 93.0 91.0 92.0 100.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:107.10 Median:97.50 stddev:17.23 (17.7%) stddev-sans-first:10.63 10:41:45 INFO - PROCESS | 1655 | Values: 147.0 128.0 98.0 98.0 97.0 97.0 98.0 97.0 112.0 99.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:89.00 stddev:22.36 (25.1%) stddev-sans-first:23.47 10:41:45 INFO - PROCESS | 1655 | Values: 88.0 91.0 71.0 141.0 135.0 89.0 90.0 90.0 89.0 87.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:61.00 stddev:13.61 (22.3%) stddev-sans-first:12.99 10:41:45 INFO - PROCESS | 1655 | Values: 48.0 52.0 83.0 82.0 86.0 62.0 59.0 60.0 58.0 59.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:85.10 Median:89.50 stddev:13.99 (15.6%) stddev-sans-first:13.21 10:41:45 INFO - PROCESS | 1655 | Values: 67.0 67.0 72.0 85.0 94.0 105.0 95.0 96.0 96.0 74.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.58 (1.9%) stddev-sans-first:1.67 10:41:45 INFO - PROCESS | 1655 | Values: 84.0 81.0 83.0 83.0 87.0 84.0 84.0 84.0 82.0 84.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:153.50 stddev:18.61 (12.1%) stddev-sans-first:19.00 10:41:45 INFO - PROCESS | 1655 | Values: 138.0 135.0 155.0 150.0 157.0 138.0 143.0 156.0 200.0 152.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:2.50 (1.5%) stddev-sans-first:2.26 10:41:45 INFO - PROCESS | 1655 | Values: 170.0 167.0 163.0 166.0 166.0 164.0 165.0 171.0 166.0 165.0 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:2.77 (4.1%) stddev-sans-first:2.92 10:41:45 INFO - PROCESS | 1655 | Values: 66.0 67.0 65.0 67.0 65.0 66.0 68.0 64.0 67.0 74.0 10:41:45 INFO - PROCESS | 1655 | -------- Summary: end -------- 10:41:45 INFO - PROCESS | 1655 | 10:41:45 INFO - TEST-INFO | 1655: exit 0 10:41:46 INFO - TEST-OK | kraken | took 59778ms 10:41:46 INFO - SUITE-END | took 1174s 10:41:46 INFO - Completed test suite (00:19:34) 10:41:46 INFO - javascript benchmark 10:41:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7356.362020866103, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3592.874249401271, 3595.7303202259836, 3618.3486972344986, 3621.1671315597428, 3632.527771389719, 6099.603525770822, 6110.236220472435, 6197.194364732584, 6208.937910620893, 6211.3167551569295, 5933.13969474427, 6081.574289799716, 6154.907676384858, 6175.320714721377, 6217.844553886155, 4580.358749775034, 5480.862978425552, 5481.177823326513, 5511.118221084627, 5547.77808887644, 5530.5022547970675, 5531.751071201786, 5548.91676624851, 5573.860653483675, 5615.7472913718775, 5421.9457805422035, 5427.83716488504, 5546.69493177875, 5555.8888822223535, 5559.749811258483, 5444.210589464526, 5476.3702174249875, 5546.584006199551, 5555.666660000373, 5612.831615051555, 5437.34751829779, 5511.641743286674, 5525.723713814293, 5526.226328314039, 5553.750081246313, 5899.793507227227, 6180.103884936704, 6231.376862313732, 6231.750729970796, 6242.313345531988, 6208.937910620881, 6231.906521402183, 6232.3144454110015, 6279.215098112736, 6356.110144579762, 5362.651427657229, 6329.303776584572, 6463.385978332051, 6467.870642587122, 6491.448226900719, 5123.38519377677, 6144.600600960924, 6177.382261773787, 6182.196314479089, 6200.286966998853, 6360.9045864312075, 6394.23269207698, 6456.160699109179, 6461.0, 6492.383223593751, 5287.68273903567, 6225.3774622537385, 6240.063990401385, 6283.937160628335, 6295.024271237966, 6371.299157092716, 6375.0, 6419.45434638061, 6428.260750013808, 6446.387593178641, 6165.660888651168, 6214.005759078525, 6222.12890195373, 6231.937680623136, 6266.843328916722, 6244.75104979006, 6323.430891219812, 6323.525735569759, 6324.272708638474, 6380.649064301415, 5199.428062913076, 5210.452902445264, 5225.6603320784025, 5232.084385232569, 5233.110371236899, 4498.460184777848, 4585.656075794329, 4633.791479383436, 4651.953480465152, 4730.290456431563, 5206.271122042917, 6144.986077297196, 6239.625622462576, 6252.531060170505, 6257.812265632038, 6501.252355979028, 6508.381703738232, 6509.381608747161, 6525.0, 6544.3782840630065, 5092.337996060563, 6103.6032657877095, 6191.504679625619, 6237.937620623827, 6240.0, 5810.941890581124, 5818.5636077294375, 5819.6508209507565, 5833.445822646841, 5856.6486010838635, 6462.127612772216, 6729.360710732472, 6744.5616034957575, 6770.627615481098, 6783.457323414016, 6229.657368844757, 6366.904496432465, 6370.490360771035, 6413.390727880844, 6532.510061745293, 6683.097781799589, 6720.395164435225, 6728.192616886005, 6747.156605424322, 6752.93247067523, 6414.422701956846, 6414.647194404352, 6428.871422571428, 6429.2284925807335, 6435.259945106185, 4659.114768194032, 6064.3935606439, 6373.490120790419, 6459.354064593503, 6497.382748638872, 6150.200473938359, 6325.652089135142, 6328.0, 6331.493480521639, 6376.202974628171, 5248.291480650063, 6284.937150628435, 6293.276273228637, 6303.0, 6305.1172835803945, 5706.714664266853, 6169.81490555284, 6189.071639254148, 6198.783042593487, 6239.126522286974, 6216.53375996793, 6223.159873417031, 6227.813165605039, 6324.051392291193, 6332.968335158294, 6194.4115309045565, 6254.781082662085, 6256.124142619946, 6259.123722678738, 6281.52888533371], "value": 5926.675657829637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.20872725094586, 534.5376249544146, 549.447804956019, 565.3442007271564, 575.4648177195212, 38162.04594885126, 40926.976825579375, 41015.38476922848, 41076.38385424221, 41209.79395103024, 33658.32683346332, 41605.95985100374, 42274.15451690964, 42284.57715422845, 42298.57701422985, 9543.47510886901, 9654.903450965507, 9698.563564639608, 9726.027397260288, 9761.658341958033, 9697.95151024244, 9713.805723885518, 9757.121859032686, 9819.312648114636, 9825.263105267099, 9798.559064842098, 9804.215662747, 9805.215582753362, 9843.114119729224, 9854.852177217348, 9726.17327527161, 9790.657326993593, 9799.216062714966, 9802.950985245065, 9815.705528834147, 9588.041195880425, 9632.662856800049, 9634.373765705206, 9671.0, 9694.982026887146, 39834.0, 39878.20243595141, 40176.0, 40264.79867600673, 40284.798576007226, 3592.9640703593154, 3609.205974685565, 4012.819423125937, 4121.876343709693, 4164.68764842635, 27650.0, 30018.099457016324, 30395.69604303951, 31078.378432431226, 31518.920691059746, 3241.773075884689, 3323.567936168307, 3329.8335083245743, 3381.7970921744773, 3384.5938487381427, 483698.0, 486515.0, 489153.0, 489198.0, 490438.0, 60061.498462537915, 60139.398606014256, 60173.39826601678, 60342.69828650916, 60509.39490605125, 61469.770604587655, 61925.0, 61964.380356196765, 62064.0, 62336.68831655903, 16408.26162822676, 16618.0, 16718.080505572067, 16730.330786768394, 16735.246913888903, 12917.418716157796, 13009.089363744448, 13099.148555343872, 13119.475220991053, 13149.474021039052, 14583.98254908067, 15314.846851531565, 15821.0, 15842.28709708066, 15926.601834953986, 5245.475452454801, 6143.84640383994, 6158.291796443466, 6206.968965155145, 6233.688315584202, 921.8847644044495, 993.7118235711707, 1057.4871187474068, 1092.4810714910354, 1103.6964834670368, 26700.866495667397, 30542.38915221683, 30781.076567703003, 31183.688163118077, 31279.0, 1002.4486532407146, 1038.6883934819523, 1160.158884808524, 1169.5146514196683, 1185.3421351150023, 14467.0, 15984.680306394039, 16035.839641603668, 16112.516624501284, 16137.35450581987, 668912.0, 672040.0, 672768.0, 673515.0, 673955.0, 59268.70365648231, 59299.40700592939, 59341.10988335178, 59437.0, 59490.70254648699, 1389.715108402775, 1401.7266633006466, 1413.3639862061907, 1423.309694798022, 1428.4429072661671, 27329.726702732718, 28180.71819281781, 29418.852905735333, 30245.546316804826, 30397.0, 38520.61479385282, 46713.76643116899, 50408.0, 50549.0, 50656.746716266185, 555438.0, 608125.918740807, 609711.0, 610795.0, 611953.0, 36611.084722882144, 38058.0, 40500.39249411202, 41579.79210104051, 42150.78924605357, 37763.81118094392, 44064.55935440605, 44954.77522612366, 47128.0, 48623.75688121537, 38832.61167388403, 39458.2108357837, 39476.80261598789, 39776.60223397729, 40852.79573602113, 38417.4237386445, 38814.4474221028, 39299.41050884182, 39733.80133099432, 39885.80913526853, 38548.229035418575, 38752.80623596864, 39338.0, 39549.80225098856, 40704.18591628092, 32038.35923281568, 34866.0, 34902.30195396027, 35161.0, 35271.470927936614, 24602.0, 26141.73858261393, 26362.736372636027, 26366.674624015646, 26500.867495662398], "value": 20264.439522711724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.28537206168573, 388.83085857651906, 389.93176194166017, 397.6739073959354, 419.31232778243685, 16279.0, 19223.423297301088, 20202.797972020275, 20587.588248235046, 20604.89697551512, 20171.0, 20362.490937726565, 20436.0, 20793.75237485752, 20947.895260523714, 5781.682007489587, 6017.518598512131, 6059.030555111183, 6061.545384096188, 6084.969575152118, 5825.0, 5905.822825315247, 6026.819195424145, 6048.304444988817, 6115.082737589352, 5802.158686990384, 5894.4989675877605, 5905.084711869667, 5914.733836977346, 5926.585139040269, 4758.45277793053, 5747.482726554609, 5838.854028649275, 5907.379725128864, 5919.792807251725, 5108.974455127738, 5204.167333226704, 5217.739113044333, 5218.243354713545, 5223.347081614798, 24676.383090422703, 24706.382340441454, 24711.752882471126, 25106.0, 25302.746972530407, 2257.3228031590456, 2307.48081681622, 2525.4696513732138, 2531.974680253211, 2561.2956436979794, 15054.849451505454, 15689.921550392175, 15692.921535392365, 15742.291596878167, 16048.27782749779, 1857.572758265593, 1917.5685470769106, 1946.4113974197444, 1975.446874875023, 1992.7110568967419, 111027.0, 115511.0, 116511.4174429131, 119408.0, 123415.14877276849, 9566.665166719271, 11896.76206475883, 12023.63929082129, 12031.939840300742, 12157.08821838348, 13585.320733963263, 14201.502947396792, 14842.03526770778, 15199.240037998277, 15204.315805788767, 7333.706651733871, 7810.570418626917, 8713.782155446037, 8924.955375223211, 8996.235319997873, 8653.39426240157, 8751.824963500694, 8787.384883058125, 8906.55467226636, 8909.1536304051, 4176.206520761046, 4601.803531081943, 4607.976960115178, 4695.272232803921, 4757.09615173116, 1749.4167778160786, 1804.4316040447218, 1965.636357273909, 1980.9900950495155, 2027.1484180058007, 804.2882049386335, 813.8575749243859, 870.9259712924472, 984.8227319082633, 1074.7420619051372, 19616.313429029917, 20704.792952070587, 20740.48148796262, 20899.895500522704, 21174.04716787748, 959.9040095990345, 1026.0201507560262, 1032.4682788363998, 1036.1037702387532, 1040.0379648824808, 10514.316569422963, 10946.56213751457, 10966.177536684621, 10975.780484390267, 11009.504572294267, 627068.0, 628880.0, 632156.0, 634367.0, 647476.0, 125789.37105314415, 127725.72274277324, 129596.0560591592, 132656.0, 138033.0, 939.1078475448215, 972.3582435592475, 994.8159590475785, 995.5271246158017, 997.6209040564684, 18171.818281817013, 18541.814581854007, 18726.719099213795, 18767.249310027444, 19196.13617387193, 55726.16410753761, 56252.43747562472, 56621.71689141528, 57454.64725084127, 57522.42477575171, 58884.705576473556, 79410.80883786632, 81971.0, 82483.58758206171, 82554.58722706349, 7971.322437592869, 8235.423520353757, 8304.0, 8316.251537361666, 8331.541765202972, 8840.867386989328, 12013.399330033639, 12549.749005019667, 12733.745325093261, 12774.425150868048, 8839.558022098741, 10886.61896833607, 11026.830864417781, 11446.313221206754, 11596.652100437, 11115.83326250123, 11186.552537898719, 11251.606193783178, 11290.266132701348, 11332.773344533229, 11421.714457138305, 11474.541018359172, 11477.483513241757, 11554.76890462203, 11602.767944640891, 8305.83388332242, 8316.376271779762, 8380.664773408995, 8410.579471026547, 8464.153584641486, 10768.62309819184, 10845.891541084487, 10897.564097436014, 11031.448427578749, 11216.495257713586], "value": 9741.90996162453, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.9686257843555, 1499.8350181480039, 1645.5310236582577, 1814.94555163345, 1851.1207176591113, 7661.463697541174, 7920.445568810185, 8192.467489613171, 8638.352123590725, 8659.220670139686, 8156.959215203916, 8443.95778021109, 8447.91552084479, 8539.359548033892, 8560.486370817755, 2373.359193017884, 2391.091385273602, 2399.6520504526834, 2402.1832576923844, 2405.9037638494437, 2377.5601513720017, 2411.9035238590436, 2416.4200591857916, 2420.5279970405777, 2425.4785221177444, 2359.3511784259294, 2369.57347677418, 2373.252425485975, 2375.501144759594, 2381.20229723043, 2329.5690297295055, 2333.0900948629965, 2335.1943579465055, 2358.2335740884196, 2369.9052037918464, 2381.30942026812, 2383.6067048936907, 2390.7848293653656, 2403.3030421177837, 2406.169871394366, 8456.492610443393, 8493.83012339756, 8527.275181609572, 8536.8719469208, 8574.142585741438, 5173.9223911640975, 5319.069162896478, 5349.786008559653, 5355.116405793039, 5359.839204823823, 3511.455724362728, 3550.7336949728615, 3556.288742251534, 3587.6950459211, 3592.8742494012586, 1064.3454275620516, 1077.9191560632985, 1095.5453486802967, 1118.1948996722347, 1134.659602119361, 9759.463229522373, 10361.740956476073, 10954.342739435659, 10968.122550195965, 10993.285436446606, 3813.599572044951, 4695.694779839299, 4746.667733258639, 4757.35775670287, 4824.059308434821, 8164.346852251806, 9485.857712134324, 9556.426614403019, 9563.0, 9577.952110239405, 5254.605904557174, 5286.259923610698, 5291.3385826771655, 5312.123499622597, 5313.628046036741, 4373.431453910971, 4384.4300240969105, 4810.8797280068275, 4821.879453013633, 4863.465018847924, 3960.6435420812263, 3964.7621142731527, 4003.3994900764537, 4074.4499492568125, 4088.0801819590356, 1315.0728736240926, 1317.3149962019888, 1319.3930791835671, 1325.204877073748, 1331.1081575344542, 821.6795449774593, 925.0980294213223, 926.4719110107309, 936.6487567162314, 946.711253067821, 5634.633748806396, 5680.97159514208, 5683.431656834284, 5688.06146985751, 5803.941960580424, 461.78526984952157, 469.6946984460128, 479.5971782536068, 917.4036876030633, 989.7773001074701, 3066.892658756977, 3521.454174602941, 3805.923881522354, 3979.243943650697, 3980.3233450313514, 9196.816063678689, 9980.600775969026, 10261.897381026243, 10351.689449316533, 10381.63664271762, 10216.182705383551, 10250.436226007492, 10253.58985640566, 10253.974602539687, 10261.076503114755, 6924.757633482804, 7474.140473845578, 7884.408669349822, 8027.117017128111, 8087.959560202161, 5012.674176178537, 5563.666180029211, 5652.576056795839, 5659.0, 5828.825135245949, 7996.960015199887, 9340.859887101564, 9416.199623032118, 9463.526823658653, 9480.0, 9181.449113053239, 9462.810743785223, 9500.334976551576, 9514.524273786421, 9586.137247647745, 6661.600303981777, 6829.965850170717, 6839.487038472035, 7023.543469674455, 7333.853322933404, 7864.5281283123195, 8056.154103819249, 8065.798355040936, 8072.273495385209, 8072.515649061075, 7217.4586905983315, 7261.201267860637, 7355.227701091522, 7395.852082958419, 7458.291462311072, 7107.715691372287, 7213.2065472799, 7215.025971493781, 7218.639068046682, 7228.674709637974, 6721.899171512334, 6750.763723269662, 6805.455563554805, 6867.416269617139, 6875.415589674733, 4806.543378379049, 4883.3651625288485, 4950.975245123751, 4965.379327584052, 4993.101241776515, 4843.782029808737, 4909.926351104665, 4932.4327702314695, 4935.457099718957, 4966.701997880139], "value": 4442.809152964293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.62653935659125, 313.4608473425708, 318.94737368334216, 322.37298454505964, 323.87045181927226, 4738.086077062599, 5241.266222728821, 5485.067538518451, 5624.493795558394, 5625.746841392137, 4705.952910483942, 4901.2648102784515, 5083.745812709368, 5175.715335656538, 5493.587980901439, 4109.301418758803, 4187.706860519765, 4191.694567987603, 4239.2581298272835, 4244.97877510612, 3223.339215460837, 3525.506429099928, 3880.5731369549326, 4060.045889216032, 4274.935875961863, 3462.342154990544, 4104.220198162339, 4162.063535704473, 4165.875782974848, 4173.707840451169, 3803.904902377435, 4151.605597468236, 4154.293770059097, 4157.62798276568, 4187.706860519765, 3073.631164260303, 3625.2568223514118, 3647.85408583659, 3658.5609726832686, 3665.3952097903816, 4591.104734576759, 4634.675572709912, 5004.599632029465, 5017.974910125463, 5436.477786219864, 4161.334186530171, 4537.727736335831, 4743.549362810528, 4753.762311884427, 4760.285957106427, 5509.5675124467525, 5706.343770466408, 5770.913436298459, 5786.768529258825, 5795.5079315894145, 3334.8156957193078, 3496.370653282408, 3589.892303230881, 3812.5234345706785, 3978.6817054635558, 6028.372339468319, 6045.342567746494, 6063.484603808682, 6066.332703402622, 6115.571909966304, 3866.8646597368956, 3989.162275922089, 3992.7604343739467, 3996.0609256824623, 3999.2201520703184, 3483.529723487297, 3713.3316003119157, 4062.51249850014, 4085.162541678949, 4195.454590903163, 4094.6928980326593, 4654.4414670239785, 4686.055287055834, 4856.125897338513, 4868.050730107666, 4673.3690951721765, 5260.395054568774, 5832.941670583325, 5849.356570777211, 5909.556783241274, 1119.485036883043, 1159.646307876106, 1191.314993878506, 1313.356455336878, 1329.2755448280711, 804.7827086686561, 873.7815546113471, 900.7477906186278, 951.5773917992507, 955.2310390136007, 4846.176150054499, 4859.400220881882, 5212.9739351303, 5229.947700523022, 5251.240834320545, 5146.716930568779, 5179.559737422286, 5370.489803468664, 5634.943650563524, 5723.570732195102, 5110.897782044338, 5174.6377753557645, 5195.922061169085, 5246.947530524722, 5257.211418287287, 2560.7311232320712, 2986.522156454957, 2988.3126880817535, 2989.980120078736, 3013.1412547424316, 5021.6735912165595, 5327.338578743599, 5340.759665815048, 5677.914831277534, 5684.8294551163535, 5087.923681144785, 5501.734601041783, 5786.768529258782, 5819.7012180188585, 5832.504237139806, 5355.955588660174, 5511.118221084687, 5603.467670571289, 5858.0, 5868.67722275279, 5503.596582871342, 5640.294963129609, 5661.801836935852, 5666.291713535808, 5669.0, 4759.7858096386435, 4763.404574428197, 5003.049420610218, 5544.251526043932, 5569.6936668482, 5059.5952323814745, 5364.946350536445, 5805.680687562224, 5821.70891455417, 6229.719662615284, 3435.8282085895107, 3598.082488965297, 3939.428782826417, 4063.9027462585527, 4072.5927407260224, 5215.895682086413, 5263.421023687468, 5336.893262134813, 5637.956977959091, 6115.6330620162935, 4893.748875517302, 5080.822171223989, 5581.218629391969, 5978.730957107027, 6208.9689551551955, 4967.652264341606, 5887.7056147193325, 5959.122876293954, 5969.821015329287, 5985.311689155803, 4569.474510431343, 5624.606277560531, 5672.801451949162, 5717.628354156966, 5798.768049277982, 4510.797014134306, 5867.794627188028, 5888.0, 5922.200502932222, 5952.255968003999, 4856.271559266138, 5629.339117172302, 5682.801101961411, 5813.534917206698, 5815.680137592304], "value": 4115.723549502766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.706150478304, 722.2885457824045, 777.0597576931912, 808.6805711743862, 857.7298151082408, 14802.185879776607, 15123.470678526253, 15351.232438378078, 15513.767293490579, 15531.990420622651, 14070.929645351784, 14090.788638170436, 14201.218932958684, 14211.857881421183, 14228.359723812428, 842.5660784695887, 855.4054931822386, 855.8288342331527, 857.3826844671858, 859.1666083898608, 856.3149480415674, 864.1876635962176, 866.7226487523964, 868.8696695495695, 868.9478631282112, 876.5748611923212, 877.5305211711735, 877.534906499553, 877.9209871111599, 878.6485405837652, 848.4781859156636, 859.2953777902122, 867.9913200868006, 868.2533021601449, 869.5391442535466, 639.1690801957483, 645.0678769178539, 645.6481217736344, 652.5790864892166, 653.8953767397194, 14861.851381486154, 15342.309596068091, 15347.923260383626, 15547.222638868012, 15722.29249683767, 14063.929680351635, 14220.786688199685, 14490.855091449055, 14515.564533064025, 14517.564473065824, 11790.705232369173, 11833.704157396049, 11881.524739010429, 11957.342346170957, 12039.819402708967, 3780.7164462665137, 3790.90522736931, 3814.6566808987322, 3829.3107240696663, 3883.2039431916673, 84746.0, 95894.0, 99044.0, 99214.0, 100571.49714251382, 10598.947005265078, 10919.508622111865, 10932.890671093346, 10949.781004379867, 11252.15608829341, 21430.892845535986, 21622.567548648938, 21690.0, 21705.67441488379, 21729.56540869174, 7908.288254057047, 7981.08217554977, 7984.20157984197, 8034.799130021796, 8063.233992770677, 4390.626796722315, 4402.977985110054, 4477.19410506112, 4493.258612328929, 4546.227141385973, 3468.7051600613727, 3544.149404142987, 3551.662592053751, 3588.5155504006625, 3593.2454184621, 650.5395387355418, 650.8382537171127, 650.853557949467, 658.5554750543364, 660.8810414125503, 595.4759811366057, 667.4893706314673, 667.4993754683987, 681.2574294019444, 729.4529103172621, 8889.977652570038, 9407.576659050359, 9655.889572699089, 9931.900680993098, 10173.338732982333, 547.1027514875607, 593.5311104227698, 597.2504506843883, 645.9580127291711, 679.5684740190015, 3941.7832019238645, 4419.0, 4658.790354434059, 4675.812967481263, 4680.859574212779, 93767.0, 110780.4460977706, 110942.0, 111319.0, 113627.43186284015, 93647.0, 94245.0, 95087.52456237674, 96305.0, 99559.0, 87349.68975465374, 89195.0, 89296.553517232, 91306.08693913108, 92704.90123043163, 8839.51382673959, 8857.822843543221, 8950.283977281671, 8970.910290897269, 9018.774530636787, 52338.0, 54785.72607136939, 55111.0, 55394.44605553893, 55949.72025140011, 70792.93810592742, 77982.0, 78738.0, 81804.0, 81833.59083204546, 10777.955446085443, 11382.0, 11450.885491145315, 11584.536618535165, 11873.346965916957, 12239.449224784728, 12753.171043882117, 12780.808287875876, 12904.095904095904, 12910.354482276036, 11828.763424731285, 12029.879701202875, 12203.511859525519, 12222.327771972627, 12237.449314780679, 11919.015134941683, 12043.0, 12052.397380130784, 12123.151379403356, 12189.878101219228, 11561.190716649753, 11672.416379180837, 11961.820572691591, 12064.879351206375, 12476.688082798002, 10190.898091018995, 10207.897921020694, 10336.586536538454, 10569.097572422846, 10724.73188170302, 10282.0, 10355.94822025885, 10587.629432969808, 10708.089812366035, 11137.387443690352], "value": 7406.923776459073, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 170.0, 121.0, 116.0, 119.0, 125.0, 134.0, 119.0, 117.0, 118.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 110.0, 140.0, 112.0, 112.0, 112.0, 110.0, 134.0, 120.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 194.0, 203.0, 194.0, 196.0, 199.0, 197.0, 197.0, 199.0], "value": 197.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 84.0, 60.0, 60.0, 71.0, 82.0, 102.0, 58.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 101.0, 105.0, 71.0, 69.0, 70.0, 84.0, 69.0, 70.0, 86.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 92.0, 89.0, 92.0, 88.0, 93.0, 91.0, 92.0, 100.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 98.0, 98.0, 97.0, 97.0, 98.0, 97.0, 112.0, 99.0], "value": 107.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 71.0, 141.0, 135.0, 89.0, 90.0, 90.0, 89.0, 87.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 52.0, 83.0, 82.0, 86.0, 62.0, 59.0, 60.0, 58.0, 59.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 72.0, 85.0, 94.0, 105.0, 95.0, 96.0, 96.0, 74.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 83.0, 87.0, 84.0, 84.0, 84.0, 82.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 155.0, 150.0, 157.0, 138.0, 143.0, 156.0, 200.0, 152.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 163.0, 166.0, 166.0, 164.0, 165.0, 171.0, 166.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 65.0, 66.0, 68.0, 64.0, 67.0, 74.0], "value": 66.9, "unit": "score"}]}]} 10:41:46 INFO - Return code: 0 10:41:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:41:46 ERROR - # TBPL SUCCESS # 10:41:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:41:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:41:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:41:46 INFO - 2017-02-01 10:41:46.360 screenresolution[1660:10596] starting screenresolution argv=screenresolution get 10:41:46 INFO - 2017-02-01 10:41:46.363 screenresolution[1660:10596] Display 0: 1600x1200x32@60 10:41:46 INFO - 2017-02-01 10:41:46.369 screenresolution[1661:10599] starting screenresolution argv=screenresolution list 10:41:46 INFO - Available Modes on Display 0 10:41:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:41:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:41:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:41:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:41:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:41:46 INFO - Intel Iris: 10:41:46 INFO - Chipset Model: Intel Iris 10:41:46 INFO - Type: GPU 10:41:46 INFO - Bus: Built-In 10:41:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:41:46 INFO - Vendor: Intel (0x8086) 10:41:46 INFO - Device ID: 0x0a2e 10:41:46 INFO - Revision ID: 0x0009 10:41:46 INFO - Displays: 10:41:46 INFO - Display: 10:41:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:41:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:41:46 INFO - Display Serial Number: 1600x1200 60 10:41:46 INFO - Main Display: Yes 10:41:46 INFO - Mirror: Off 10:41:46 INFO - Online: Yes 10:41:46 INFO - Rotation: Supported 10:41:46 INFO - Return code: 0 10:41:46 INFO - Running post-action listener: _resource_record_post_action 10:41:46 INFO - [mozharness: 2017-02-01 18:41:46.613673Z] Finished run-tests step (success) 10:41:46 INFO - Running post-run listener: _resource_record_post_run 10:41:46 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38725632; Write bytes: 501788160; Read time: 248; Write time: 1609 10:41:46 INFO - TinderboxPrint: CPU usage
54.2% 10:41:46 INFO - TinderboxPrint: I/O read bytes / time
38,725,632 / 248 10:41:46 INFO - TinderboxPrint: I/O write bytes / time
501,788,160 / 1,609 10:41:46 INFO - TinderboxPrint: CPU idle
2,192.8 (45.8%) 10:41:46 INFO - TinderboxPrint: CPU system
967.8 (20.2%) 10:41:46 INFO - TinderboxPrint: CPU user
1,629.2 (34.0%) 10:41:46 INFO - TinderboxPrint: Swap in / out
230,047,744 / 0 10:41:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192426496; Write bytes: 192233472; Read time: 17696; Write time: 406 10:41:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35686400; Write bytes: 307075072; Read time: 226; Write time: 1193 10:41:47 INFO - Running post-run listener: _upload_blobber_files 10:41:47 INFO - Blob upload gear active. 10:41:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:47 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:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:41:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:41:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:41:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:48 INFO - (blobuploader) - INFO - Done attempting. 10:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:41:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:49 INFO - (blobuploader) - INFO - Done attempting. 10:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:51 INFO - (blobuploader) - INFO - Done attempting. 10:41:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:51 INFO - Return code: 0 10:41:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f94d2350c3c2757799ed35ae1306b4aed516f3ce3af28e5ff6cbb5719adb6d792b830dd742c6d9c1d197e8fc7fd3f41391a2b21a4195d8826612846da08549eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffbd98250ba9cdc5fe4006f1520d1ff6e698e37d4dea18b9b2b351090a889e1a6b767bfdfb47bcf410ce5bcf308e146268142d9c60b9f4000639131f5eb31bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f418cb004a7f097930e46cff25c01ed01a373214ca1e4f5f43b26db6a97edfdbd1fcac1584390ed4fcb917c8df8bd9b5021cc30190a30fc58cd6002803355a09"} 10:41:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:51 INFO - Contents: 10:41:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f94d2350c3c2757799ed35ae1306b4aed516f3ce3af28e5ff6cbb5719adb6d792b830dd742c6d9c1d197e8fc7fd3f41391a2b21a4195d8826612846da08549eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffbd98250ba9cdc5fe4006f1520d1ff6e698e37d4dea18b9b2b351090a889e1a6b767bfdfb47bcf410ce5bcf308e146268142d9c60b9f4000639131f5eb31bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f418cb004a7f097930e46cff25c01ed01a373214ca1e4f5f43b26db6a97edfdbd1fcac1584390ed4fcb917c8df8bd9b5021cc30190a30fc58cd6002803355a09"} 10:41:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:51 INFO - Copying logs to upload dir... 10:41:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.881253 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-02-01 10:41:52.163302) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:41:52.170550) ========= 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.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f94d2350c3c2757799ed35ae1306b4aed516f3ce3af28e5ff6cbb5719adb6d792b830dd742c6d9c1d197e8fc7fd3f41391a2b21a4195d8826612846da08549eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffbd98250ba9cdc5fe4006f1520d1ff6e698e37d4dea18b9b2b351090a889e1a6b767bfdfb47bcf410ce5bcf308e146268142d9c60b9f4000639131f5eb31bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f418cb004a7f097930e46cff25c01ed01a373214ca1e4f5f43b26db6a97edfdbd1fcac1584390ed4fcb917c8df8bd9b5021cc30190a30fc58cd6002803355a09"} build_url:https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/WASNDg-tSJCigLzoAWjTuA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f94d2350c3c2757799ed35ae1306b4aed516f3ce3af28e5ff6cbb5719adb6d792b830dd742c6d9c1d197e8fc7fd3f41391a2b21a4195d8826612846da08549eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffbd98250ba9cdc5fe4006f1520d1ff6e698e37d4dea18b9b2b351090a889e1a6b767bfdfb47bcf410ce5bcf308e146268142d9c60b9f4000639131f5eb31bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f418cb004a7f097930e46cff25c01ed01a373214ca1e4f5f43b26db6a97edfdbd1fcac1584390ed4fcb917c8df8bd9b5021cc30190a30fc58cd6002803355a09"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 10:41:52.207378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:41:52.207684) ========= 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.pe32yXN346/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.weL8oNCvtC/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005155 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 10:41:52.255797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:41:52.256085) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 10:41:52.256940) ========= ========= Total master_lag: 0.38 =========