builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0366 starttime: 1477140805.61 results: success (0) buildid: 20161022030204 builduid: 07445e3160354a56b7e3a05d2eb69015 revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:25.611475) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:25.612119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:25.612496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:25.639624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:25.640260) ========= 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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-22 05:53:25-- 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% 159M=0s 2016-10-22 05:53:26 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.954586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.617963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.618333) ========= 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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.025212 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:26.668353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 05:53:26.668753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5639a9f476d08f300c079117e61697f5026b6367 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-22 05:53:26,695 truncating revision to first 12 chars 2016-10-22 05:53:26,695 Setting DEBUG logging. 2016-10-22 05:53:26,695 attempt 1/10 2016-10-22 05:53:26,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5639a9f476d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 05:53:27,870 unpacking tar archive at: mozilla-central-5639a9f476d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.507866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-22 05:53:28.199927) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.200443) ========= script_repo_revision: 5639a9f476d08f300c079117e61697f5026b6367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.201073) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.201513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 05:53:28.220087) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-22 05:53:28.220460) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:53:28 INFO - MultiFileLogger online at 20161022 05:53:28 in /builds/slave/test 05:53:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:53:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:53:28 INFO - {'append_to_log': False, 05:53:28 INFO - 'base_work_dir': '/builds/slave/test', 05:53:28 INFO - 'blob_upload_branch': 'Firefox', 05:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:53:28 INFO - 'branch': 'Firefox', 05:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:53:28 INFO - 'config_files': ('talos/mac_config.py',), 05:53:28 INFO - 'default_actions': ('clobber', 05:53:28 INFO - 'read-buildbot-config', 05:53:28 INFO - 'download-and-extract', 05:53:28 INFO - 'populate-webroot', 05:53:28 INFO - 'create-virtualenv', 05:53:28 INFO - 'install', 05:53:28 INFO - 'run-tests'), 05:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:53:28 INFO - 'download_minidump_stackwalk': True, 05:53:28 INFO - 'download_symbols': 'ondemand', 05:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:53:28 INFO - 'installer_path': 'installer.exe', 05:53:28 INFO - 'log_level': 'info', 05:53:28 INFO - 'log_name': 'talos', 05:53:28 INFO - 'log_to_console': True, 05:53:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:53:28 INFO - 'opt_config_files': (), 05:53:28 INFO - 'pip_index': False, 05:53:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:53:28 INFO - 'cmd': ('bash', 05:53:28 INFO - '-c', 05:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:53:28 INFO - 'enabled': True, 05:53:28 INFO - 'halt_on_failure': False, 05:53:28 INFO - 'name': 'check_screen_resolution'},), 05:53:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:53:28 INFO - 'cmd': ('bash', 05:53:28 INFO - '-c', 05:53:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:53:28 INFO - 'enabled': True, 05:53:28 INFO - 'halt_on_failure': False, 05:53:28 INFO - 'name': 'check_screen_resolution'},), 05:53:28 INFO - 'run_cmd_checks_enabled': True, 05:53:28 INFO - 'sps_profile': False, 05:53:28 INFO - 'sps_profile_interval': 0, 05:53:28 INFO - 'suite': 'dromaeojs-e10s', 05:53:28 INFO - 'system_bits': '32', 05:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:53:28 INFO - 'title': 't-yosemite-r7-0366', 05:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:53:28 INFO - 'use_talos_json': True, 05:53:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:53:28 INFO - 'work_dir': 'build'} 05:53:28 INFO - [mozharness: 2016-10-22 12:53:28.366522Z] Running clobber step. 05:53:28 INFO - Running pre-action listener: _resource_record_pre_action 05:53:28 INFO - Running main action method: clobber 05:53:28 INFO - rmtree: /builds/slave/test/build 05:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:53:30 INFO - Running post-action listener: _resource_record_post_action 05:53:30 INFO - [mozharness: 2016-10-22 12:53:30.607444Z] Finished clobber step (success) 05:53:30 INFO - [mozharness: 2016-10-22 12:53:30.607639Z] Running read-buildbot-config step. 05:53:30 INFO - Running pre-action listener: _resource_record_pre_action 05:53:30 INFO - Running main action method: read_buildbot_config 05:53:30 INFO - Using buildbot properties: 05:53:30 INFO - { 05:53:30 INFO - "project": "", 05:53:30 INFO - "product": "firefox", 05:53:30 INFO - "script_repo_revision": "production", 05:53:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:53:30 INFO - "repository": "", 05:53:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:53:30 INFO - "buildid": "20161022030204", 05:53:30 INFO - "stage_platform": "macosx64", 05:53:30 INFO - "basedir": "/builds/slave/test", 05:53:30 INFO - "nightly_build": "True", 05:53:30 INFO - "buildnumber": 77, 05:53:30 INFO - "slavename": "t-yosemite-r7-0366", 05:53:30 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:53:30 INFO - "platform": "yosemite_r7", 05:53:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:53:30 INFO - "branch": "mozilla-central", 05:53:30 INFO - "repo_path": "mozilla-central", 05:53:30 INFO - "revision": "5639a9f476d08f300c079117e61697f5026b6367", 05:53:30 INFO - "pgo_build": "False", 05:53:30 INFO - "builduid": "07445e3160354a56b7e3a05d2eb69015", 05:53:30 INFO - "slavebuilddir": "test" 05:53:30 INFO - } 05:53:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:53:30 INFO - Running post-action listener: _resource_record_post_action 05:53:30 INFO - [mozharness: 2016-10-22 12:53:30.612025Z] Finished read-buildbot-config step (success) 05:53:30 INFO - [mozharness: 2016-10-22 12:53:30.612162Z] Running download-and-extract step. 05:53:30 INFO - Running pre-action listener: _resource_record_pre_action 05:53:30 INFO - Running main action method: download_and_extract 05:53:30 INFO - mkdir: /builds/slave/test/build/tests 05:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:30 INFO - trying https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:53:30 INFO - Downloading https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:53:31 INFO - Downloaded 1199 bytes. 05:53:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:53:31 INFO - Using the following test package requirements: 05:53:31 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:53:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:53:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:53:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'jsshell-mac.zip'], 05:53:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:53:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:53:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:53:31 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:53:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:53:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:53:31 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:53:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:53:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:53:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:53:31 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:53:32 INFO - Http code: 200 05:53:32 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 05:53:32 INFO - x-amz-cf-id: 0pnFBN1noOfQEV5u18lEEuzvvZmD0AWSc38cIDeCai4F0lOIgrALrA== 05:53:32 INFO - x-amz-version-id: yFC2jzdh.Svr7vFhwcBta3LSeMs9k2l2 05:53:32 INFO - Expected file size: 16420828 05:53:32 INFO - Obtained file size: 16420828 05:53:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:53:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:53:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:53:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:53:39 INFO - Http code: 200 05:53:39 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 05:53:39 INFO - x-amz-cf-id: OPiqQ1Y-82NhmZUIAFy787WefcuGo9ACKyYVdPpTnPkbOIQlNzZSHQ== 05:53:39 INFO - x-amz-version-id: yFC2jzdh.Svr7vFhwcBta3LSeMs9k2l2 05:53:40 INFO - Expected file size: 16420828 05:53:40 INFO - Obtained file size: 16420828 05:53:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:53:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:53:46 INFO - Fetch https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:53:47 INFO - Http code: 200 05:53:47 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:53:47 INFO - x-amz-cf-id: V5wcIIGGKXILWtg1LitQ4n37XoB9dX8cmOiHNFjgiTbl8u6amTSf8Q== 05:53:47 INFO - x-amz-version-id: QTWPGwPIcqkl0tF8hLaFox_x_tt_5QEr 05:53:47 INFO - Expected file size: 14409028 05:53:47 INFO - Obtained file size: 14409028 05:53: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')]} 05:53:48 INFO - trying https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:48 INFO - Downloading https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:53:51 INFO - Downloaded 111469529 bytes. 05:53:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:51 INFO - mkdir: /builds/slave/test/properties 05:53:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:51 INFO - Contents: 05:53:51 INFO - build_url:https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - Running post-action listener: set_extra_try_arguments 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.940515Z] Finished download-and-extract step (success) 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.940653Z] Running populate-webroot step. 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: populate_webroot 05:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:51 INFO - '--tppagecycles', 05:53:51 INFO - '7'], 05:53:51 INFO - 'tests': ['tsvgm']}}, 05:53:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['damp', 'tps']}, 05:53:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['damp', 'tps']}, 05:53:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['dromaeo_dom']}, 05:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['basic_compositor_video']}, 05:53:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['a11yr', 05:53:51 INFO - 'ts_paint', 05:53:51 INFO - 'tpaint', 05:53:51 INFO - 'sessionrestore', 05:53:51 INFO - 'sessionrestore_no_auto_restore', 05:53:51 INFO - 'tabpaint']}, 05:53:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tsvgx', 05:53:51 INFO - 'tsvgr_opacity', 05:53:51 INFO - 'tart', 05:53:51 INFO - 'tscrollx', 05:53:51 INFO - 'cart']}, 05:53:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:51 INFO - 'tsvgr_opacity', 05:53:51 INFO - 'tart', 05:53:51 INFO - 'tscrollx', 05:53:51 INFO - 'cart']}, 05:53:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s'], 05:53:51 INFO - 'tests': ['tp5o']}, 05:53:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'tests': ['tp5o']}, 05:53:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--disable-e10s', 05:53:51 INFO - '--xperf_path', 05:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:51 INFO - 'tests': ['tp5n']}, 05:53:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:51 INFO - 'talos_options': ['--xperf_path', 05:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:51 INFO - 'tests': ['tp5n']}}, 05:53:51 INFO - 'talos.zip': {'path': '', 05:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:51 INFO - Running post-action listener: _resource_record_post_action 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.959742Z] Finished populate-webroot step (success) 05:53:51 INFO - [mozharness: 2016-10-22 12:53:51.959874Z] Running create-virtualenv step. 05:53:51 INFO - Running pre-action listener: _resource_record_pre_action 05:53:51 INFO - Running main action method: create_virtualenv 05:53:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:51 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 05:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:52 INFO - Using real prefix '/tools/python27' 05:53:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:55 INFO - Installing pip.................done. 05:53:55 INFO - Return code: 0 05:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:56 INFO - Reading from file tmpfile_stdout 05:53:56 INFO - Output received: 05:53:56 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) 05:53:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:56 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')]} 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:56 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')]} 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:56 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:53:56 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 05:53:56 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 05:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:56 INFO - 'HOME': '/Users/cltbld', 05:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:56 INFO - 'LOGNAME': 'cltbld', 05:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:56 INFO - 'MOZ_NO_REMOTE': '1', 05:53:56 INFO - 'NO_EM_RESTART': '1', 05:53:56 INFO - 'PAGER': '/bin/cat', 05:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:56 INFO - 'PWD': '/builds/slave/test', 05:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:56 INFO - 'SHELL': '/bin/bash', 05:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:53:56 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:56 INFO - 'USER': 'cltbld', 05:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:56 INFO - 'XPC_FLAGS': '0x0', 05:53:56 INFO - 'XPC_SERVICE_NAME': '0', 05:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:56 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 05:53:56 INFO - Cleaning up... 05:53:56 INFO - Return code: 0 05:53:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:56 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')]} 05:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:56 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')]} 05:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:56 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:53:56 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 05:53:56 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 05:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:56 INFO - 'HOME': '/Users/cltbld', 05:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:56 INFO - 'LOGNAME': 'cltbld', 05:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:56 INFO - 'MOZ_NO_REMOTE': '1', 05:53:56 INFO - 'NO_EM_RESTART': '1', 05:53:56 INFO - 'PAGER': '/bin/cat', 05:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:56 INFO - 'PWD': '/builds/slave/test', 05:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:56 INFO - 'SHELL': '/bin/bash', 05:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:53:56 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:56 INFO - 'USER': 'cltbld', 05:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:56 INFO - 'XPC_FLAGS': '0x0', 05:53:56 INFO - 'XPC_SERVICE_NAME': '0', 05:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:56 INFO - Downloading/unpacking psutil>=3.1.1 05:53:56 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 05:53:56 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 05:53:56 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 05:53:56 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 05:53:56 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 05:53:56 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 05:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:00 INFO - Installing collected packages: psutil 05:54:00 INFO - Running setup.py install for psutil 05:54:00 INFO - building 'psutil._psutil_osx' extension 05:54:00 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 05:54:00 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 05:54:01 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 05:54:01 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 05:54:01 INFO - building 'psutil._psutil_posix' extension 05:54:01 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 05:54:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:54:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:54:01 INFO - ^ 05:54:01 INFO - 1 warning generated. 05:54:01 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 05:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:01 INFO - Successfully installed psutil 05:54:01 INFO - Cleaning up... 05:54:01 INFO - Return code: 0 05:54:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:01 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')]} 05:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:01 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')]} 05:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:01 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:01 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 05:54:01 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 05:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:01 INFO - 'HOME': '/Users/cltbld', 05:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:01 INFO - 'LOGNAME': 'cltbld', 05:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:01 INFO - 'MOZ_NO_REMOTE': '1', 05:54:01 INFO - 'NO_EM_RESTART': '1', 05:54:01 INFO - 'PAGER': '/bin/cat', 05:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:01 INFO - 'PWD': '/builds/slave/test', 05:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:01 INFO - 'SHELL': '/bin/bash', 05:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:01 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:01 INFO - 'USER': 'cltbld', 05:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:01 INFO - 'XPC_FLAGS': '0x0', 05:54:01 INFO - 'XPC_SERVICE_NAME': '0', 05:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:01 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 05:54:01 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 05:54:01 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 05:54:01 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 05:54:01 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 05:54:01 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 05:54:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:04 INFO - Installing collected packages: mozsystemmonitor 05:54:04 INFO - Running setup.py install for mozsystemmonitor 05:54:04 INFO - Successfully installed mozsystemmonitor 05:54:04 INFO - Cleaning up... 05:54:04 INFO - Return code: 0 05:54:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:04 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:04 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 05:54:04 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 05:54:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:04 INFO - 'HOME': '/Users/cltbld', 05:54:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:04 INFO - 'LOGNAME': 'cltbld', 05:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:04 INFO - 'MOZ_NO_REMOTE': '1', 05:54:04 INFO - 'NO_EM_RESTART': '1', 05:54:04 INFO - 'PAGER': '/bin/cat', 05:54:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:04 INFO - 'PWD': '/builds/slave/test', 05:54:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:04 INFO - 'SHELL': '/bin/bash', 05:54:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:04 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:04 INFO - 'USER': 'cltbld', 05:54:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:04 INFO - 'XPC_FLAGS': '0x0', 05:54:04 INFO - 'XPC_SERVICE_NAME': '0', 05:54:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:04 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:04 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 05:54:04 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 05:54:04 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 05:54:04 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 05:54:04 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 05:54:04 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 05:54:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:07 INFO - warning: no files found matching '*.txt' 05:54:07 INFO - no previously-included directories found matching 'build' 05:54:07 INFO - no previously-included directories found matching 'dist' 05:54:07 INFO - no previously-included directories found matching '.git*' 05:54:07 INFO - Installing collected packages: jsonschema, functools32 05:54:07 INFO - Running setup.py install for functools32 05:54:08 INFO - warning: no files found matching '*.txt' 05:54:08 INFO - no previously-included directories found matching 'build' 05:54:08 INFO - no previously-included directories found matching 'dist' 05:54:08 INFO - no previously-included directories found matching '.git*' 05:54:08 INFO - Successfully installed jsonschema functools32 05:54:08 INFO - Cleaning up... 05:54:08 INFO - Return code: 0 05:54:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:54:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:08 INFO - 'HOME': '/Users/cltbld', 05:54:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:08 INFO - 'LOGNAME': 'cltbld', 05:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:08 INFO - 'MOZ_NO_REMOTE': '1', 05:54:08 INFO - 'NO_EM_RESTART': '1', 05:54:08 INFO - 'PAGER': '/bin/cat', 05:54:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:08 INFO - 'PWD': '/builds/slave/test', 05:54:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:08 INFO - 'SHELL': '/bin/bash', 05:54:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:08 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:08 INFO - 'USER': 'cltbld', 05:54:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:08 INFO - 'XPC_FLAGS': '0x0', 05:54:08 INFO - 'XPC_SERVICE_NAME': '0', 05:54:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:08 INFO - Cleaning up... 05:54:08 INFO - Return code: 0 05:54:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:54:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:08 INFO - 'HOME': '/Users/cltbld', 05:54:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:08 INFO - 'LOGNAME': 'cltbld', 05:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:08 INFO - 'MOZ_NO_REMOTE': '1', 05:54:08 INFO - 'NO_EM_RESTART': '1', 05:54:08 INFO - 'PAGER': '/bin/cat', 05:54:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:08 INFO - 'PWD': '/builds/slave/test', 05:54:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:08 INFO - 'SHELL': '/bin/bash', 05:54:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:08 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:08 INFO - 'USER': 'cltbld', 05:54:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:08 INFO - 'XPC_FLAGS': '0x0', 05:54:08 INFO - 'XPC_SERVICE_NAME': '0', 05:54:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:54:12 INFO - Downloading docopt-0.6.1.tar.gz 05:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:12 INFO - Running setup.py install for blobuploader 05:54:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:12 INFO - Running setup.py install for requests 05:54:13 INFO - Running setup.py install for docopt 05:54:13 INFO - Successfully installed blobuploader requests docopt 05:54:13 INFO - Cleaning up... 05:54:13 INFO - Return code: 0 05:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:13 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:13 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 05:54:13 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 05:54:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:13 INFO - 'HOME': '/Users/cltbld', 05:54:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:13 INFO - 'LOGNAME': 'cltbld', 05:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:13 INFO - 'MOZ_NO_REMOTE': '1', 05:54:13 INFO - 'NO_EM_RESTART': '1', 05:54:13 INFO - 'PAGER': '/bin/cat', 05:54:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:13 INFO - 'PWD': '/builds/slave/test', 05:54:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:13 INFO - 'SHELL': '/bin/bash', 05:54:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:13 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:13 INFO - 'USER': 'cltbld', 05:54:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:13 INFO - 'XPC_FLAGS': '0x0', 05:54:13 INFO - 'XPC_SERVICE_NAME': '0', 05:54:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:13 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-NKs7yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:13 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-JPLimH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:13 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-shVRZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:13 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-hU_th4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-6fRcA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-IzOkNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-H5JK89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-OexryU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-XqN_nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-P3vYPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-oQQXa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-T7vZvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-mZMgSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:14 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5ryfBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:15 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-uFL1UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:15 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-9APIYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:15 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-u7JW_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:15 INFO - Running setup.py install for manifestparser 05:54:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Running setup.py install for mozcrash 05:54:15 INFO - Running setup.py install for mozdebug 05:54:15 INFO - Running setup.py install for mozdevice 05:54:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozfile 05:54:16 INFO - Running setup.py install for mozhttpd 05:54:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozinfo 05:54:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozInstall 05:54:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for mozleak 05:54:16 INFO - Running setup.py install for mozlog 05:54:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:16 INFO - Running setup.py install for moznetwork 05:54:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Running setup.py install for mozprocess 05:54:17 INFO - Running setup.py install for mozprofile 05:54:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Running setup.py install for mozrunner 05:54:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Running setup.py install for mozscreenshot 05:54:17 INFO - Running setup.py install for moztest 05:54:17 INFO - Running setup.py install for mozversion 05:54:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:17 INFO - Cleaning up... 05:54:17 INFO - Return code: 0 05:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:17 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')]} 05:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:17 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')]} 05:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:17 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:17 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 05:54:17 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 05:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:17 INFO - 'HOME': '/Users/cltbld', 05:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:17 INFO - 'LOGNAME': 'cltbld', 05:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:17 INFO - 'MOZ_NO_REMOTE': '1', 05:54:17 INFO - 'NO_EM_RESTART': '1', 05:54:17 INFO - 'PAGER': '/bin/cat', 05:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:17 INFO - 'PWD': '/builds/slave/test', 05:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:17 INFO - 'SHELL': '/bin/bash', 05:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:17 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:17 INFO - 'USER': 'cltbld', 05:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:17 INFO - 'XPC_FLAGS': '0x0', 05:54:17 INFO - 'XPC_SERVICE_NAME': '0', 05:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-B1h8HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-5n8zZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-_cDacf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-kLmQ04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-U10tBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-c3oOwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-xDgKij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:18 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)) 05:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:18 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-4w0euy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-k7bCM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-ah0qL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-hLjO4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-vsvqbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-GZOo_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-WONTs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-FGa7ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:19 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)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-SI2YAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:19 INFO - Running setup.py (path:/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/pip-zv543l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:20 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)) 05:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:20 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)) 05:54:20 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)) 05:54:20 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)) 05:54:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54: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 05:54:22 INFO - Downloading blessings-1.6.tar.gz 05:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:22 INFO - Installing collected packages: blessings 05:54:22 INFO - Running setup.py install for blessings 05:54:22 INFO - Successfully installed blessings 05:54:22 INFO - Cleaning up... 05:54:22 INFO - Return code: 0 05:54:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:23 INFO - Reading from file tmpfile_stdout 05:54:23 INFO - Current package versions: 05:54:23 INFO - blessings == 1.6 05:54:23 INFO - blobuploader == 1.2.4 05:54:23 INFO - docopt == 0.6.1 05:54:23 INFO - functools32 == 3.2.3-2 05:54:23 INFO - jsonschema == 2.5.1 05:54:23 INFO - manifestparser == 1.1 05:54:23 INFO - mozInstall == 1.12 05:54:23 INFO - mozcrash == 0.17 05:54:23 INFO - mozdebug == 0.1 05:54:23 INFO - mozdevice == 0.48 05:54:23 INFO - mozfile == 1.2 05:54:23 INFO - mozhttpd == 0.7 05:54:23 INFO - mozinfo == 0.9 05:54:23 INFO - mozleak == 0.1 05:54:23 INFO - mozlog == 3.4 05:54:23 INFO - moznetwork == 0.27 05:54:23 INFO - mozprocess == 0.23 05:54:23 INFO - mozprofile == 0.28 05:54:23 INFO - mozrunner == 6.12 05:54:23 INFO - mozscreenshot == 0.1 05:54:23 INFO - mozsystemmonitor == 0.3 05:54:23 INFO - moztest == 0.7 05:54:23 INFO - mozversion == 1.4 05:54:23 INFO - psutil == 3.1.1 05:54:23 INFO - requests == 1.2.3 05:54:23 INFO - wsgiref == 0.1.2 05:54:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:23 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')]} 05:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 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')]} 05:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:23 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 05:54:23 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 05:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:23 INFO - 'HOME': '/Users/cltbld', 05:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:23 INFO - 'LOGNAME': 'cltbld', 05:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:23 INFO - 'MOZ_NO_REMOTE': '1', 05:54:23 INFO - 'NO_EM_RESTART': '1', 05:54:23 INFO - 'PAGER': '/bin/cat', 05:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:23 INFO - 'PWD': '/builds/slave/test', 05:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:23 INFO - 'SHELL': '/bin/bash', 05:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:23 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:23 INFO - 'USER': 'cltbld', 05:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:23 INFO - 'XPC_FLAGS': '0x0', 05:54:23 INFO - 'XPC_SERVICE_NAME': '0', 05:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 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)) 05:54:23 INFO - Cleaning up... 05:54:23 INFO - Return code: 0 05:54:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:23 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')]} 05:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 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')]} 05:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:23 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 0x108fb8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f2e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba0d874d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, '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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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 05:54:23 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 05:54:23 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 05:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:23 INFO - 'HOME': '/Users/cltbld', 05:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:23 INFO - 'LOGNAME': 'cltbld', 05:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:23 INFO - 'MOZ_NO_REMOTE': '1', 05:54:23 INFO - 'NO_EM_RESTART': '1', 05:54:23 INFO - 'PAGER': '/bin/cat', 05:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:23 INFO - 'PWD': '/builds/slave/test', 05:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:23 INFO - 'SHELL': '/bin/bash', 05:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:23 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:23 INFO - 'USER': 'cltbld', 05:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:23 INFO - 'XPC_FLAGS': '0x0', 05:54:23 INFO - 'XPC_SERVICE_NAME': '0', 05:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:23 INFO - Cleaning up... 05:54:23 INFO - Return code: 0 05:54:23 INFO - Running post-action listener: _resource_record_post_action 05:54:23 INFO - Running post-action listener: _start_resource_monitoring 05:54:23 INFO - Starting resource monitoring. 05:54:23 INFO - [mozharness: 2016-10-22 12:54:23.764295Z] Finished create-virtualenv step (success) 05:54:23 INFO - [mozharness: 2016-10-22 12:54:23.765277Z] Running install step. 05:54:23 INFO - Running pre-action listener: _resource_record_pre_action 05:54:23 INFO - Running main action method: install 05:54:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:24 INFO - Reading from file tmpfile_stdout 05:54:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:24 INFO - Reading from file tmpfile_stdout 05:54:24 INFO - Output received: 05:54:24 INFO - Usage: mozinstall [options] installer 05:54:24 INFO - Options: 05:54:24 INFO - -h, --help show this help message and exit 05:54:24 INFO - -d DEST, --destination=DEST 05:54:24 INFO - Directory to install application into. [default: 05:54:24 INFO - "/builds/slave/test"] 05:54:24 INFO - --app=APP Application being installed. [default: firefox] 05:54:24 INFO - mkdir: /builds/slave/test/build/application 05:54:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:54:58 INFO - Reading from file tmpfile_stdout 05:54:58 INFO - Output received: 05:54:58 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:54:58 INFO - Running post-action listener: _resource_record_post_action 05:54:58 INFO - [mozharness: 2016-10-22 12:54:58.679348Z] Finished install step (success) 05:54:58 INFO - [mozharness: 2016-10-22 12:54:58.679520Z] Running run-tests step. 05:54:58 INFO - Running pre-action listener: _resource_record_pre_action 05:54:58 INFO - Running main action method: run_tests 05:54:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:54:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:54:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:54:58 INFO - 2016-10-22 05:54:58.693 screenresolution[1654:10173] starting screenresolution argv=screenresolution get 05:54:58 INFO - 2016-10-22 05:54:58.696 screenresolution[1654:10173] Display 0: 1600x1200x32@60 05:54:58 INFO - 2016-10-22 05:54:58.702 screenresolution[1655:10175] starting screenresolution argv=screenresolution list 05:54:58 INFO - Available Modes on Display 0 05:54:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:54:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:54:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:54:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:54:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:54:58 INFO - Intel Iris: 05:54:58 INFO - Chipset Model: Intel Iris 05:54:58 INFO - Type: GPU 05:54:58 INFO - Bus: Built-In 05:54:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:54:58 INFO - Vendor: Intel (0x8086) 05:54:58 INFO - Device ID: 0x0a2e 05:54:58 INFO - Revision ID: 0x0009 05:54:58 INFO - Displays: 05:54:58 INFO - Display: 05:54:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:54:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:54:58 INFO - Display Serial Number: 1600x1200 60 05:54:58 INFO - Main Display: Yes 05:54:58 INFO - Mirror: Off 05:54:58 INFO - Online: Yes 05:54:58 INFO - Rotation: Supported 05:54:58 INFO - Return code: 0 05:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:58 INFO - Python 2.7.3 05:54:58 INFO - Return code: 0 05:54:58 INFO - grabbing minidump binary from tooltool 05:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108dccd30>, '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 0x108bf2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dc4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:54:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:54:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:54:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:59 INFO - Return code: 0 05:54:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:54:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:54:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 05:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0366 --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 05:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Clfy8pKWxb/Render', 05:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:54:59 INFO - 'HOME': '/Users/cltbld', 05:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:54:59 INFO - 'LOGNAME': 'cltbld', 05:54:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:59 INFO - 'MOZ_NO_REMOTE': '1', 05:54:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:59 INFO - 'NO_EM_RESTART': '1', 05:54:59 INFO - 'PAGER': '/bin/cat', 05:54:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:59 INFO - 'PWD': '/builds/slave/test', 05:54:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:54:59 INFO - 'SHELL': '/bin/bash', 05:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nEAbHft4rZ/Listeners', 05:54:59 INFO - 'TMPDIR': '/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/', 05:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:54:59 INFO - 'USER': 'cltbld', 05:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:59 INFO - 'XPC_FLAGS': '0x0', 05:54:59 INFO - 'XPC_SERVICE_NAME': '0', 05:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:54:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0366', '--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 05:54:59 INFO - mozversion application_buildid: 20161022030204 05:54:59 INFO - mozversion application_changeset: 5639a9f476d08f300c079117e61697f5026b6367 05:54:59 INFO - mozversion application_display_name: Nightly 05:54:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:59 INFO - mozversion application_name: Firefox 05:54:59 INFO - mozversion application_remotingname: firefox 05:54:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:59 INFO - mozversion application_vendor: Mozilla 05:54:59 INFO - mozversion application_version: 52.0a1 05:54:59 INFO - mozversion platform_buildid: 20161022030204 05:54:59 INFO - mozversion platform_changeset: 5639a9f476d08f300c079117e61697f5026b6367 05:54:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:59 INFO - mozversion platform_version: 52.0a1 05:54:59 INFO - using testdate: 1477140899 05:54:59 INFO - actual date: 1477140899 05:54:59 INFO - starting webserver on 'localhost:49269' 05:54:59 INFO - SUITE-START | Running 2 tests 05:54:59 INFO - TEST-START | dromaeo_css 05:54:59 INFO - operating with platform_type : mac_ 05:54:59 INFO - Initialising browser for dromaeo_css test... 05:54:59 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpPtM_fL/profile http://localhost:49269/getInfo.html) 05:55:02 INFO - PROCESS | 1665 | 2016-10-22 05:55:02.099 plugin-container[1669:10353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x924f, name = 'com.apple.tsm.portname' 05:55:02 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:55:02 INFO - PROCESS | 1665 | 2016-10-22 05:55:02.099 plugin-container[1669:10353] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 05:55:02 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:55:02 INFO - PROCESS | 1665 | 2016-10-22 05:55:02.099 plugin-container[1669:10353] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:55:02 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:55:02 INFO - PROCESS | 1665 | colorDepth:24 05:55:02 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:55:02 INFO - PROCESS | 1665 | __metrics 05:55:02 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 05:55:02 INFO - TEST-INFO | 1665: exit 0 05:55:02 INFO - Browser initialized. 05:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:02 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmpPtM_fL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:05 INFO - PROCESS | 1670 | 2016-10-22 05:55:05.331 plugin-container[1671:10475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:55:05 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:55:05 INFO - PROCESS | 1670 | 2016-10-22 05:55:05.331 plugin-container[1671:10475] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:55:05 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:55:05 INFO - PROCESS | 1670 | 2016-10-22 05:55:05.331 plugin-container[1671:10475] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:55:14 INFO - PROCESS | 1670 | RSS: Main: 236511232 05:55:14 INFO - PROCESS | 1670 | 05:56:04 INFO - PROCESS | 1670 | 1477140964571 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:58:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 05:58:19 INFO - PROCESS | 1670 | RSS: Main: 249171968 05:58:19 INFO - PROCESS | 1670 | 06:01:21 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 06:01:22 INFO - PROCESS | 1670 | RSS: Main: 263348224 06:01:22 INFO - PROCESS | 1670 | 06:04:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 06:04:25 INFO - PROCESS | 1670 | RSS: Main: 268042240 06:04:25 INFO - PROCESS | 1670 | 06:07:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 06:07:27 INFO - PROCESS | 1670 | RSS: Main: 267689984 06:07:27 INFO - PROCESS | 1670 | 06:10:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 06:10:31 INFO - PROCESS | 1670 | RSS: Main: 272961536 06:10:31 INFO - PROCESS | 1670 | 06:13:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 06:13:34 INFO - PROCESS | 1670 | RSS: Main: 275832832 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | __start_tp_report 06:13:34 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 06:13:34 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 06:13:34 INFO - PROCESS | 1670 | |i|pagename|runs| 06:13:34 INFO - PROCESS | 1670 | |0;dojo.html;2786.4705705915876;3352.4133276676575;3365.091425315165;3394.304167645633;3406.9659303406966;5568.805091821782;5572.442755724425;5591.552675785938;5622.634528755628;5634.4928956393915;5501.779928802853;5639.407862174474;5652.858678533028;5656.604037717361;5660.858478538039;5107.616928730342;5183.118869792144;5192.922106168392;5198.714070726109;5215;5175.171972484384;5260.500252476008;5265.236540701596;5267.0256002639635;5341.359036915556;5044.672096313728;5205.6356055075785;5207.6875387476875;5239.895202095956;5257.553107985826;5050.191969284933;5079.466656001104;5143.125668636303;5172.094883395428;5193.143131383317;5129.3075434816565;5131.076406246874;5132.358455193101;5138.871528211825;5180.238718835576;5465.098258787295;5470.480304371078;5538.972305138489;5630.887382252373;5661.490465858093;6094.329623741429;6124.938750612481;6128.63228206309;6193.659348735818;6207.6275423474735;5137.768800403991;6177.629342239435;6209.534284928648;6246.625202487865;6273.686315684197;5138.460461651547;5428.891422171613;5614.971925140389;5705.229793977843;5712.742926568314;6055.666938318434;6206.596571222946;6211.3167551569295;6245.781397651061;6246.281677607042;4109.671226301889;5110.48895110486;5113.53978141969;5978.910316345258;6111.908321375183;4968.627352948471;5508.862278443071;5733.623930256792;6198.287196972406;6224.159738435344;5377.112776391929;5974.40255974399;6064.272287325549;6111;6112.32764395925;6149.3235744068115;6173.783917562864;6206.751729930752;6206.875862482725;6222.502199824004;4142.979285103615;4652;4835.44392394872;4900.117978763786;4904.583110435653;4327.7186982846015;4328.9394098445455;4342.6742994275555;4399.296112621965;4411.1618792429335;4809.879753006203;5722.62802917809;5784.82645520635;5816.447437493516;5875.588708790344;5349.358077030781;6030.939690603125;6175.104609831639;6245.250569931637;6268.811935641938;5629.887402252014;5683.857903552444;5716.485516303553;5831.4168583141345;5838.824835254949;5344.786208551692;5354.678719276856;5384.757685904144;5402.702851343135;5439.755211015514;6229.314775374705;6266.091416744638;6266.342034086355;6274.403931626488;6278.529110316745;6106.1451396803595;6253.874302625571;6267.373262673696;6274.027525733519;6275.403836635513;6214.067889816563;6225.875482490234;6240.656763878031;6273.341299163522;6277.874442511215;6096.1465394845645;6127.8468038297615;6152.138700582012;6158.784442544489;6183.288921774054;6083.726232319645;6101.792513241417;6142.078688196806;6270.341614130451;6279.403456671609;5894.498967587803;5938.851528711817;5981.162637230704;6030.095485677183;6031.306399763907;5923.674197918984;5966.433188847052;5988.910166347596;5995.070764031408;6021.006533922029;5720.656760594377;5764.365919748908;5838.5621078418435;5845.298564172156;5850.0932355484965;5793.652380857162;5863.530917526673;5953.166556681981;6011.068284415923;6046.455818976313;5891.617044892068;5898.1152827076285;5927.14056461802;5930.495907847881;5935.109733540004 06:13:34 INFO - PROCESS | 1670 | |1;ext.html;444.53324009789714;464.9976750116253;515.7601715202431;520.0457161109364;534.110705675051;38648.61351386485;40013;40139.79930100353;40146.39780403296;42654.786726066326;35551.82224088876;38967.41548876769;42066;42088;43771.56228437715;9458.574364153596;9474.999999999984;9616.951915240448;9652.710418687415;9665.903340966606;7374.926250737504;9420.905790942106;9545.570449329796;9576.664816731416;9579.80840383192;9569.186619137381;9584.329096963216;9590.472524011177;9591.040895910422;9615.086566776145;9438.244940404751;9545.952270238638;9567.808643827155;9591.472469014201;9595.136437720568;9494.098060684224;9561.043895610383;9603.039696030412;9622.518874056339;9626.66306679263;38966.61033389687;39097.022574435585;39493.40759888604;39524.80237598823;39604.60395396038;3506.561679790026;3592.1378869071236;3709.6661300482815;3852.5569559500736;4082.9795851020854;29526.70473295261;30551.694483055107;30784.922527711646;30966.535501967264;30972.690273097207;3021.561873528326;3112.6109236345455;3186.617605887285;3187.235063584746;3207.3585282943504;478619;479903;485229;487333.99999999645;488183;56397;56908.43091569114;57092;57200;57239.42760572341;59681.701591491765;59717.70141149353;59827.401725982185;60112.39887601155;60231;15443.150626715415;15717.528474145794;15724.213789310488;15757.606059848365;15761.763573546406;10279.640212592672;12155.027597792156;12161.939190303992;12197;12217.144799863925;13667.863321366858;14310.427582896777;14635.926820366043;14785.852141478448;14876.330565124596;3092.567040614316;3184.172115250052;6448.9355106449275;6569.737210511622;6587.50593705474;861.8965724113021;879.7360791762574;1010.1363334349172;1012.7974405119006;1047.5809676129456;24994.625080623806;27138.45723085527;29960.550591741143;30184.849075754482;30674.53988190179;980.4656462228103;1078.2182917384832;1083.3012706804068;1124.8256520239377;1212.5816593275306;15059.322330495153;15441.382344706086;15510.767338489932;15610;16071.678566428605;638046;638341;640332;645314;645667;56745.7162714192;57321.71339143361;57548;57589.712051440314;57656.42343576511;1353.1204716934071;1386.202933313349;1395.699924516234;1408.478862820763;1409.4784929576122;26843.86578067097;27364.042258520858;27772.72227277782;29784.702152978192;30423.935162269216;48870.75564622296;49109.75445122751;49471.75264123656;49553;49593;485361;486052;578465;579045;580520.0973995103;21831.78168218361;24425.9237964775;25342.873285633454;25530.489390212464;25864.612030819175;46187.538124618324;46720.29919551141;47114.82212944567;47152.056958861314;47417.28874066961;33943;37387.252254955296;38466.80766596149;39624.603753963245;39716.2056758869;34253;38092;38655.43717635864;38954;39042.80478597589;31178.388727675305;32063;33245.50131747977;34393.484097739056;35873;27102.72897271081;34292.657073429946;34516;34601.65398346085;34835.825820870734;24248.272551823473;24515.632265515676;25004;25012.62481062749;25394.619080713434 06:13:34 INFO - PROCESS | 1670 | |2;jquery.html;366.3387585408337;374.21601744345594;378.8579282768962;382.220270647878;400.83766074739725;19053;19754.90122549389;20492.590148197047;20608.793912060893;20640.48398790031;15707.84292157081;19989.900050499764;20478.488037799027;20964;21223.787762122374;5259.526642602165;5629.774809007635;5801.274840644919;5805.01314776489;5889.6171748836405;3824.2542704172697;5941.821745347646;5984.5511586630955;6001.2498437695285;6024.283079322394;3998.7603842808676;4613.331066995283;5937.2578427696535;5980.983232850404;6057.182280392135;5808.186853840466;5946;5964.642121472704;6016.518678505709;6042.486388656969;5774.422557744234;5776.508996735282;5779.682117483537;5809.535237181058;5813.244278243844;13172.209667419986;18763.90618046915;24674.889629966696;24861.638144376255;25422.36444088894;2051.148773259096;2106.304919376602;2130.62714025045;2142.1110239250693;2150.709654196679;7606.961965190194;10080.596776128947;10332.380057196593;11626;15901.443449479328;1824.7262910563388;1862.9441116766518;1881.5766452548066;1895.2134864031411;1926.7994877750925;113563;120396;120809.79190208162;125415.3729231348;128228.35885820512;10959.561617535368;11349.148813838996;11495.942520287512;11576.353448663644;11833.349165795791;14433.35049922756;14439.85560144385;14466.782998255034;14474.421023159166;14502.419903203965;6917.792466226021;7298.56208627484;8132.227438393344;8433.728924414962;8503.277221436247;6683.365080317362;8360.581970901552;8363.330933525303;8522.147785221428;8534.78663033429;4449.466064072332;4503.054358584734;4514.593686568224;4559.270516717309;4603.838865639754;1889.952751181204;1934.1296416612581;1934.6517626827306;1936.1674479973465;1965.705144228377;330.993380132396;374.31313539654496;379.4270651316477;406.1714103229379;437.0101719605097;11686.532538698528;11880.584179553847;12009.339486328161;12105.636830895088;12181.634550963485;405.4526389374321;430.96983211175547;432.34931428200986;434.9195398851223;438.98244070237473;6085.726142323606;6108.602940808833;6149.385061493815;6259.4679452246155;6270.9372906270355;546063;560181;584278;586020;587168;134904;139927.30036349752;142223;144706;145692.27153864375;357.8926322103359;439.3585365366537;439.56263517799357;439.95820397062226;442.8937055106751;9154.35221660081;11319.288034920428;11370.090392768725;11384.715382115513;11662.475188616701;51712.74143629258;54495.72752136214;54724.90550188894;56091.9860765985;59706;58067.70966145142;74339;80208.79686804819;85628;86307.56846215729;6987.266337034742;7355.227701091522;7388.445866559922;7816.10114836801;8389;10222.846657300295;11707.824382634437;12037.458314375699;13357.13178643385;13399;9758.121769040821;9775.706728798148;10995.065419439117;11187.16096292765;11280.435978201222;10534.894651053391;11069.833952490559;11071.83392249133;11201.71995700114;11249;11425.485853136795;11460.197786155222;11606.040459682727;11821.586244481401;11879.703007424883;7426.405887529093;7478.663460144197;7481.588512631857;7583.469157158946;7617.619119043915;8341.666333346599;10951.288166269167;11283.323000619988;11291.209615326849;11428.657140285804 06:13:34 INFO - PROCESS | 1670 | |3;mootools.html;1530.981897038469;1574.4332040465433;1704.0542498913114;1804.1340156724773;1910.5032691500205;7441.293077157675;7883.724069657549;8148.796280093001;8886.333524985635;8898.555072246387;8381.371397145209;8670.393072484929;8700.173483519071;8779.29765618749;8804.55977201139;2265.8300627452923;2302.6200676888293;2306.9423264418356;2309.2725791375747;2311.2141871763597;2257.898394572248;2299.839011269212;2316.3166865774638;2317.432229103872;2321.686572312733;2281.7946384825364;2299.287220961499;2306.6194077977116;2332.8367014309006;2338.4270853640796;2257.401788526042;2270.2735124760084;2283.862968221904;2285.5771682238674;2297.1959814065026;2283.920062797794;2287.4395773035544;2290.6907567478343;2291.873946932918;2301.4361481436986;8797.076306987738;8801.295896328278;8812.779680507974;8815.51514666693;8866.822663546758;4478.94744734987;5128.794848206067;5275.657082289639;5298.470152984709;5311.62818602698;3432.6910578047846;3500.1074725944977;3592.8742494012586;3631.9818400907825;3633.854645814164;1022.3405903192399;1045.7281106912183;1054.899784520477;1066.7493139112303;1071.8669847004483;11433.59982400612;11439.428028598537;11457.942710286396;11534.250273732181;11584.362860042695;4396.516383197845;4438.178936896685;4601.631869450436;4613.838515651936;4660.86017419478;9793;9865.408075515492;9889.011098890054;9902;9916.702498925044;4472.955270447319;5232;5240.371155461293;5248.265242866002;5254.106801843695;3617.7829330239742;4328.156009578165;4769.809207631656;4774.092922344744;4806.687565308243;3208.4866421372467;3252.512123181494;3336.0992532016703;3813.84744610218;3912.7065470089856;1243.7450322683828;1258.182181581979;1264.9241045537296;1266.7276535544902;1267.2333238390825;766.4404984361447;788.8461749958703;833.9291160251325;864.5590748718199;939.1031564855547;5441.374241962225;5605.523530499871;5937;5939.22790037301;5968.9701551492835;374.9493818334544;406.8087998640634;424.23849190702765;427.79038271246867;430.4017415792052;3494.899106781356;3594.2272411431145;3954.584768599313;3983.64147226751;4021.959780402217;10375.688729338131;10665.520051597698;10773.892261077446;10778.892211077946;10792;10284.640037598649;10689;10716.303440276357;10729.517171727291;10732.78534429307;8010.679572817138;8287.254147126787;8295;8312.750617481484;8326.875096873551;5614.203454894395;5701.7434215461235;5752.597318187687;5822.883542329215;5856.648601083949;10006.749831253986;10017.899821001696;10024.298299118991;10044.497775111362;10075.294729368874;9740.220782337254;9903.306768526134;10081.69754907354;10186.490675466346;10252.333598316085;6856.485763567653;7092.148942126978;7379.852402951804;7448.068991376078;7529.397648188023;6683.966580167068;8345.332373410234;8356.791080223044;8454.66181352739;8508.936382952132;7349.375303099083;7493.9883115778675;7526.924730752622;7606.04924384452;7610.353119984642;7353.080864891888;7353.117625884928;7377.557346559223;7422.294881986203;7535.284148005931;6798.898016529855;6891.896621550581;6897.7585784497305;6975.755848545276;6980.546264492792;4923.507649235048;4980.651354405157;4987.055048531149;5029.245613158056;5045.31888195089;4233.428487154195;4824.179889418737;4858.271259311132;5004.3494345734825;5142.151544995034 06:13:34 INFO - PROCESS | 1670 | |4;prototype.html;269.4180569968867;295.7604340484208;310.13627048669446;313.49370766212576;314.50151509856875;4561.22459181939;5298.4436634153435;5473.233747275384;5487.6981766002855;5577.247071645332;4548.613367863727;5404.702741349224;5470.753816078276;5490.423505531921;5500.614956953005;3872.5159355080614;4184.665226781865;4198.769067701275;4205.705600607958;4219.9578004219875;4103.220388126247;4150.626443620074;4153.605407486284;4255.489301298041;4270.818240410898;3687.815609219528;3873.3802591585354;4140.937885931713;4163.604457576525;4169.874903752877;3492.301539692059;4123.958760412417;4158.126793373395;4174.686898482626;4198.307279298912;3652;3653.853845846163;3657.3965295726175;3657.5976642569294;3692.280005398948;4991.650584459089;5032.295478632995;5206.7917283308625;5349.946500534984;5367.919481207785;4835.734034628094;4836.588889944359;4853.19922212838;4859.246816743411;4879.974810453693;4842.757862106916;5160.870978225536;5421.861409104093;5765.88468230633;5849.841085813656;3672.669459748609;3834.8657796976972;3912.5891781363116;4014.237294913957;4016.0562267867026;5551.639143455663;5818.5636077294375;5859.326177489601;6153.569250152491;6171.253792062534;3626.673599376069;4102.835886564564;4116.361963895601;4121.216968775923;4121.825279795244;3758.699304055669;4021.235965166609;4026.9060088753686;4039.73741706794;4164.083901541656;4280.743155410623;4303.74177549348;4565.246734288871;4704.435467743892;4705.7647117644665;4624.676272660949;4763.975310493096;5055;5777.62445441045;5819.31239940421;1267.7591257661015;1287.6330245879878;1329.2954733991;1336.191604079518;1355.783074708042;860.2515811244258;889.6352495476823;917.206616276929;921.1525396634978;931.2596485793811;4836.806527738921;5057.342545469139;5469.589780766459;5470.781168753205;5475.6440831345835;5910.408959104056;5952.107183922446;5954.37479064692;5975.7609695612555;5993.430624090704;4597.712640460676;4893.584045356113;5351.785928562814;5428.4028756836715;5517.682573319215;3150.842457877097;3168.98415507921;3177.714005739448;3179.7582704193487;3187.2031992002;5808.82573522795;5968.432998865101;6270.529710271748;6277;6283.434490895841;5292.682439053592;5853;6029.487493563009;6136.171616831671;6177.567570270038;5810.924978878921;6363.854506188838;6366.713497892606;6452.322506136788;6462.806115816533;5612.466815652507;5629.380768115586;5967.403259673998;6079.787207447718;6126.343978576225;5104.132297509506;5255.842324730112;5473.233747275464;5708.372079071216;5724.4561766632105;5235.790568377222;5291.867703307448;5986.970065149646;6370.299267080525;6442.259140198749;3494.423420135649;3692.9076773080888;3920.2355540669296;3993.381025940984;4040.4949381327333;5848.385919478394;6076.483498902643;6132.202813634199;6179.134921110958;6186.783462578788;5449.8827740312345;5646.830595082154;5715.5713321500225;5820.31210948837;5855.707214639337;4817.542333478314;5424.294841670716;5559.861003474945;5836.299644042742;5857;5081.754970032366;5275.366955965309;5367.973160134175;5368.865778355573;5746.138079287973;5367.490088441592;5601.719914004365;5903.317554496948;5909.70451477433;5960.761569537343;4731.69243999139;5099.158638824552;5726.656400615976;5754.6547207167705;5766.682832444256 06:13:34 INFO - PROCESS | 1670 | |5;yui.html;629.4505668519059;686.8626274745052;724.2550732722976;775.2170307988929;827.8427098851217;12263.632091037261;16110.919445402786;16256;16289;16333.183340832955;15565.533034008999;16217.675646487092;16278.104704241263;16504.33982640696;16618;720.6612891940792;867.2931560777946;869.8999615044256;899.653633351158;905.2622112977901;658.2857599504543;674.1943377663694;699.2937133495155;892.3931726426027;895.0914821456228;905.1627244798535;924.154398725169;940.8447606144978;942.3921570586967;942.7313215733517;900.6487469886716;906.5376657904483;926.8702381666573;940.8541676040225;945.744648944788;572.9629370838795;632.7816903168399;667.2260178193272;679.0188178082673;700.3276854219955;15877;15887.60280992973;15992.12043337616;16008.19959002057;16013.35946562136;14232.28838558068;14240.857591424161;14264.429422823074;14312.64218394538;14441.927790361085;11903.94048029763;12034.939825300817;12042.217255878428;12069;12123.454444549929;3748.775073495599;3759.7368184227116;3762.4168253920684;3768.434734789776;3906.101596632762;93246.53376733072;96279.9999999993;113623.29565056531;118282.4404583359;121462.392688036;10569.154467642571;10842.241043127064;10917.617883374043;10931.18016148792;11296.6046188383;22394.664080038812;22624.773752262266;22643.981020854102;22700.545989080125;22713.432164196027;7836.725714599962;7897.407694422941;7979.601019948979;8010.5994700264755;8053.993250843644;4347.5652434756275;4382;4391.978040109779;4458.175237581057;4463.263561512379;3104.239461331988;3472.461768425898;3584.408572585546;3599.640035996432;3602.153493928977;646.3665607704476;647.4237928243866;666.976655817044;673.6227712481026;674.0731494195481;638.7764282501088;661.3419647450817;663.5288944849115;668.2548957911894;683.1528904158807;9269.768255793659;9356.298277629205;9479.857802132974;9485.810283794286;9706.126448619658;636.2682914648192;662.6719773712043;666.4601672645173;676.905233267343;687.3435868745336;4406.559344065632;4621.930671039937;4628.629709623222;4642.094791515622;4680.3447517347595;156913;159031.409685904;160067;162564;165306;92609;133536.33231833778;135196;135423;136287;91647;97848.51075744575;100374.4981275089;103158;104707.99999999847;9359.251259899056;9613;9649.276304277348;9662.516874156405;9774.902250977684;60353.69823150856;60553.39446605654;61421;62184.756304872746;63681;64840.949652803894;72606.54786904338;79024.60487697755;82176;98185.01814981758;13153.736925261632;13216.933915330363;13243.536476223286;13405.396757146147;13502.662433439242;14807.057597339923;14952.850471495582;15057.924710376377;15085.922998622873;15276.15981121049;13324.666883327995;13641.522546710818;13773;14146.858531414555;14275.785863212268;13609.591712248648;13625.250611216477;13676.042677012514;13722.176669399869;13729.794053089012;12074.27554346742;13417;13558.322083895962;13667.838233749844;13747.793783093462;10766.407847568458;11151;11346.659600212008;11436.19946603763;11511.963923246947;9544.062352150147;10056.34633748804;11438.337109017899;11577.768444631229;11593.6521904343 06:13:34 INFO - PROCESS | 1670 | __end_tp_report 06:13:34 INFO - PROCESS | 1670 | __start_cc_report 06:13:34 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,369 06:13:34 INFO - PROCESS | 1670 | __end_cc_report 06:13:34 INFO - PROCESS | 1670 | __startTimestamp1477142014038__endTimestamp 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | ------- Summary: start ------- 06:13:34 INFO - PROCESS | 1670 | Number of tests: 6 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5618.26 Median:5793.65 stddev:660.83 (11.4%) stddev-sans-first:624.40 06:13:34 INFO - PROCESS | 1670 | Values: 2786.5 3352.4 3365.1 3394.3 3407.0 5568.8 5572.4 5591.6 5622.6 5634.5 5501.8 5639.4 5652.9 5656.6 5660.9 5107.6 5183.1 5192.9 5198.7 5215.0 5175.2 5260.5 5265.2 5267.0 5341.4 5044.7 5205.6 5207.7 5239.9 5257.6 5050.2 5079.5 5143.1 5172.1 5193.1 5129.3 5131.1 5132.4 5138.9 5180.2 5465.1 5470.5 5539.0 5630.9 5661.5 6094.3 6124.9 6128.6 6193.7 6207.6 5137.8 6177.6 6209.5 6246.6 6273.7 5138.5 5428.9 5615.0 5705.2 5712.7 6055.7 6206.6 6211.3 6245.8 6246.3 4109.7 5110.5 5113.5 5978.9 6111.9 4968.6 5508.9 5733.6 6198.3 6224.2 5377.1 5974.4 6064.3 6111.0 6112.3 6149.3 6173.8 6206.8 6206.9 6222.5 4143.0 4652.0 4835.4 4900.1 4904.6 4327.7 4328.9 4342.7 4399.3 4411.2 4809.9 5722.6 5784.8 5816.4 5875.6 5349.4 6030.9 6175.1 6245.3 6268.8 5629.9 5683.9 5716.5 5831.4 5838.8 5344.8 5354.7 5384.8 5402.7 5439.8 6229.3 6266.1 6266.3 6274.4 6278.5 6106.1 6253.9 6267.4 6274.0 6275.4 6214.1 6225.9 6240.7 6273.3 6277.9 6096.1 6127.8 6152.1 6158.8 6183.3 6083.7 6101.8 6142.1 6270.3 6279.4 5894.5 5938.9 5981.2 6030.1 6031.3 5923.7 5966.4 5988.9 5995.1 6021.0 5720.7 5764.4 5838.6 5845.3 5850.1 5793.7 5863.5 5953.2 6011.1 6046.5 5891.6 5898.1 5927.1 5930.5 5935.1 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:68274.28 Median:39295.22 stddev:149809.66 (381.2%) stddev-sans-first:150143.35 06:13:34 INFO - PROCESS | 1670 | Values: 444.5 465.0 515.8 520.0 534.1 38648.6 40013.0 40139.8 40146.4 42654.8 35551.8 38967.4 42066.0 42088.0 43771.6 9458.6 9475.0 9617.0 9652.7 9665.9 7374.9 9420.9 9545.6 9576.7 9579.8 9569.2 9584.3 9590.5 9591.0 9615.1 9438.2 9546.0 9567.8 9591.5 9595.1 9494.1 9561.0 9603.0 9622.5 9626.7 38966.6 39097.0 39493.4 39524.8 39604.6 3506.6 3592.1 3709.7 3852.6 4083.0 29526.7 30551.7 30784.9 30966.5 30972.7 3021.6 3112.6 3186.6 3187.2 3207.4 478619.0 479903.0 485229.0 487334.0 488183.0 56397.0 56908.4 57092.0 57200.0 57239.4 59681.7 59717.7 59827.4 60112.4 60231.0 15443.2 15717.5 15724.2 15757.6 15761.8 10279.6 12155.0 12161.9 12197.0 12217.1 13667.9 14310.4 14635.9 14785.9 14876.3 3092.6 3184.2 6448.9 6569.7 6587.5 861.9 879.7 1010.1 1012.8 1047.6 24994.6 27138.5 29960.6 30184.8 30674.5 980.5 1078.2 1083.3 1124.8 1212.6 15059.3 15441.4 15510.8 15610.0 16071.7 638046.0 638341.0 640332.0 645314.0 645667.0 56745.7 57321.7 57548.0 57589.7 57656.4 1353.1 1386.2 1395.7 1408.5 1409.5 26843.9 27364.0 27772.7 29784.7 30423.9 48870.8 49109.8 49471.8 49553.0 49593.0 485361.0 486052.0 578465.0 579045.0 580520.1 21831.8 24425.9 25342.9 25530.5 25864.6 46187.5 46720.3 47114.8 47152.1 47417.3 33943.0 37387.3 38466.8 39624.6 39716.2 34253.0 38092.0 38655.4 38954.0 39042.8 31178.4 32063.0 33245.5 34393.5 35873.0 27102.7 34292.7 34516.0 34601.7 34835.8 24248.3 24515.6 25004.0 25012.6 25394.6 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33971.22 Median:379.14 stddev:96567.42 (25470.0%) stddev-sans-first:96805.35 06:13:34 INFO - PROCESS | 1670 | Values: 366.3 374.2 378.9 382.2 400.8 19053.0 19754.9 20492.6 20608.8 20640.5 15707.8 19989.9 20478.5 20964.0 21223.8 5259.5 5629.8 5801.3 5805.0 5889.6 3824.3 5941.8 5984.6 6001.2 6024.3 3998.8 4613.3 5937.3 5981.0 6057.2 5808.2 5946.0 5964.6 6016.5 6042.5 5774.4 5776.5 5779.7 5809.5 5813.2 13172.2 18763.9 24674.9 24861.6 25422.4 2051.1 2106.3 2130.6 2142.1 2150.7 7607.0 10080.6 10332.4 11626.0 15901.4 1824.7 1862.9 1881.6 1895.2 1926.8 113563.0 120396.0 120809.8 125415.4 128228.4 10959.6 11349.1 11495.9 11576.4 11833.3 14433.4 14439.9 14466.8 14474.4 14502.4 6917.8 7298.6 8132.2 8433.7 8503.3 6683.4 8360.6 8363.3 8522.1 8534.8 4449.5 4503.1 4514.6 4559.3 4603.8 1890.0 1934.1 1934.7 1936.2 1965.7 331.0 374.3 379.4 406.2 437.0 11686.5 11880.6 12009.3 12105.6 12181.6 405.5 431.0 432.3 434.9 439.0 6085.7 6108.6 6149.4 6259.5 6270.9 546063.0 560181.0 584278.0 586020.0 587168.0 134904.0 139927.3 142223.0 144706.0 145692.3 357.9 439.4 439.6 440.0 442.9 9154.4 11319.3 11370.1 11384.7 11662.5 51712.7 54495.7 54724.9 56092.0 59706.0 58067.7 74339.0 80208.8 85628.0 86307.6 6987.3 7355.2 7388.4 7816.1 8389.0 10222.8 11707.8 12037.5 13357.1 13399.0 9758.1 9775.7 10995.1 11187.2 11280.4 10534.9 11069.8 11071.8 11201.7 11249.0 11425.5 11460.2 11606.0 11821.6 11879.7 7426.4 7478.7 7481.6 7583.5 7617.6 8341.7 10951.3 11283.3 11291.2 11428.7 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5612.10 Median:4607.74 stddev:3219.11 (69.9%) stddev-sans-first:3213.53 06:13:34 INFO - PROCESS | 1670 | Values: 1531.0 1574.4 1704.1 1804.1 1910.5 7441.3 7883.7 8148.8 8886.3 8898.6 8381.4 8670.4 8700.2 8779.3 8804.6 2265.8 2302.6 2306.9 2309.3 2311.2 2257.9 2299.8 2316.3 2317.4 2321.7 2281.8 2299.3 2306.6 2332.8 2338.4 2257.4 2270.3 2283.9 2285.6 2297.2 2283.9 2287.4 2290.7 2291.9 2301.4 8797.1 8801.3 8812.8 8815.5 8866.8 4478.9 5128.8 5275.7 5298.5 5311.6 3432.7 3500.1 3592.9 3632.0 3633.9 1022.3 1045.7 1054.9 1066.7 1071.9 11433.6 11439.4 11457.9 11534.3 11584.4 4396.5 4438.2 4601.6 4613.8 4660.9 9793.0 9865.4 9889.0 9902.0 9916.7 4473.0 5232.0 5240.4 5248.3 5254.1 3617.8 4328.2 4769.8 4774.1 4806.7 3208.5 3252.5 3336.1 3813.8 3912.7 1243.7 1258.2 1264.9 1266.7 1267.2 766.4 788.8 833.9 864.6 939.1 5441.4 5605.5 5937.0 5939.2 5969.0 374.9 406.8 424.2 427.8 430.4 3494.9 3594.2 3954.6 3983.6 4022.0 10375.7 10665.5 10773.9 10778.9 10792.0 10284.6 10689.0 10716.3 10729.5 10732.8 8010.7 8287.3 8295.0 8312.8 8326.9 5614.2 5701.7 5752.6 5822.9 5856.6 10006.7 10017.9 10024.3 10044.5 10075.3 9740.2 9903.3 10081.7 10186.5 10252.3 6856.5 7092.1 7379.9 7448.1 7529.4 6684.0 8345.3 8356.8 8454.7 8508.9 7349.4 7494.0 7526.9 7606.0 7610.4 7353.1 7353.1 7377.6 7422.3 7535.3 6798.9 6891.9 6897.8 6975.8 6980.5 4923.5 4980.7 4987.1 5029.2 5045.3 4233.4 4824.2 4858.3 5004.3 5142.2 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4688.92 Median:5265.60 stddev:1447.32 (27.5%) stddev-sans-first:1412.86 06:13:34 INFO - PROCESS | 1670 | Values: 269.4 295.8 310.1 313.5 314.5 4561.2 5298.4 5473.2 5487.7 5577.2 4548.6 5404.7 5470.8 5490.4 5500.6 3872.5 4184.7 4198.8 4205.7 4220.0 4103.2 4150.6 4153.6 4255.5 4270.8 3687.8 3873.4 4140.9 4163.6 4169.9 3492.3 4124.0 4158.1 4174.7 4198.3 3652.0 3653.9 3657.4 3657.6 3692.3 4991.7 5032.3 5206.8 5349.9 5367.9 4835.7 4836.6 4853.2 4859.2 4880.0 4842.8 5160.9 5421.9 5765.9 5849.8 3672.7 3834.9 3912.6 4014.2 4016.1 5551.6 5818.6 5859.3 6153.6 6171.3 3626.7 4102.8 4116.4 4121.2 4121.8 3758.7 4021.2 4026.9 4039.7 4164.1 4280.7 4303.7 4565.2 4704.4 4705.8 4624.7 4764.0 5055.0 5777.6 5819.3 1267.8 1287.6 1329.3 1336.2 1355.8 860.3 889.6 917.2 921.2 931.3 4836.8 5057.3 5469.6 5470.8 5475.6 5910.4 5952.1 5954.4 5975.8 5993.4 4597.7 4893.6 5351.8 5428.4 5517.7 3150.8 3169.0 3177.7 3179.8 3187.2 5808.8 5968.4 6270.5 6277.0 6283.4 5292.7 5853.0 6029.5 6136.2 6177.6 5810.9 6363.9 6366.7 6452.3 6462.8 5612.5 5629.4 5967.4 6079.8 6126.3 5104.1 5255.8 5473.2 5708.4 5724.5 5235.8 5291.9 5987.0 6370.3 6442.3 3494.4 3692.9 3920.2 3993.4 4040.5 5848.4 6076.5 6132.2 6179.1 6186.8 5449.9 5646.8 5715.6 5820.3 5855.7 4817.5 5424.3 5559.9 5836.3 5857.0 5081.8 5275.4 5368.0 5368.9 5746.1 5367.5 5601.7 5903.3 5909.7 5960.8 4731.7 5099.2 5726.7 5754.7 5766.7 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:24593.85 Median:3761.08 stddev:39459.04 (1049.1%) stddev-sans-first:39528.71 06:13:34 INFO - PROCESS | 1670 | Values: 629.5 686.9 724.3 775.2 827.8 12263.6 16110.9 16256.0 16289.0 16333.2 15565.5 16217.7 16278.1 16504.3 16618.0 720.7 867.3 869.9 899.7 905.3 658.3 674.2 699.3 892.4 895.1 905.2 924.2 940.8 942.4 942.7 900.6 906.5 926.9 940.9 945.7 573.0 632.8 667.2 679.0 700.3 15877.0 15887.6 15992.1 16008.2 16013.4 14232.3 14240.9 14264.4 14312.6 14441.9 11903.9 12034.9 12042.2 12069.0 12123.5 3748.8 3759.7 3762.4 3768.4 3906.1 93246.5 96280.0 113623.3 118282.4 121462.4 10569.2 10842.2 10917.6 10931.2 11296.6 22394.7 22624.8 22644.0 22700.5 22713.4 7836.7 7897.4 7979.6 8010.6 8054.0 4347.6 4382.0 4392.0 4458.2 4463.3 3104.2 3472.5 3584.4 3599.6 3602.2 646.4 647.4 667.0 673.6 674.1 638.8 661.3 663.5 668.3 683.2 9269.8 9356.3 9479.9 9485.8 9706.1 636.3 662.7 666.5 676.9 687.3 4406.6 4621.9 4628.6 4642.1 4680.3 156913.0 159031.4 160067.0 162564.0 165306.0 92609.0 133536.3 135196.0 135423.0 136287.0 91647.0 97848.5 100374.5 103158.0 104708.0 9359.3 9613.0 9649.3 9662.5 9774.9 60353.7 60553.4 61421.0 62184.8 63681.0 64840.9 72606.5 79024.6 82176.0 98185.0 13153.7 13216.9 13243.5 13405.4 13502.7 14807.1 14952.9 15057.9 15085.9 15276.2 13324.7 13641.5 13773.0 14146.9 14275.8 13609.6 13625.3 13676.0 13722.2 13729.8 12074.3 13417.0 13558.3 13667.8 13747.8 10766.4 11151.0 11346.7 11436.2 11512.0 9544.1 10056.3 11438.3 11577.8 11593.7 06:13:34 INFO - PROCESS | 1670 | -------- Summary: end -------- 06:13:34 INFO - PROCESS | 1670 | 06:13:34 INFO - TEST-INFO | 1670: exit 0 06:13:34 INFO - TEST-OK | dromaeo_css | took 1115400ms 06:13:34 INFO - TEST-START | kraken 06:13:34 INFO - operating with platform_type : mac_ 06:13:34 INFO - Initialising browser for kraken test... 06:13:34 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp6aSu0x/profile http://localhost:49269/getInfo.html) 06:13:37 INFO - PROCESS | 1679 | 2016-10-22 06:13:37.254 plugin-container[1681:12643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 06:13:37 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:37 INFO - PROCESS | 1679 | 2016-10-22 06:13:37.254 plugin-container[1681:12643] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872f, name = 'com.apple.CFPasteboardClient' 06:13:37 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:37 INFO - PROCESS | 1679 | 2016-10-22 06:13:37.254 plugin-container[1681:12643] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:13:37 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 06:13:37 INFO - PROCESS | 1679 | colorDepth:24 06:13:37 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 06:13:37 INFO - PROCESS | 1679 | __metrics 06:13:37 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 06:13:38 INFO - TEST-INFO | 1679: exit 0 06:13:38 INFO - Browser initialized. 06:13:38 INFO - Running cycle 1/1 for kraken test... 06:13:38 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/T/tmp6aSu0x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:40 INFO - PROCESS | 1682 | 2016-10-22 06:13:40.548 plugin-container[1683:12762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 06:13:40 INFO - PROCESS | 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:40 INFO - PROCESS | 1682 | 2016-10-22 06:13:40.549 plugin-container[1683:12762] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.CFPasteboardClient' 06:13:40 INFO - PROCESS | 1682 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:13:40 INFO - PROCESS | 1682 | 2016-10-22 06:13:40.549 plugin-container[1683:12762] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:13:50 INFO - PROCESS | 1682 | RSS: Main: 236556288 06:13:50 INFO - PROCESS | 1682 | 06:13:53 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:54 INFO - PROCESS | 1682 | RSS: Main: 249163776 06:13:54 INFO - PROCESS | 1682 | 06:13:57 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 06:13:57 INFO - PROCESS | 1682 | RSS: Main: 256765952 06:13:57 INFO - PROCESS | 1682 | 06:14:01 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 06:14:01 INFO - PROCESS | 1682 | RSS: Main: 259768320 06:14:01 INFO - PROCESS | 1682 | 06:14:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 06:14:04 INFO - PROCESS | 1682 | RSS: Main: 260784128 06:14:04 INFO - PROCESS | 1682 | 06:14:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:07 INFO - PROCESS | 1682 | RSS: Main: 262418432 06:14:07 INFO - PROCESS | 1682 | 06:14:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:10 INFO - PROCESS | 1682 | RSS: Main: 262488064 06:14:10 INFO - PROCESS | 1682 | 06:14:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:14 INFO - PROCESS | 1682 | RSS: Main: 262762496 06:14:14 INFO - PROCESS | 1682 | 06:14:17 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 06:14:17 INFO - PROCESS | 1682 | RSS: Main: 262811648 06:14:17 INFO - PROCESS | 1682 | 06:14:19 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:20 INFO - PROCESS | 1682 | RSS: Main: 262725632 06:14:20 INFO - PROCESS | 1682 | 06:14:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:23 INFO - PROCESS | 1682 | RSS: Main: 262713344 06:14:23 INFO - PROCESS | 1682 | 06:14:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:25 INFO - PROCESS | 1682 | RSS: Main: 263270400 06:14:25 INFO - PROCESS | 1682 | 06:14:28 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:29 INFO - PROCESS | 1682 | RSS: Main: 263163904 06:14:29 INFO - PROCESS | 1682 | 06:14:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:33 INFO - PROCESS | 1682 | RSS: Main: 261156864 06:14:33 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 06:14:35 INFO - PROCESS | 1682 | RSS: Main: 263958528 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | __start_tp_report 06:14:35 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 06:14:35 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 06:14:35 INFO - PROCESS | 1682 | |i|pagename|runs| 06:14:35 INFO - PROCESS | 1682 | |0;ai-astar;123;121;117;120;116;118;119;114;118;117 06:14:35 INFO - PROCESS | 1682 | |1;audio-beat-detection;166;152;146;175;113;117;147;151;163;115 06:14:35 INFO - PROCESS | 1682 | |2;audio-dft;203;237;234;197;201;278;258;200;198;193 06:14:35 INFO - PROCESS | 1682 | |3;audio-fft;81;58;61;92;86;59;59;59;81;61 06:14:35 INFO - PROCESS | 1682 | |4;audio-oscillator;79;69;86;71;72;89;124;99;80;86 06:14:35 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;135;133;90;91;124;88;95;132;130;88 06:14:35 INFO - PROCESS | 1682 | |6;imaging-darkroom;97;96;98;95;106;96;95;97;97;99 06:14:35 INFO - PROCESS | 1682 | |7;imaging-desaturate;135;135;119;86;101;92;148;144;91;94 06:14:35 INFO - PROCESS | 1682 | |8;json-parse-financial;58;57;57;59;57;81;76;76;93;89 06:14:35 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;70;70;79;78;77;91;106;106;108;71 06:14:35 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;88;86;100;113;100;89;91;87;91;88 06:14:35 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;148;160;131;156;172;160;155;132;185;163 06:14:35 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;156;214;248;239;166;236;241;224;239;191 06:14:35 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;72;71;71;88;91;89;80;71;71;69 06:14:35 INFO - PROCESS | 1682 | __end_tp_report 06:14:35 INFO - PROCESS | 1682 | __start_cc_report 06:14:35 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,945 06:14:35 INFO - PROCESS | 1682 | __end_cc_report 06:14:35 INFO - PROCESS | 1682 | __startTimestamp1477142075732__endTimestamp 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | ------- Summary: start ------- 06:14:35 INFO - PROCESS | 1682 | Number of tests: 14 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:118.30 Median:118.50 stddev:2.58 (2.2%) stddev-sans-first:2.11 06:14:35 INFO - PROCESS | 1682 | Values: 123.0 121.0 117.0 120.0 116.0 118.0 119.0 114.0 118.0 117.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:22.26 (14.7%) stddev-sans-first:22.21 06:14:35 INFO - PROCESS | 1682 | Values: 166.0 152.0 146.0 175.0 113.0 117.0 147.0 151.0 163.0 115.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:219.90 Median:218.50 stddev:29.97 (13.7%) stddev-sans-first:31.16 06:14:35 INFO - PROCESS | 1682 | Values: 203.0 237.0 234.0 197.0 201.0 278.0 258.0 200.0 198.0 193.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:69.70 Median:71.00 stddev:13.54 (19.1%) stddev-sans-first:13.73 06:14:35 INFO - PROCESS | 1682 | Values: 81.0 58.0 61.0 92.0 86.0 59.0 59.0 59.0 81.0 61.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:83.00 stddev:16.38 (19.7%) stddev-sans-first:17.20 06:14:35 INFO - PROCESS | 1682 | Values: 79.0 69.0 86.0 71.0 72.0 89.0 124.0 99.0 80.0 86.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:88.00 stddev:21.56 (24.5%) stddev-sans-first:20.98 06:14:35 INFO - PROCESS | 1682 | Values: 135.0 133.0 90.0 91.0 124.0 88.0 95.0 132.0 130.0 88.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:97.00 stddev:3.20 (3.3%) stddev-sans-first:3.39 06:14:35 INFO - PROCESS | 1682 | Values: 97.0 96.0 98.0 95.0 106.0 96.0 95.0 97.0 97.0 99.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:114.50 Median:117.00 stddev:24.33 (20.8%) stddev-sans-first:24.65 06:14:35 INFO - PROCESS | 1682 | Values: 135.0 135.0 119.0 86.0 101.0 92.0 148.0 144.0 91.0 94.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:76.00 stddev:14.35 (18.9%) stddev-sans-first:14.52 06:14:35 INFO - PROCESS | 1682 | Values: 58.0 57.0 57.0 59.0 57.0 81.0 76.0 76.0 93.0 89.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:85.60 Median:74.00 stddev:15.77 (21.3%) stddev-sans-first:15.68 06:14:35 INFO - PROCESS | 1682 | Values: 70.0 70.0 79.0 78.0 77.0 91.0 106.0 106.0 108.0 71.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:88.00 stddev:8.54 (9.7%) stddev-sans-first:8.84 06:14:35 INFO - PROCESS | 1682 | Values: 88.0 86.0 100.0 113.0 100.0 89.0 91.0 87.0 91.0 88.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:160.00 stddev:16.48 (10.3%) stddev-sans-first:17.21 06:14:35 INFO - PROCESS | 1682 | Values: 148.0 160.0 131.0 156.0 172.0 160.0 155.0 132.0 185.0 163.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:215.40 Median:237.50 stddev:33.16 (14.0%) stddev-sans-first:27.33 06:14:35 INFO - PROCESS | 1682 | Values: 156.0 214.0 248.0 239.0 166.0 236.0 241.0 224.0 239.0 191.0 06:14:35 INFO - PROCESS | 1682 | 06:14:35 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:76.00 stddev:8.83 (11.6%) stddev-sans-first:9.16 06:14:35 INFO - PROCESS | 1682 | Values: 72.0 71.0 71.0 88.0 91.0 89.0 80.0 71.0 71.0 69.0 06:14:35 INFO - PROCESS | 1682 | -------- Summary: end -------- 06:14:35 INFO - PROCESS | 1682 | 06:14:36 INFO - TEST-INFO | 1682: exit 0 06:14:36 INFO - TEST-OK | kraken | took 61883ms 06:14:36 INFO - SUITE-END | took 1177s 06:14:36 INFO - Completed test suite (00:19:37) 06:14:36 INFO - javascript benchmark 06:14:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7130.75820538251, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2786.4705705915876, 3352.4133276676575, 3365.091425315165, 3394.304167645633, 3406.9659303406966, 5568.805091821782, 5572.442755724425, 5591.552675785938, 5622.634528755628, 5634.4928956393915, 5501.779928802853, 5639.407862174474, 5652.858678533028, 5656.604037717361, 5660.858478538039, 5107.616928730342, 5183.118869792144, 5192.922106168392, 5198.714070726109, 5215.0, 5175.171972484384, 5260.500252476008, 5265.236540701596, 5267.0256002639635, 5341.359036915556, 5044.672096313728, 5205.6356055075785, 5207.6875387476875, 5239.895202095956, 5257.553107985826, 5050.191969284933, 5079.466656001104, 5143.125668636303, 5172.094883395428, 5193.143131383317, 5129.3075434816565, 5131.076406246874, 5132.358455193101, 5138.871528211825, 5180.238718835576, 5465.098258787295, 5470.480304371078, 5538.972305138489, 5630.887382252373, 5661.490465858093, 6094.329623741429, 6124.938750612481, 6128.63228206309, 6193.659348735818, 6207.6275423474735, 5137.768800403991, 6177.629342239435, 6209.534284928648, 6246.625202487865, 6273.686315684197, 5138.460461651547, 5428.891422171613, 5614.971925140389, 5705.229793977843, 5712.742926568314, 6055.666938318434, 6206.596571222946, 6211.3167551569295, 6245.781397651061, 6246.281677607042, 4109.671226301889, 5110.48895110486, 5113.53978141969, 5978.910316345258, 6111.908321375183, 4968.627352948471, 5508.862278443071, 5733.623930256792, 6198.287196972406, 6224.159738435344, 5377.112776391929, 5974.40255974399, 6064.272287325549, 6111.0, 6112.32764395925, 6149.3235744068115, 6173.783917562864, 6206.751729930752, 6206.875862482725, 6222.502199824004, 4142.979285103615, 4652.0, 4835.44392394872, 4900.117978763786, 4904.583110435653, 4327.7186982846015, 4328.9394098445455, 4342.6742994275555, 4399.296112621965, 4411.1618792429335, 4809.879753006203, 5722.62802917809, 5784.82645520635, 5816.447437493516, 5875.588708790344, 5349.358077030781, 6030.939690603125, 6175.104609831639, 6245.250569931637, 6268.811935641938, 5629.887402252014, 5683.857903552444, 5716.485516303553, 5831.4168583141345, 5838.824835254949, 5344.786208551692, 5354.678719276856, 5384.757685904144, 5402.702851343135, 5439.755211015514, 6229.314775374705, 6266.091416744638, 6266.342034086355, 6274.403931626488, 6278.529110316745, 6106.1451396803595, 6253.874302625571, 6267.373262673696, 6274.027525733519, 6275.403836635513, 6214.067889816563, 6225.875482490234, 6240.656763878031, 6273.341299163522, 6277.874442511215, 6096.1465394845645, 6127.8468038297615, 6152.138700582012, 6158.784442544489, 6183.288921774054, 6083.726232319645, 6101.792513241417, 6142.078688196806, 6270.341614130451, 6279.403456671609, 5894.498967587803, 5938.851528711817, 5981.162637230704, 6030.095485677183, 6031.306399763907, 5923.674197918984, 5966.433188847052, 5988.910166347596, 5995.070764031408, 6021.006533922029, 5720.656760594377, 5764.365919748908, 5838.5621078418435, 5845.298564172156, 5850.0932355484965, 5793.652380857162, 5863.530917526673, 5953.166556681981, 6011.068284415923, 6046.455818976313, 5891.617044892068, 5898.1152827076285, 5927.14056461802, 5930.495907847881, 5935.109733540004], "value": 5577.0942348251965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.53324009789714, 464.9976750116253, 515.7601715202431, 520.0457161109364, 534.110705675051, 38648.61351386485, 40013.0, 40139.79930100353, 40146.39780403296, 42654.786726066326, 35551.82224088876, 38967.41548876769, 42066.0, 42088.0, 43771.56228437715, 9458.574364153596, 9474.999999999984, 9616.951915240448, 9652.710418687415, 9665.903340966606, 7374.926250737504, 9420.905790942106, 9545.570449329796, 9576.664816731416, 9579.80840383192, 9569.186619137381, 9584.329096963216, 9590.472524011177, 9591.040895910422, 9615.086566776145, 9438.244940404751, 9545.952270238638, 9567.808643827155, 9591.472469014201, 9595.136437720568, 9494.098060684224, 9561.043895610383, 9603.039696030412, 9622.518874056339, 9626.66306679263, 38966.61033389687, 39097.022574435585, 39493.40759888604, 39524.80237598823, 39604.60395396038, 3506.561679790026, 3592.1378869071236, 3709.6661300482815, 3852.5569559500736, 4082.9795851020854, 29526.70473295261, 30551.694483055107, 30784.922527711646, 30966.535501967264, 30972.690273097207, 3021.561873528326, 3112.6109236345455, 3186.617605887285, 3187.235063584746, 3207.3585282943504, 478619.0, 479903.0, 485229.0, 487333.99999999645, 488183.0, 56397.0, 56908.43091569114, 57092.0, 57200.0, 57239.42760572341, 59681.701591491765, 59717.70141149353, 59827.401725982185, 60112.39887601155, 60231.0, 15443.150626715415, 15717.528474145794, 15724.213789310488, 15757.606059848365, 15761.763573546406, 10279.640212592672, 12155.027597792156, 12161.939190303992, 12197.0, 12217.144799863925, 13667.863321366858, 14310.427582896777, 14635.926820366043, 14785.852141478448, 14876.330565124596, 3092.567040614316, 3184.172115250052, 6448.9355106449275, 6569.737210511622, 6587.50593705474, 861.8965724113021, 879.7360791762574, 1010.1363334349172, 1012.7974405119006, 1047.5809676129456, 24994.625080623806, 27138.45723085527, 29960.550591741143, 30184.849075754482, 30674.53988190179, 980.4656462228103, 1078.2182917384832, 1083.3012706804068, 1124.8256520239377, 1212.5816593275306, 15059.322330495153, 15441.382344706086, 15510.767338489932, 15610.0, 16071.678566428605, 638046.0, 638341.0, 640332.0, 645314.0, 645667.0, 56745.7162714192, 57321.71339143361, 57548.0, 57589.712051440314, 57656.42343576511, 1353.1204716934071, 1386.202933313349, 1395.699924516234, 1408.478862820763, 1409.4784929576122, 26843.86578067097, 27364.042258520858, 27772.72227277782, 29784.702152978192, 30423.935162269216, 48870.75564622296, 49109.75445122751, 49471.75264123656, 49553.0, 49593.0, 485361.0, 486052.0, 578465.0, 579045.0, 580520.0973995103, 21831.78168218361, 24425.9237964775, 25342.873285633454, 25530.489390212464, 25864.612030819175, 46187.538124618324, 46720.29919551141, 47114.82212944567, 47152.056958861314, 47417.28874066961, 33943.0, 37387.252254955296, 38466.80766596149, 39624.603753963245, 39716.2056758869, 34253.0, 38092.0, 38655.43717635864, 38954.0, 39042.80478597589, 31178.388727675305, 32063.0, 33245.50131747977, 34393.484097739056, 35873.0, 27102.72897271081, 34292.657073429946, 34516.0, 34601.65398346085, 34835.825820870734, 24248.272551823473, 24515.632265515676, 25004.0, 25012.62481062749, 25394.619080713434], "value": 19225.97237207141, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.3387585408337, 374.21601744345594, 378.8579282768962, 382.220270647878, 400.83766074739725, 19053.0, 19754.90122549389, 20492.590148197047, 20608.793912060893, 20640.48398790031, 15707.84292157081, 19989.900050499764, 20478.488037799027, 20964.0, 21223.787762122374, 5259.526642602165, 5629.774809007635, 5801.274840644919, 5805.01314776489, 5889.6171748836405, 3824.2542704172697, 5941.821745347646, 5984.5511586630955, 6001.2498437695285, 6024.283079322394, 3998.7603842808676, 4613.331066995283, 5937.2578427696535, 5980.983232850404, 6057.182280392135, 5808.186853840466, 5946.0, 5964.642121472704, 6016.518678505709, 6042.486388656969, 5774.422557744234, 5776.508996735282, 5779.682117483537, 5809.535237181058, 5813.244278243844, 13172.209667419986, 18763.90618046915, 24674.889629966696, 24861.638144376255, 25422.36444088894, 2051.148773259096, 2106.304919376602, 2130.62714025045, 2142.1110239250693, 2150.709654196679, 7606.961965190194, 10080.596776128947, 10332.380057196593, 11626.0, 15901.443449479328, 1824.7262910563388, 1862.9441116766518, 1881.5766452548066, 1895.2134864031411, 1926.7994877750925, 113563.0, 120396.0, 120809.79190208162, 125415.3729231348, 128228.35885820512, 10959.561617535368, 11349.148813838996, 11495.942520287512, 11576.353448663644, 11833.349165795791, 14433.35049922756, 14439.85560144385, 14466.782998255034, 14474.421023159166, 14502.419903203965, 6917.792466226021, 7298.56208627484, 8132.227438393344, 8433.728924414962, 8503.277221436247, 6683.365080317362, 8360.581970901552, 8363.330933525303, 8522.147785221428, 8534.78663033429, 4449.466064072332, 4503.054358584734, 4514.593686568224, 4559.270516717309, 4603.838865639754, 1889.952751181204, 1934.1296416612581, 1934.6517626827306, 1936.1674479973465, 1965.705144228377, 330.993380132396, 374.31313539654496, 379.4270651316477, 406.1714103229379, 437.0101719605097, 11686.532538698528, 11880.584179553847, 12009.339486328161, 12105.636830895088, 12181.634550963485, 405.4526389374321, 430.96983211175547, 432.34931428200986, 434.9195398851223, 438.98244070237473, 6085.726142323606, 6108.602940808833, 6149.385061493815, 6259.4679452246155, 6270.9372906270355, 546063.0, 560181.0, 584278.0, 586020.0, 587168.0, 134904.0, 139927.30036349752, 142223.0, 144706.0, 145692.27153864375, 357.8926322103359, 439.3585365366537, 439.56263517799357, 439.95820397062226, 442.8937055106751, 9154.35221660081, 11319.288034920428, 11370.090392768725, 11384.715382115513, 11662.475188616701, 51712.74143629258, 54495.72752136214, 54724.90550188894, 56091.9860765985, 59706.0, 58067.70966145142, 74339.0, 80208.79686804819, 85628.0, 86307.56846215729, 6987.266337034742, 7355.227701091522, 7388.445866559922, 7816.10114836801, 8389.0, 10222.846657300295, 11707.824382634437, 12037.458314375699, 13357.13178643385, 13399.0, 9758.121769040821, 9775.706728798148, 10995.065419439117, 11187.16096292765, 11280.435978201222, 10534.894651053391, 11069.833952490559, 11071.83392249133, 11201.71995700114, 11249.0, 11425.485853136795, 11460.197786155222, 11606.040459682727, 11821.586244481401, 11879.703007424883, 7426.405887529093, 7478.663460144197, 7481.588512631857, 7583.469157158946, 7617.619119043915, 8341.666333346599, 10951.288166269167, 11283.323000619988, 11291.209615326849, 11428.657140285804], "value": 8393.871005831576, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.981897038469, 1574.4332040465433, 1704.0542498913114, 1804.1340156724773, 1910.5032691500205, 7441.293077157675, 7883.724069657549, 8148.796280093001, 8886.333524985635, 8898.555072246387, 8381.371397145209, 8670.393072484929, 8700.173483519071, 8779.29765618749, 8804.55977201139, 2265.8300627452923, 2302.6200676888293, 2306.9423264418356, 2309.2725791375747, 2311.2141871763597, 2257.898394572248, 2299.839011269212, 2316.3166865774638, 2317.432229103872, 2321.686572312733, 2281.7946384825364, 2299.287220961499, 2306.6194077977116, 2332.8367014309006, 2338.4270853640796, 2257.401788526042, 2270.2735124760084, 2283.862968221904, 2285.5771682238674, 2297.1959814065026, 2283.920062797794, 2287.4395773035544, 2290.6907567478343, 2291.873946932918, 2301.4361481436986, 8797.076306987738, 8801.295896328278, 8812.779680507974, 8815.51514666693, 8866.822663546758, 4478.94744734987, 5128.794848206067, 5275.657082289639, 5298.470152984709, 5311.62818602698, 3432.6910578047846, 3500.1074725944977, 3592.8742494012586, 3631.9818400907825, 3633.854645814164, 1022.3405903192399, 1045.7281106912183, 1054.899784520477, 1066.7493139112303, 1071.8669847004483, 11433.59982400612, 11439.428028598537, 11457.942710286396, 11534.250273732181, 11584.362860042695, 4396.516383197845, 4438.178936896685, 4601.631869450436, 4613.838515651936, 4660.86017419478, 9793.0, 9865.408075515492, 9889.011098890054, 9902.0, 9916.702498925044, 4472.955270447319, 5232.0, 5240.371155461293, 5248.265242866002, 5254.106801843695, 3617.7829330239742, 4328.156009578165, 4769.809207631656, 4774.092922344744, 4806.687565308243, 3208.4866421372467, 3252.512123181494, 3336.0992532016703, 3813.84744610218, 3912.7065470089856, 1243.7450322683828, 1258.182181581979, 1264.9241045537296, 1266.7276535544902, 1267.2333238390825, 766.4404984361447, 788.8461749958703, 833.9291160251325, 864.5590748718199, 939.1031564855547, 5441.374241962225, 5605.523530499871, 5937.0, 5939.22790037301, 5968.9701551492835, 374.9493818334544, 406.8087998640634, 424.23849190702765, 427.79038271246867, 430.4017415792052, 3494.899106781356, 3594.2272411431145, 3954.584768599313, 3983.64147226751, 4021.959780402217, 10375.688729338131, 10665.520051597698, 10773.892261077446, 10778.892211077946, 10792.0, 10284.640037598649, 10689.0, 10716.303440276357, 10729.517171727291, 10732.78534429307, 8010.679572817138, 8287.254147126787, 8295.0, 8312.750617481484, 8326.875096873551, 5614.203454894395, 5701.7434215461235, 5752.597318187687, 5822.883542329215, 5856.648601083949, 10006.749831253986, 10017.899821001696, 10024.298299118991, 10044.497775111362, 10075.294729368874, 9740.220782337254, 9903.306768526134, 10081.69754907354, 10186.490675466346, 10252.333598316085, 6856.485763567653, 7092.148942126978, 7379.852402951804, 7448.068991376078, 7529.397648188023, 6683.966580167068, 8345.332373410234, 8356.791080223044, 8454.66181352739, 8508.936382952132, 7349.375303099083, 7493.9883115778675, 7526.924730752622, 7606.04924384452, 7610.353119984642, 7353.080864891888, 7353.117625884928, 7377.557346559223, 7422.294881986203, 7535.284148005931, 6798.898016529855, 6891.896621550581, 6897.7585784497305, 6975.755848545276, 6980.546264492792, 4923.507649235048, 4980.651354405157, 4987.055048531149, 5029.245613158056, 5045.31888195089, 4233.428487154195, 4824.179889418737, 4858.271259311132, 5004.3494345734825, 5142.151544995034], "value": 4405.08699465428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.4180569968867, 295.7604340484208, 310.13627048669446, 313.49370766212576, 314.50151509856875, 4561.22459181939, 5298.4436634153435, 5473.233747275384, 5487.6981766002855, 5577.247071645332, 4548.613367863727, 5404.702741349224, 5470.753816078276, 5490.423505531921, 5500.614956953005, 3872.5159355080614, 4184.665226781865, 4198.769067701275, 4205.705600607958, 4219.9578004219875, 4103.220388126247, 4150.626443620074, 4153.605407486284, 4255.489301298041, 4270.818240410898, 3687.815609219528, 3873.3802591585354, 4140.937885931713, 4163.604457576525, 4169.874903752877, 3492.301539692059, 4123.958760412417, 4158.126793373395, 4174.686898482626, 4198.307279298912, 3652.0, 3653.853845846163, 3657.3965295726175, 3657.5976642569294, 3692.280005398948, 4991.650584459089, 5032.295478632995, 5206.7917283308625, 5349.946500534984, 5367.919481207785, 4835.734034628094, 4836.588889944359, 4853.19922212838, 4859.246816743411, 4879.974810453693, 4842.757862106916, 5160.870978225536, 5421.861409104093, 5765.88468230633, 5849.841085813656, 3672.669459748609, 3834.8657796976972, 3912.5891781363116, 4014.237294913957, 4016.0562267867026, 5551.639143455663, 5818.5636077294375, 5859.326177489601, 6153.569250152491, 6171.253792062534, 3626.673599376069, 4102.835886564564, 4116.361963895601, 4121.216968775923, 4121.825279795244, 3758.699304055669, 4021.235965166609, 4026.9060088753686, 4039.73741706794, 4164.083901541656, 4280.743155410623, 4303.74177549348, 4565.246734288871, 4704.435467743892, 4705.7647117644665, 4624.676272660949, 4763.975310493096, 5055.0, 5777.62445441045, 5819.31239940421, 1267.7591257661015, 1287.6330245879878, 1329.2954733991, 1336.191604079518, 1355.783074708042, 860.2515811244258, 889.6352495476823, 917.206616276929, 921.1525396634978, 931.2596485793811, 4836.806527738921, 5057.342545469139, 5469.589780766459, 5470.781168753205, 5475.6440831345835, 5910.408959104056, 5952.107183922446, 5954.37479064692, 5975.7609695612555, 5993.430624090704, 4597.712640460676, 4893.584045356113, 5351.785928562814, 5428.4028756836715, 5517.682573319215, 3150.842457877097, 3168.98415507921, 3177.714005739448, 3179.7582704193487, 3187.2031992002, 5808.82573522795, 5968.432998865101, 6270.529710271748, 6277.0, 6283.434490895841, 5292.682439053592, 5853.0, 6029.487493563009, 6136.171616831671, 6177.567570270038, 5810.924978878921, 6363.854506188838, 6366.713497892606, 6452.322506136788, 6462.806115816533, 5612.466815652507, 5629.380768115586, 5967.403259673998, 6079.787207447718, 6126.343978576225, 5104.132297509506, 5255.842324730112, 5473.233747275464, 5708.372079071216, 5724.4561766632105, 5235.790568377222, 5291.867703307448, 5986.970065149646, 6370.299267080525, 6442.259140198749, 3494.423420135649, 3692.9076773080888, 3920.2355540669296, 3993.381025940984, 4040.4949381327333, 5848.385919478394, 6076.483498902643, 6132.202813634199, 6179.134921110958, 6186.783462578788, 5449.8827740312345, 5646.830595082154, 5715.5713321500225, 5820.31210948837, 5855.707214639337, 4817.542333478314, 5424.294841670716, 5559.861003474945, 5836.299644042742, 5857.0, 5081.754970032366, 5275.366955965309, 5367.973160134175, 5368.865778355573, 5746.138079287973, 5367.490088441592, 5601.719914004365, 5903.317554496948, 5909.70451477433, 5960.761569537343, 4731.69243999139, 5099.158638824552, 5726.656400615976, 5754.6547207167705, 5766.682832444256], "value": 4219.91631492204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.4505668519059, 686.8626274745052, 724.2550732722976, 775.2170307988929, 827.8427098851217, 12263.632091037261, 16110.919445402786, 16256.0, 16289.0, 16333.183340832955, 15565.533034008999, 16217.675646487092, 16278.104704241263, 16504.33982640696, 16618.0, 720.6612891940792, 867.2931560777946, 869.8999615044256, 899.653633351158, 905.2622112977901, 658.2857599504543, 674.1943377663694, 699.2937133495155, 892.3931726426027, 895.0914821456228, 905.1627244798535, 924.154398725169, 940.8447606144978, 942.3921570586967, 942.7313215733517, 900.6487469886716, 906.5376657904483, 926.8702381666573, 940.8541676040225, 945.744648944788, 572.9629370838795, 632.7816903168399, 667.2260178193272, 679.0188178082673, 700.3276854219955, 15877.0, 15887.60280992973, 15992.12043337616, 16008.19959002057, 16013.35946562136, 14232.28838558068, 14240.857591424161, 14264.429422823074, 14312.64218394538, 14441.927790361085, 11903.94048029763, 12034.939825300817, 12042.217255878428, 12069.0, 12123.454444549929, 3748.775073495599, 3759.7368184227116, 3762.4168253920684, 3768.434734789776, 3906.101596632762, 93246.53376733072, 96279.9999999993, 113623.29565056531, 118282.4404583359, 121462.392688036, 10569.154467642571, 10842.241043127064, 10917.617883374043, 10931.18016148792, 11296.6046188383, 22394.664080038812, 22624.773752262266, 22643.981020854102, 22700.545989080125, 22713.432164196027, 7836.725714599962, 7897.407694422941, 7979.601019948979, 8010.5994700264755, 8053.993250843644, 4347.5652434756275, 4382.0, 4391.978040109779, 4458.175237581057, 4463.263561512379, 3104.239461331988, 3472.461768425898, 3584.408572585546, 3599.640035996432, 3602.153493928977, 646.3665607704476, 647.4237928243866, 666.976655817044, 673.6227712481026, 674.0731494195481, 638.7764282501088, 661.3419647450817, 663.5288944849115, 668.2548957911894, 683.1528904158807, 9269.768255793659, 9356.298277629205, 9479.857802132974, 9485.810283794286, 9706.126448619658, 636.2682914648192, 662.6719773712043, 666.4601672645173, 676.905233267343, 687.3435868745336, 4406.559344065632, 4621.930671039937, 4628.629709623222, 4642.094791515622, 4680.3447517347595, 156913.0, 159031.409685904, 160067.0, 162564.0, 165306.0, 92609.0, 133536.33231833778, 135196.0, 135423.0, 136287.0, 91647.0, 97848.51075744575, 100374.4981275089, 103158.0, 104707.99999999847, 9359.251259899056, 9613.0, 9649.276304277348, 9662.516874156405, 9774.902250977684, 60353.69823150856, 60553.39446605654, 61421.0, 62184.756304872746, 63681.0, 64840.949652803894, 72606.54786904338, 79024.60487697755, 82176.0, 98185.01814981758, 13153.736925261632, 13216.933915330363, 13243.536476223286, 13405.396757146147, 13502.662433439242, 14807.057597339923, 14952.850471495582, 15057.924710376377, 15085.922998622873, 15276.15981121049, 13324.666883327995, 13641.522546710818, 13773.0, 14146.858531414555, 14275.785863212268, 13609.591712248648, 13625.250611216477, 13676.042677012514, 13722.176669399869, 13729.794053089012, 12074.27554346742, 13417.0, 13558.322083895962, 13667.838233749844, 13747.793783093462, 10766.407847568458, 11151.0, 11346.659600212008, 11436.19946603763, 11511.963923246947, 9544.062352150147, 10056.34633748804, 11438.337109017899, 11577.768444631229, 11593.6521904343], "value": 7856.946668797439, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1658.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 117.0, 120.0, 116.0, 118.0, 119.0, 114.0, 118.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 152.0, 146.0, 175.0, 113.0, 117.0, 147.0, 151.0, 163.0, 115.0], "value": 144.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 237.0, 234.0, 197.0, 201.0, 278.0, 258.0, 200.0, 198.0, 193.0], "value": 219.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 92.0, 86.0, 59.0, 59.0, 59.0, 81.0, 61.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 69.0, 86.0, 71.0, 72.0, 89.0, 124.0, 99.0, 80.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 90.0, 91.0, 124.0, 88.0, 95.0, 132.0, 130.0, 88.0], "value": 110.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 95.0, 106.0, 96.0, 95.0, 97.0, 97.0, 99.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 119.0, 86.0, 101.0, 92.0, 148.0, 144.0, 91.0, 94.0], "value": 114.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 59.0, 57.0, 81.0, 76.0, 76.0, 93.0, 89.0], "value": 70.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 79.0, 78.0, 77.0, 91.0, 106.0, 106.0, 108.0, 71.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 100.0, 113.0, 100.0, 89.0, 91.0, 87.0, 91.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 160.0, 131.0, 156.0, 172.0, 160.0, 155.0, 132.0, 185.0, 163.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 214.0, 248.0, 239.0, 166.0, 236.0, 241.0, 224.0, 239.0, 191.0], "value": 215.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 88.0, 91.0, 89.0, 80.0, 71.0, 71.0, 69.0], "value": 77.3, "unit": "score"}]}]} 06:14:37 INFO - Return code: 0 06:14:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:37 ERROR - # TBPL SUCCESS # 06:14:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:37 INFO - 2016-10-22 06:14:37.080 screenresolution[1687:13158] starting screenresolution argv=screenresolution get 06:14:37 INFO - 2016-10-22 06:14:37.082 screenresolution[1687:13158] Display 0: 1600x1200x32@60 06:14:37 INFO - 2016-10-22 06:14:37.088 screenresolution[1688:13161] starting screenresolution argv=screenresolution list 06:14:37 INFO - Available Modes on Display 0 06:14:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:37 INFO - Intel Iris: 06:14:37 INFO - Chipset Model: Intel Iris 06:14:37 INFO - Type: GPU 06:14:37 INFO - Bus: Built-In 06:14:37 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:37 INFO - Vendor: Intel (0x8086) 06:14:37 INFO - Device ID: 0x0a2e 06:14:37 INFO - Revision ID: 0x0009 06:14:37 INFO - Displays: 06:14:37 INFO - Display: 06:14:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:37 INFO - Display Serial Number: 1600x1200 60 06:14:37 INFO - Main Display: Yes 06:14:37 INFO - Mirror: Off 06:14:37 INFO - Online: Yes 06:14:37 INFO - Rotation: Supported 06:14:37 INFO - Return code: 0 06:14:37 INFO - Running post-action listener: _resource_record_post_action 06:14:37 INFO - [mozharness: 2016-10-22 13:14:37.323661Z] Finished run-tests step (success) 06:14:37 INFO - Running post-run listener: _resource_record_post_run 06:14:37 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 33284096; Write bytes: 712479232; Read time: 207; Write time: 2073 06:14:37 INFO - TinderboxPrint: CPU usage
54.3% 06:14:37 INFO - TinderboxPrint: I/O read bytes / time
33,284,096 / 207 06:14:37 INFO - TinderboxPrint: I/O write bytes / time
712,479,232 / 2,073 06:14:37 INFO - TinderboxPrint: CPU idle
2,216.4 (45.7%) 06:14:37 INFO - TinderboxPrint: CPU system
982.8 (20.2%) 06:14:37 INFO - TinderboxPrint: CPU user
1,654.5 (34.1%) 06:14:37 INFO - TinderboxPrint: Swap in / out
434,307,072 / 0 06:14:37 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 385419776; Write bytes: 379160576; Read time: 28784; Write time: 815 06:14:37 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 32362496; Write bytes: 303150080; Read time: 186; Write time: 1176 06:14:37 INFO - Running post-run listener: _upload_blobber_files 06:14:37 INFO - Blob upload gear active. 06:14:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:37 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 06:14:37 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:37 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:14:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:39 INFO - (blobuploader) - INFO - Done attempting. 06:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:40 INFO - (blobuploader) - INFO - Done attempting. 06:14:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:42 INFO - (blobuploader) - INFO - Done attempting. 06:14:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:42 INFO - Return code: 0 06:14:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49c398e6274eaaa3e43789488527b6c6287723e8f14eeef4fb03149f019b32b3dfbcecfbe0950aad1b92ba0d7f909b58f3d6b06792dda8820d77cf20439eb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1522df38b6531b108c73820759eb43b31e0a40e6c02bf4379fc9f96b906ad1de72981f715ff64d540b01fb7000ed578861c76f1e70e5be5f2cac759b650e0f7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe6bc99349ae8a49e167a3dccd840023c4affc4d047fa3075c95530fa7f01ab5f50c8f8465ec410bd8343dae8573df23a55511e9061662304ae66e4b1e3312"} 06:14:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:42 INFO - Contents: 06:14:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49c398e6274eaaa3e43789488527b6c6287723e8f14eeef4fb03149f019b32b3dfbcecfbe0950aad1b92ba0d7f909b58f3d6b06792dda8820d77cf20439eb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1522df38b6531b108c73820759eb43b31e0a40e6c02bf4379fc9f96b906ad1de72981f715ff64d540b01fb7000ed578861c76f1e70e5be5f2cac759b650e0f7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe6bc99349ae8a49e167a3dccd840023c4affc4d047fa3075c95530fa7f01ab5f50c8f8465ec410bd8343dae8573df23a55511e9061662304ae66e4b1e3312"} 06:14:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:42 INFO - Copying logs to upload dir... 06:14:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.340439 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-22 06:14:42.603195) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:42.606505) ========= 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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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/Firefox/sha512/49c398e6274eaaa3e43789488527b6c6287723e8f14eeef4fb03149f019b32b3dfbcecfbe0950aad1b92ba0d7f909b58f3d6b06792dda8820d77cf20439eb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1522df38b6531b108c73820759eb43b31e0a40e6c02bf4379fc9f96b906ad1de72981f715ff64d540b01fb7000ed578861c76f1e70e5be5f2cac759b650e0f7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe6bc99349ae8a49e167a3dccd840023c4affc4d047fa3075c95530fa7f01ab5f50c8f8465ec410bd8343dae8573df23a55511e9061662304ae66e4b1e3312"} build_url:https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/QjYmVcyoTKObjilDf3Tzhg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49c398e6274eaaa3e43789488527b6c6287723e8f14eeef4fb03149f019b32b3dfbcecfbe0950aad1b92ba0d7f909b58f3d6b06792dda8820d77cf20439eb9d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1522df38b6531b108c73820759eb43b31e0a40e6c02bf4379fc9f96b906ad1de72981f715ff64d540b01fb7000ed578861c76f1e70e5be5f2cac759b650e0f7e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe6bc99349ae8a49e167a3dccd840023c4affc4d047fa3075c95530fa7f01ab5f50c8f8465ec410bd8343dae8573df23a55511e9061662304ae66e4b1e3312"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:42.638458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:42.638770) ========= 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.Clfy8pKWxb/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.nEAbHft4rZ/Listeners TMPDIR=/var/folders/fg/pfrf4nhd1hz969r_0mf1rb2400000w/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.004944 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 06:14:42.688148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:14:42.688495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 06:14:42.688890) ========= ========= Total master_lag: 0.18 =========