builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0265 starttime: 1486413681.49 results: success (0) buildid: 20170206101855 builduid: e7e74b7e86a44fc1b3528c0720eff052 revision: 501a3fa83897af9598adfd6f794b5d5ea82fe237 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.494142) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.494608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.494880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.521834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.522184) ========= 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.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-06 12:41:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-02-06 12:41:21 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.671844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.672156) ========= 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.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.025163 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:21.720149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 12:41:21.720539) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 501a3fa83897af9598adfd6f794b5d5ea82fe237 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 501a3fa83897af9598adfd6f794b5d5ea82fe237 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-06 12:41:21,827 truncating revision to first 12 chars 2017-02-06 12:41:21,827 Setting DEBUG logging. 2017-02-06 12:41:21,827 attempt 1/10 2017-02-06 12:41:21,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/501a3fa83897?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 12:41:23,228 unpacking tar archive at: mozilla-beta-501a3fa83897/testing/mozharness/ program finished with exit code 0 elapsedTime=1.680715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 12:41:23.425013) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:23.425344) ========= script_repo_revision: 501a3fa83897af9598adfd6f794b5d5ea82fe237 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:23.425717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:23.425979) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 12:41:23.444846) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 12:41:23.445166) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:41:23 INFO - MultiFileLogger online at 20170206 12:41:23 in /builds/slave/test 12:41:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:41:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:41:23 INFO - {'append_to_log': False, 12:41:23 INFO - 'base_work_dir': '/builds/slave/test', 12:41:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:41:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:41:23 INFO - 'branch': 'Mozilla-Beta', 12:41:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:41:23 INFO - 'config_files': ('talos/mac_config.py',), 12:41:23 INFO - 'default_actions': ('clobber', 12:41:23 INFO - 'read-buildbot-config', 12:41:23 INFO - 'download-and-extract', 12:41:23 INFO - 'populate-webroot', 12:41:23 INFO - 'create-virtualenv', 12:41:23 INFO - 'install', 12:41:23 INFO - 'run-tests'), 12:41:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:41:23 INFO - 'download_minidump_stackwalk': True, 12:41:23 INFO - 'download_symbols': 'ondemand', 12:41:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:41:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:41:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:41:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:41:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:41:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:41:23 INFO - 'installer_path': 'installer.exe', 12:41:23 INFO - 'log_level': 'info', 12:41:23 INFO - 'log_name': 'talos', 12:41:23 INFO - 'log_to_console': True, 12:41:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:41:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:41:23 INFO - 'opt_config_files': (), 12:41:23 INFO - 'pip_index': False, 12:41:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:41:23 INFO - 'cmd': ('bash', 12:41:23 INFO - '-c', 12:41:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:41:23 INFO - 'enabled': True, 12:41:23 INFO - 'halt_on_failure': False, 12:41:23 INFO - 'name': 'check_screen_resolution'},), 12:41:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:41:23 INFO - 'cmd': ('bash', 12:41:23 INFO - '-c', 12:41:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:41:23 INFO - 'enabled': True, 12:41:23 INFO - 'halt_on_failure': False, 12:41:23 INFO - 'name': 'check_screen_resolution'},), 12:41:23 INFO - 'run_cmd_checks_enabled': True, 12:41:23 INFO - 'sps_profile': False, 12:41:23 INFO - 'sps_profile_interval': 0, 12:41:23 INFO - 'suite': 'dromaeojs-e10s', 12:41:23 INFO - 'system_bits': '32', 12:41:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:41:23 INFO - 'title': 't-yosemite-r7-0265', 12:41:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:41:23 INFO - 'use_talos_json': True, 12:41:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:41:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:41:23 INFO - 'work_dir': 'build'} 12:41:23 INFO - [mozharness: 2017-02-06 20:41:23.652619Z] Running clobber step. 12:41:23 INFO - Running pre-action listener: _resource_record_pre_action 12:41:23 INFO - Running main action method: clobber 12:41:23 INFO - rmtree: /builds/slave/test/build 12:41:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:41:25 INFO - Running post-action listener: _resource_record_post_action 12:41:25 INFO - [mozharness: 2017-02-06 20:41:25.930973Z] Finished clobber step (success) 12:41:25 INFO - [mozharness: 2017-02-06 20:41:25.931097Z] Running read-buildbot-config step. 12:41:25 INFO - Running pre-action listener: _resource_record_pre_action 12:41:25 INFO - Running main action method: read_buildbot_config 12:41:25 INFO - Using buildbot properties: 12:41:25 INFO - { 12:41:25 INFO - "project": "", 12:41:25 INFO - "product": "firefox", 12:41:25 INFO - "script_repo_revision": "production", 12:41:25 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 12:41:25 INFO - "repository": "", 12:41:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 12:41:25 INFO - "buildid": "20170206101855", 12:41:25 INFO - "pgo_build": "False", 12:41:25 INFO - "basedir": "/builds/slave/test", 12:41:25 INFO - "buildnumber": 4, 12:41:25 INFO - "slavename": "t-yosemite-r7-0265", 12:41:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:41:25 INFO - "platform": "yosemite_r7", 12:41:25 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:41:25 INFO - "branch": "mozilla-beta", 12:41:25 INFO - "repo_path": "releases/mozilla-beta", 12:41:25 INFO - "revision": "501a3fa83897af9598adfd6f794b5d5ea82fe237", 12:41:25 INFO - "stage_platform": "macosx64", 12:41:25 INFO - "builduid": "e7e74b7e86a44fc1b3528c0720eff052", 12:41:25 INFO - "slavebuilddir": "test" 12:41:25 INFO - } 12:41:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 12:41:25 INFO - Running post-action listener: _resource_record_post_action 12:41:25 INFO - [mozharness: 2017-02-06 20:41:25.934459Z] Finished read-buildbot-config step (success) 12:41:25 INFO - [mozharness: 2017-02-06 20:41:25.934572Z] Running download-and-extract step. 12:41:25 INFO - Running pre-action listener: _resource_record_pre_action 12:41:25 INFO - Running main action method: download_and_extract 12:41:25 INFO - mkdir: /builds/slave/test/build/tests 12:41:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:25 INFO - trying https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 12:41:25 INFO - Downloading https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:41:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 12:41:27 INFO - Downloaded 1165 bytes. 12:41:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 12:41:27 INFO - Using the following test package requirements: 12:41:27 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:41:27 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 12:41:27 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 12:41:27 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:41:27 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 12:41:27 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 12:41:27 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 12:41:27 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 12:41:27 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 12:41:27 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 12:41:27 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 12:41:27 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 12:41:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:41:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:41:27 INFO - Fetch https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:41:28 INFO - Http code: 200 12:41:28 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 12:41:28 INFO - x-amz-cf-id: 27wp_JI5XePB6bRagct81RseEhC87eS6BXYHoQCospGMjiVBU992MQ== 12:41:28 INFO - x-amz-version-id: utYgj80xjCS9HMZ9.imgaZfiymqFigTC 12:41:29 INFO - Expected file size: 16091811 12:41:29 INFO - Obtained file size: 16091811 12:41:35 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:41:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 12:41:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 12:41:35 INFO - Fetch https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 12:41:36 INFO - Http code: 200 12:41:36 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 12:41:36 INFO - x-amz-cf-id: gH6ZestctsupbucQsi_3cztur3VaCXLS-iOmkFSyZA2Nq5bSTKu6Fg== 12:41:36 INFO - x-amz-version-id: utYgj80xjCS9HMZ9.imgaZfiymqFigTC 12:41:36 INFO - Expected file size: 16091811 12:41:36 INFO - Obtained file size: 16091811 12:41:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 12:41:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 12:41:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 12:41:43 INFO - Http code: 200 12:41:43 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 12:41:43 INFO - x-amz-cf-id: ft_E4vaY13A6fNHCEju6KjxDKgltrm2kCNaM7jAQbvYMVsS1YkZb5A== 12:41:43 INFO - x-amz-version-id: AQqbK88l1_BXNtiPmNXW0CAEXP63bP_K 12:41:44 INFO - Expected file size: 14403005 12:41:44 INFO - Obtained file size: 14403005 12:41:44 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')]} 12:41:44 INFO - trying https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:41:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 12:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 12:41:47 INFO - Downloaded 82135698 bytes. 12:41:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:41:47 INFO - mkdir: /builds/slave/test/properties 12:41:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:41:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:41:47 INFO - Contents: 12:41:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 12:41:48 INFO - Running post-action listener: _resource_record_post_action 12:41:48 INFO - Running post-action listener: set_extra_try_arguments 12:41:48 INFO - [mozharness: 2017-02-06 20:41:48.234158Z] Finished download-and-extract step (success) 12:41:48 INFO - [mozharness: 2017-02-06 20:41:48.234275Z] Running populate-webroot step. 12:41:48 INFO - Running pre-action listener: _resource_record_pre_action 12:41:48 INFO - Running main action method: populate_webroot 12:41:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:41:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:41:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:41:48 INFO - '--tppagecycles', 12:41:48 INFO - '7'], 12:41:48 INFO - 'tests': ['tsvgm']}}, 12:41:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:41:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:41:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:41:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:41:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:41:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['damp', 'tps']}, 12:41:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'tests': ['damp', 'tps']}, 12:41:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['dromaeo_dom']}, 12:41:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:41:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['basic_compositor_video']}, 12:41:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:41:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'other-e10s': {'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['a11yr', 12:41:48 INFO - 'ts_paint', 12:41:48 INFO - 'tpaint', 12:41:48 INFO - 'sessionrestore', 12:41:48 INFO - 'sessionrestore_no_auto_restore', 12:41:48 INFO - 'tabpaint']}, 12:41:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['tsvgx', 12:41:48 INFO - 'tsvgr_opacity', 12:41:48 INFO - 'tart', 12:41:48 INFO - 'tscrollx', 12:41:48 INFO - 'cart']}, 12:41:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:41:48 INFO - 'tsvgr_opacity', 12:41:48 INFO - 'tart', 12:41:48 INFO - 'tscrollx', 12:41:48 INFO - 'cart']}, 12:41:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'talos_options': ['--disable-e10s'], 12:41:48 INFO - 'tests': ['tp5o']}, 12:41:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'tests': ['tp5o']}, 12:41:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'talos_options': ['--disable-e10s', 12:41:48 INFO - '--xperf_path', 12:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:48 INFO - 'tests': ['tp5n']}, 12:41:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:41:48 INFO - 'talos_options': ['--xperf_path', 12:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:41:48 INFO - 'tests': ['tp5n']}}, 12:41:48 INFO - 'talos.zip': {'path': '', 12:41:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:41:48 INFO - Running post-action listener: _resource_record_post_action 12:41:48 INFO - [mozharness: 2017-02-06 20:41:48.252656Z] Finished populate-webroot step (success) 12:41:48 INFO - [mozharness: 2017-02-06 20:41:48.252767Z] Running create-virtualenv step. 12:41:48 INFO - Running pre-action listener: _resource_record_pre_action 12:41:48 INFO - Running main action method: create_virtualenv 12:41:48 INFO - Creating virtualenv /builds/slave/test/build/venv 12:41:48 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 12:41:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:41:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:41:48 INFO - Using real prefix '/tools/python27' 12:41:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:41:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:41:51 INFO - Installing pip.................done. 12:41:51 INFO - Return code: 0 12:41:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:41:52 INFO - Reading from file tmpfile_stdout 12:41:52 INFO - Output received: 12:41:52 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) 12:41:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:41:52 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')]} 12:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 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')]} 12:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:41:52 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 12:41:52 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 12:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:52 INFO - 'HOME': '/Users/cltbld', 12:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:52 INFO - 'LOGNAME': 'cltbld', 12:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:52 INFO - 'MOZ_NO_REMOTE': '1', 12:41:52 INFO - 'NO_EM_RESTART': '1', 12:41:52 INFO - 'PAGER': '/bin/cat', 12:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:52 INFO - 'PWD': '/builds/slave/test', 12:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:52 INFO - 'SHELL': '/bin/bash', 12:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:41:52 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:52 INFO - 'USER': 'cltbld', 12:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:52 INFO - 'XPC_FLAGS': '0x0', 12:41:52 INFO - 'XPC_SERVICE_NAME': '0', 12:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:52 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 12:41:52 INFO - Cleaning up... 12:41:52 INFO - Return code: 0 12:41:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:41:52 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')]} 12:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 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')]} 12:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:52 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:41:52 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 12:41:52 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 12:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:52 INFO - 'HOME': '/Users/cltbld', 12:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:52 INFO - 'LOGNAME': 'cltbld', 12:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:52 INFO - 'MOZ_NO_REMOTE': '1', 12:41:52 INFO - 'NO_EM_RESTART': '1', 12:41:52 INFO - 'PAGER': '/bin/cat', 12:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:52 INFO - 'PWD': '/builds/slave/test', 12:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:52 INFO - 'SHELL': '/bin/bash', 12:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:41:52 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:52 INFO - 'USER': 'cltbld', 12:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:52 INFO - 'XPC_FLAGS': '0x0', 12:41:52 INFO - 'XPC_SERVICE_NAME': '0', 12:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:52 INFO - Downloading/unpacking psutil>=3.1.1 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:52 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 12:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:56 INFO - Installing collected packages: psutil 12:41:56 INFO - Running setup.py install for psutil 12:41:56 INFO - building 'psutil._psutil_osx' extension 12:41:56 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 12:41:56 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 12:41:56 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 12:41:57 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 12:41:57 INFO - building 'psutil._psutil_posix' extension 12:41:57 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 12:41:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:41:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:41:57 INFO - ^ 12:41:57 INFO - 1 warning generated. 12:41:57 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 12:41:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:41:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:41:57 INFO - Successfully installed psutil 12:41:57 INFO - Cleaning up... 12:41:57 INFO - Return code: 0 12:41:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:41:57 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')]} 12:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:57 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')]} 12:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:57 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:41:57 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 12:41:57 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 12:41:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:41:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:57 INFO - 'HOME': '/Users/cltbld', 12:41:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:57 INFO - 'LOGNAME': 'cltbld', 12:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:57 INFO - 'MOZ_NO_REMOTE': '1', 12:41:57 INFO - 'NO_EM_RESTART': '1', 12:41:57 INFO - 'PAGER': '/bin/cat', 12:41:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:57 INFO - 'PWD': '/builds/slave/test', 12:41:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:57 INFO - 'SHELL': '/bin/bash', 12:41:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:41:57 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:41:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:57 INFO - 'USER': 'cltbld', 12:41:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:57 INFO - 'XPC_FLAGS': '0x0', 12:41:57 INFO - 'XPC_SERVICE_NAME': '0', 12:41:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:41:57 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 12:41:57 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 12:41:57 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 12:41:57 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 12:41:57 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 12:41:57 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 12:42:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:42:00 INFO - Installing collected packages: mozsystemmonitor 12:42:00 INFO - Running setup.py install for mozsystemmonitor 12:42:00 INFO - Successfully installed mozsystemmonitor 12:42:00 INFO - Cleaning up... 12:42:00 INFO - Return code: 0 12:42:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:00 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42:00 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 12:42:00 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 12:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:00 INFO - 'HOME': '/Users/cltbld', 12:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:00 INFO - 'LOGNAME': 'cltbld', 12:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:00 INFO - 'MOZ_NO_REMOTE': '1', 12:42:00 INFO - 'NO_EM_RESTART': '1', 12:42:00 INFO - 'PAGER': '/bin/cat', 12:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:00 INFO - 'PWD': '/builds/slave/test', 12:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:00 INFO - 'SHELL': '/bin/bash', 12:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:00 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:00 INFO - 'USER': 'cltbld', 12:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:00 INFO - 'XPC_FLAGS': '0x0', 12:42:00 INFO - 'XPC_SERVICE_NAME': '0', 12:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:42:00 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 12:42:00 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 12:42:00 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 12:42:00 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 12:42:00 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 12:42:00 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 12:42:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:42:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:42:03 INFO - warning: no files found matching '*.txt' 12:42:03 INFO - no previously-included directories found matching 'build' 12:42:03 INFO - no previously-included directories found matching 'dist' 12:42:03 INFO - no previously-included directories found matching '.git*' 12:42:04 INFO - Installing collected packages: jsonschema, functools32 12:42:04 INFO - Running setup.py install for functools32 12:42:04 INFO - warning: no files found matching '*.txt' 12:42:04 INFO - no previously-included directories found matching 'build' 12:42:04 INFO - no previously-included directories found matching 'dist' 12:42:04 INFO - no previously-included directories found matching '.git*' 12:42:04 INFO - Successfully installed jsonschema functools32 12:42:04 INFO - Cleaning up... 12:42:04 INFO - Return code: 0 12:42:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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', '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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:42: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 functools32==3.2.3-2 12:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:04 INFO - 'HOME': '/Users/cltbld', 12:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:04 INFO - 'LOGNAME': 'cltbld', 12:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:04 INFO - 'MOZ_NO_REMOTE': '1', 12:42:04 INFO - 'NO_EM_RESTART': '1', 12:42:04 INFO - 'PAGER': '/bin/cat', 12:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:04 INFO - 'PWD': '/builds/slave/test', 12:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:04 INFO - 'SHELL': '/bin/bash', 12:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:04 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:04 INFO - 'USER': 'cltbld', 12:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:04 INFO - 'XPC_FLAGS': '0x0', 12:42:04 INFO - 'XPC_SERVICE_NAME': '0', 12:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:42:04 INFO - Cleaning up... 12:42:04 INFO - Return code: 0 12:42:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:42: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')]} 12:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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')]} 12:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42: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', '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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:42: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 blobuploader==1.2.4 12:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:04 INFO - 'HOME': '/Users/cltbld', 12:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:04 INFO - 'LOGNAME': 'cltbld', 12:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:04 INFO - 'MOZ_NO_REMOTE': '1', 12:42:04 INFO - 'NO_EM_RESTART': '1', 12:42:04 INFO - 'PAGER': '/bin/cat', 12:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:04 INFO - 'PWD': '/builds/slave/test', 12:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:04 INFO - 'SHELL': '/bin/bash', 12:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:04 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:04 INFO - 'USER': 'cltbld', 12:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:04 INFO - 'XPC_FLAGS': '0x0', 12:42:04 INFO - 'XPC_SERVICE_NAME': '0', 12:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:42:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:42:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42: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 12:42:08 INFO - Downloading docopt-0.6.1.tar.gz 12:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:42:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:42:08 INFO - Running setup.py install for blobuploader 12:42:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:42:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:42:08 INFO - Running setup.py install for requests 12:42:09 INFO - Running setup.py install for docopt 12:42:09 INFO - Successfully installed blobuploader requests docopt 12:42:09 INFO - Cleaning up... 12:42:09 INFO - Return code: 0 12:42:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:09 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')]} 12:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 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')]} 12:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:09 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42:09 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 12:42:09 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 12:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:09 INFO - 'HOME': '/Users/cltbld', 12:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:09 INFO - 'LOGNAME': 'cltbld', 12:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:09 INFO - 'MOZ_NO_REMOTE': '1', 12:42:09 INFO - 'NO_EM_RESTART': '1', 12:42:09 INFO - 'PAGER': '/bin/cat', 12:42:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:09 INFO - 'PWD': '/builds/slave/test', 12:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:09 INFO - 'SHELL': '/bin/bash', 12:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:09 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:09 INFO - 'USER': 'cltbld', 12:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:09 INFO - 'XPC_FLAGS': '0x0', 12:42:09 INFO - 'XPC_SERVICE_NAME': '0', 12:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-MRGTt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:09 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-YGIJ7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-WF4Ujn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-DOoKEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-b7w2KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-gzCbG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-6t8RxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-UDD2jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ZBqAUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-nKG0ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-10ruy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:10 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-aGRnNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:11 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-HVcXLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:11 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-BpLtUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:11 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-M_aHyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:11 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-4VnDla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:11 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-gOpLHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:42:11 INFO - Running setup.py install for manifestparser 12:42:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:42:11 INFO - Running setup.py install for mozcrash 12:42:11 INFO - Running setup.py install for mozdebug 12:42:11 INFO - Running setup.py install for mozdevice 12:42:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Running setup.py install for mozfile 12:42:12 INFO - Running setup.py install for mozhttpd 12:42:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Running setup.py install for mozinfo 12:42:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Running setup.py install for mozInstall 12:42:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:42:12 INFO - Running setup.py install for mozleak 12:42:12 INFO - Running setup.py install for mozlog 12:42:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Running setup.py install for moznetwork 12:42:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Running setup.py install for mozprocess 12:42:13 INFO - Running setup.py install for mozprofile 12:42:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Running setup.py install for mozrunner 12:42:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:42:13 INFO - Running setup.py install for mozscreenshot 12:42:13 INFO - Running setup.py install for moztest 12:42:13 INFO - Running setup.py install for mozversion 12:42:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:42:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:42:14 INFO - Cleaning up... 12:42:14 INFO - Return code: 0 12:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:14 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42:14 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 12:42:14 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 12:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:14 INFO - 'HOME': '/Users/cltbld', 12:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:14 INFO - 'LOGNAME': 'cltbld', 12:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:14 INFO - 'MOZ_NO_REMOTE': '1', 12:42:14 INFO - 'NO_EM_RESTART': '1', 12:42:14 INFO - 'PAGER': '/bin/cat', 12:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:14 INFO - 'PWD': '/builds/slave/test', 12:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:14 INFO - 'SHELL': '/bin/bash', 12:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:14 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:14 INFO - 'USER': 'cltbld', 12:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:14 INFO - 'XPC_FLAGS': '0x0', 12:42:14 INFO - 'XPC_SERVICE_NAME': '0', 12:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-y0llwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:42:14 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)) 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-syaf0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-3JxQZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:42:14 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)) 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-k_0sPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:42:14 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)) 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-3HMTh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:42:14 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)) 12:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:42:14 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-8dm1XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-N0B3w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-SpI4qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-vfI37H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-IMzLAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-ZP0D17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-IiWAu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-K4aY0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:42:15 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)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-yeJbJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:15 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-L7YEOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:42:16 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)) 12:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:42:16 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-aYC90d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:42:16 INFO - Running setup.py (path:/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/pip-XZh5N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:42:16 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)) 12:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:42:16 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)) 12:42:16 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)) 12:42:16 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)) 12:42:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:42:18 INFO - Downloading blessings-1.6.tar.gz 12:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:42:18 INFO - Installing collected packages: blessings 12:42:18 INFO - Running setup.py install for blessings 12:42:19 INFO - Successfully installed blessings 12:42:19 INFO - Cleaning up... 12:42:19 INFO - Return code: 0 12:42:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:42:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:19 INFO - Reading from file tmpfile_stdout 12:42:19 INFO - Current package versions: 12:42:19 INFO - blessings == 1.6 12:42:19 INFO - blobuploader == 1.2.4 12:42:19 INFO - docopt == 0.6.1 12:42:19 INFO - functools32 == 3.2.3-2 12:42:19 INFO - jsonschema == 2.5.1 12:42:19 INFO - manifestparser == 1.1 12:42:19 INFO - mozInstall == 1.12 12:42:19 INFO - mozcrash == 1.0 12:42:19 INFO - mozdebug == 0.1 12:42:19 INFO - mozdevice == 0.48 12:42:19 INFO - mozfile == 1.2 12:42:19 INFO - mozhttpd == 0.7 12:42:19 INFO - mozinfo == 0.9 12:42:19 INFO - mozleak == 0.1 12:42:19 INFO - mozlog == 3.4 12:42:19 INFO - moznetwork == 0.27 12:42:19 INFO - mozprocess == 0.23 12:42:19 INFO - mozprofile == 0.28 12:42:19 INFO - mozrunner == 6.13 12:42:19 INFO - mozscreenshot == 0.1 12:42:19 INFO - mozsystemmonitor == 0.3 12:42:19 INFO - moztest == 0.8 12:42:19 INFO - mozversion == 1.4 12:42:19 INFO - psutil == 3.1.1 12:42:19 INFO - requests == 1.2.3 12:42:19 INFO - wsgiref == 0.1.2 12:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:20 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 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42:20 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 12:42:20 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 12:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:20 INFO - 'HOME': '/Users/cltbld', 12:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:20 INFO - 'LOGNAME': 'cltbld', 12:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:20 INFO - 'MOZ_NO_REMOTE': '1', 12:42:20 INFO - 'NO_EM_RESTART': '1', 12:42:20 INFO - 'PAGER': '/bin/cat', 12:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:20 INFO - 'PWD': '/builds/slave/test', 12:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:20 INFO - 'SHELL': '/bin/bash', 12:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:20 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:20 INFO - 'USER': 'cltbld', 12:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:20 INFO - 'XPC_FLAGS': '0x0', 12:42:20 INFO - 'XPC_SERVICE_NAME': '0', 12:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 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)) 12:42:20 INFO - Cleaning up... 12:42:20 INFO - Return code: 0 12:42:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:42:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106aba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a30570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae03589d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, '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.COa3BN4Rbi/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.SerCndsYDR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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 12:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:20 INFO - 'HOME': '/Users/cltbld', 12:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:20 INFO - 'LOGNAME': 'cltbld', 12:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:20 INFO - 'MOZ_NO_REMOTE': '1', 12:42:20 INFO - 'NO_EM_RESTART': '1', 12:42:20 INFO - 'PAGER': '/bin/cat', 12:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:20 INFO - 'PWD': '/builds/slave/test', 12:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:20 INFO - 'SHELL': '/bin/bash', 12:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:20 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:20 INFO - 'USER': 'cltbld', 12:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:20 INFO - 'XPC_FLAGS': '0x0', 12:42:20 INFO - 'XPC_SERVICE_NAME': '0', 12:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:42:21 INFO - Cleaning up... 12:42:21 INFO - Return code: 0 12:42:21 INFO - Running post-action listener: _resource_record_post_action 12:42:21 INFO - Running post-action listener: _start_resource_monitoring 12:42:21 INFO - Starting resource monitoring. 12:42:21 INFO - [mozharness: 2017-02-06 20:42:21.210283Z] Finished create-virtualenv step (success) 12:42:21 INFO - [mozharness: 2017-02-06 20:42:21.211332Z] Running install step. 12:42:21 INFO - Running pre-action listener: _resource_record_pre_action 12:42:21 INFO - Running main action method: install 12:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:42:21 INFO - Reading from file tmpfile_stdout 12:42:21 INFO - Detecting whether we're running mozinstall >=1.0... 12:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:42:21 INFO - Reading from file tmpfile_stdout 12:42:21 INFO - Output received: 12:42:21 INFO - Usage: mozinstall [options] installer 12:42:21 INFO - Options: 12:42:21 INFO - -h, --help show this help message and exit 12:42:21 INFO - -d DEST, --destination=DEST 12:42:21 INFO - Directory to install application into. [default: 12:42:21 INFO - "/builds/slave/test"] 12:42:21 INFO - --app=APP Application being installed. [default: firefox] 12:42:21 INFO - mkdir: /builds/slave/test/build/application 12:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:42:42 INFO - Reading from file tmpfile_stdout 12:42:42 INFO - Output received: 12:42:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:42:42 INFO - Running post-action listener: _resource_record_post_action 12:42:42 INFO - [mozharness: 2017-02-06 20:42:42.653615Z] Finished install step (success) 12:42:42 INFO - [mozharness: 2017-02-06 20:42:42.653717Z] Running run-tests step. 12:42:42 INFO - Running pre-action listener: _resource_record_pre_action 12:42:42 INFO - Running main action method: run_tests 12:42:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:42:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:42:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:42:42 INFO - 2017-02-06 12:42:42.668 screenresolution[1626:7301] starting screenresolution argv=screenresolution get 12:42:42 INFO - 2017-02-06 12:42:42.670 screenresolution[1626:7301] Display 0: 1600x1200x32@60 12:42:42 INFO - 2017-02-06 12:42:42.676 screenresolution[1627:7303] starting screenresolution argv=screenresolution list 12:42:42 INFO - Available Modes on Display 0 12:42:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:42:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:42:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:42:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:42:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:42:42 INFO - Intel Iris: 12:42:42 INFO - Chipset Model: Intel Iris 12:42:42 INFO - Type: GPU 12:42:42 INFO - Bus: Built-In 12:42:42 INFO - VRAM (Dynamic, Max): 1536 MB 12:42:42 INFO - Vendor: Intel (0x8086) 12:42:42 INFO - Device ID: 0x0a2e 12:42:42 INFO - Revision ID: 0x0009 12:42:42 INFO - Displays: 12:42:42 INFO - Display: 12:42:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:42:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:42:42 INFO - Display Serial Number: 1600x1200 60 12:42:42 INFO - Main Display: Yes 12:42:42 INFO - Mirror: Off 12:42:42 INFO - Online: Yes 12:42:42 INFO - Rotation: Supported 12:42:42 INFO - Return code: 0 12:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:42:42 INFO - Python 2.7.3 12:42:42 INFO - Return code: 0 12:42:42 INFO - grabbing minidump binary from tooltool 12:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:42:42 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 0x1068ced30>, '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 0x106734db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:42:42 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 12:42:42 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 12:42:42 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 12:42:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:42:43 INFO - Return code: 0 12:42:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:42:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:42:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:42:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:42:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--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 12:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0265 --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 12:42:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.COa3BN4Rbi/Render', 12:42:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:42:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:42:43 INFO - 'HOME': '/Users/cltbld', 12:42:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:42:43 INFO - 'LOGNAME': 'cltbld', 12:42:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:42:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:42:43 INFO - 'MOZ_NO_REMOTE': '1', 12:42:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:42:43 INFO - 'NO_EM_RESTART': '1', 12:42:43 INFO - 'PAGER': '/bin/cat', 12:42:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:42:43 INFO - 'PWD': '/builds/slave/test', 12:42:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:42:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:42:43 INFO - 'SHELL': '/bin/bash', 12:42:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SerCndsYDR/Listeners', 12:42:43 INFO - 'TMPDIR': '/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/', 12:42:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:42:43 INFO - 'USER': 'cltbld', 12:42:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:42:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:42:43 INFO - 'XPC_FLAGS': '0x0', 12:42:43 INFO - 'XPC_SERVICE_NAME': '0', 12:42:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:42:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0265', '--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 12:42:43 INFO - mozversion application_buildid: 20170206101855 12:42:43 INFO - mozversion application_changeset: 501a3fa83897af9598adfd6f794b5d5ea82fe237 12:42:43 INFO - mozversion application_display_name: Firefox 12:42:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:42:43 INFO - mozversion application_name: Firefox 12:42:43 INFO - mozversion application_remotingname: firefox 12:42:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:42:43 INFO - mozversion application_vendor: Mozilla 12:42:43 INFO - mozversion application_version: 52.0 12:42:43 INFO - mozversion platform_buildid: 20170206101855 12:42:43 INFO - mozversion platform_changeset: 501a3fa83897af9598adfd6f794b5d5ea82fe237 12:42:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:42:43 INFO - mozversion platform_version: 52.0 12:42:43 INFO - using testdate: 1486413763 12:42:43 INFO - actual date: 1486413763 12:42:43 INFO - starting webserver on 'localhost:49239' 12:42:43 INFO - SUITE-START | Running 2 tests 12:42:43 INFO - TEST-START | dromaeo_css 12:42:43 INFO - operating with platform_type : mac_ 12:42:43 INFO - Initialising browser for dromaeo_css test... 12:42:43 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpuZdDVh/profile http://localhost:49239/getInfo.html) 12:42:46 INFO - PROCESS | 1637 | 2017-02-06 12:42:46.225 plugin-container[1640:7484] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 12:42:46 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:42:46 INFO - PROCESS | 1637 | 2017-02-06 12:42:46.226 plugin-container[1640:7484] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4f07, name = 'com.apple.CFPasteboardClient' 12:42:46 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:42:46 INFO - PROCESS | 1637 | 2017-02-06 12:42:46.226 plugin-container[1640:7484] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:42:46 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 12:42:46 INFO - PROCESS | 1637 | colorDepth:24 12:42:46 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 12:42:46 INFO - PROCESS | 1637 | __metrics 12:42:46 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 12:42:47 INFO - TEST-INFO | 1637: exit 0 12:42:47 INFO - Browser initialized. 12:42:47 INFO - Running cycle 1/1 for dromaeo_css test... 12:42:47 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpuZdDVh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:42:49 INFO - PROCESS | 1641 | 2017-02-06 12:42:49.462 plugin-container[1642:7614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 12:42:49 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:42:49 INFO - PROCESS | 1641 | 2017-02-06 12:42:49.463 plugin-container[1642:7614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 12:42:49 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:42:49 INFO - PROCESS | 1641 | 2017-02-06 12:42:49.463 plugin-container[1642:7614] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:42:59 INFO - PROCESS | 1641 | RSS: Main: 177446912 12:42:59 INFO - PROCESS | 1641 | 12:46:00 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 12:46:02 INFO - PROCESS | 1641 | RSS: Main: 183451648 12:46:02 INFO - PROCESS | 1641 | 12:49:04 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 12:49:05 INFO - PROCESS | 1641 | RSS: Main: 196775936 12:49:05 INFO - PROCESS | 1641 | 12:52:07 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 12:52:07 INFO - PROCESS | 1641 | RSS: Main: 198496256 12:52:07 INFO - PROCESS | 1641 | 12:55:09 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 12:55:10 INFO - PROCESS | 1641 | RSS: Main: 201592832 12:55:10 INFO - PROCESS | 1641 | 12:58:13 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 12:58:13 INFO - PROCESS | 1641 | RSS: Main: 204025856 12:58:13 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 13:01:16 INFO - PROCESS | 1641 | RSS: Main: 204582912 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | __start_tp_report 13:01:16 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 13:01:16 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 13:01:16 INFO - PROCESS | 1641 | |i|pagename|runs| 13:01:16 INFO - PROCESS | 1641 | |0;dojo.html;2911.3740545782653;2953.246922034881;3557.7687450315743;3595.334863050334;3598.85604575817;5706.600537962339;5773.047447171217;5808.419158084194;5844.415558444153;5871.735771890265;5840.6787626680625;5894.086416605433;5906.852328691774;5935.020721580934;5959.88080238395;3682.3739964206015;5001.274815151801;5061.658660454982;5152.9484705152845;5158.097332966725;5353.946460535403;5362.705051222181;5379.112446446351;5380.139177731564;5408.864778380553;5237.6071794615555;5354.43778403266;5372.382176049765;5373.946260537384;5377.11277639189;5260.263563101169;5292.735363231843;5310.123829568117;5342.492463215988;5364;4348.782560871944;4472.888177795581;5205.973970130125;5310.283111779938;5327.840164795062;4895.510448955111;5908.527317814607;5945.554083443759;6005.939940600625;6061.636301821861;6117.327094019654;6119.929102025404;6126.5176737973225;6144.354842741537;6176.104464852616;5229.137192363255;6118.663473508956;6216;6223.533235007348;6234.750609975596;5959.702014899238;5975.25309336333;5976.760929562813;5981.043033114681;5986.4612184903135;6201.565890387629;6264.937350626436;6269.811905642838;6282.151909492251;6360;6203.751849926042;6235.688215589203;6244.500439964792;6255.843603909848;6260.248770147611;6275.780347687809;6296.307406185316;6297.118403423525;6311.958526843111;6313.147725057059;6123.770712314271;6165.445109940127;6191.845203869849;6193.071039344134;6205.100260462208;6204.906926396107;6229.470495007975;6248.4688801452385;6264.436200741955;6267.1539342188225;5010.997800439926;5030.7233102179;5043.899122017612;5047.1419858623385;5049.722265275445;4451.933221001623;4469.865904022885;4495.64034877209;4573.56551127649;4576.061907308994;5204.375474943031;5614.859628509238;5894.997850365362;5910.852228694317;5930.644161350333;6227.314995350508;6229.595076320024;6260.342664020303;6282.465990390777;6300.779472718433;5708.942910570924;5798.6520808750765;5818.709064546841;5839.503642190376;5916.201312822714;5515.889682206333;5528.7235638218735;5529.529989950819;5537.307836520435;5558.610897237155;6426.485881129498;6441.355864413615;6483.4164925156965;6488.837779055561;6501.349865013555;6150.477209437069;6171.382861713792;6190.071489276645;6283.874322513433;6301.684915754286;5926.140709597171;6064.878702426015;6355.459785918064;6438.177614198771;6506.577072490273;6215.751369945332;6258.061290806416;6269.279032911274;6281.842953926189;6291.748330066929;6159.353267906805;6231.688415579293;6267.091271765477;6276.435120839146;6281.466075383643;6110.984061328701;6119.41115851624;6142.314611233224;6217.440430361289;6247.12540244357;6174.536909731878;6183.196184495987;6204.410580994799;6217.689115544295;6222.657753823583;5671.971640141938;6013.218281623361;6084.39156084388;6112.235970503687;6116.204893363834;4783.856484305476;5225.712585807665;5398.514133727984;6036.034234522455;6178.5366097543765;6041.486473649789;6093.500797448272;6105.755769769159;6107.267127944675;6128.32588415265 13:01:16 INFO - PROCESS | 1641 | |1;ext.html;489.554505400086;500.1672215760758;506.21789335476683;545.6126150433191;553.3000754046133;28421.715782842166;32793.67206327936;41213.79393103034;42923.570764292344;42960.570394296046;42114.78942605283;42804.35793463101;42840.78579607105;42914;43047.35428968568;9477.289203309761;9730.026997300283;9769.023097690246;9826.410415375065;9832.705018849447;9733.415995040321;9778.853317200248;9848.310618256724;9857;9936.50317484123;9836;9866.112049915506;9884.90115098847;9885.851712224287;9887.159591434736;9774.413535187876;9855.014498550123;9866.45734484603;9879.209663226997;9896.604135834557;9686.370385924964;9798.26513011527;9808.019198080136;9816.803663926681;9828.852567211497;40947.38578921289;41332.586674133476;41364.1727165458;41455.1708965822;41600.1679966402;3273.4107860585086;3574.7140228781896;3616.8734094306574;3691.9446208306895;3947.388154836005;29909.850450747825;29946.401071978657;30015.549766753516;30276.394472110656;32207.35585288281;3300.5709257796334;3320.933581328384;3377.8986630401128;3418.8632454701783;3463;492238;497602;498717;499802.50098749634;500652;50554.74722626364;56642.716786416626;57680.711596441746;57742;58131;59611.70194149001;59813.20560383196;59900.400995990356;60026.69986650126;60045;13194.802077968838;13468.461261549624;15786;16127.677446451005;16421.261043253082;12855.678608034686;12870.356482175854;12906.612801615967;12940.935295323652;12951.805722914163;14289.356978935974;15038.54884353471;15161.696766064617;15290.311935962685;15422.46021389246;3274.9836250818594;3378.3074469733647;6055.303640081359;6231.532635052389;6249.531285153541;924.311388015919;987.170776547689;1004.3321191407778;1018.3737001744022;1123.8707548632012;30306.242343941136;30357;30645.540316895265;30746.610031040786;31263.37473250522;1108.3294606762954;1119.9384033878214;1152.8558930133734;1183.8756930522343;1206.203905422417;12503.249805011728;15953.282102305424;15985.200739962955;16017.759733604005;16040.839591604168;708326;724356;726128;726829;727403;52010;54879.62800930009;58529.41470585325;59013.819723606146;59046.40953590409;1187.4775098956432;1360.3606305036617;1412.1950488221821;1415.6460884778805;1422.9359678814478;29924.102276931728;30397.088087357413;30446.84776576103;30512.932047378235;31114.844425777726;49350;49817.00365992732;49891;49958.75020624873;50000.49999499958;569274;632701;634745;637634;638321;26676.466470670865;26858;26946.59580106339;27055.86472067627;27114;46362.53637463582;47039;47117.52882471131;47253.2912006327;47854;39149.41275880921;39439.60560394359;39509.2098158041;40572.594274058065;40662.983425414604;31555.684443155274;38793.80603096967;39085.41371879367;39528.604713953646;40203.79388618346;36995.63004369922;37151.07122321964;37419.43870841994;38917.80541097277;38951;33548.99353019414;34773;34863;35018.07394111594;35247;25665.61501577515;25870.353241169123;25892.22323330303;26222.475550489264;26489 13:01:16 INFO - PROCESS | 1641 | |2;jquery.html;377.79410221429316;384.1740258444344;395.15042658284676;395.99010024749396;406.67872380819153;19105;21025.218065032084;21324.147034118636;21348.46628834276;21552.784472155272;20367.28714494993;20834.68747968782;20911.268105616306;21203.257885973995;21229.787702122972;5817.709114544277;5835.620684655505;6025.096235564656;6078.878422431549;6079.4528492435675;4286.76422796746;4541.341505481703;5974.074018527113;6079.331273559905;6372.490200783949;6608.7686930957425;6710.496712746539;6721.529492935497;6723.428508576777;6738.59568425896;6456.903146452807;6668.133142691468;6683.0977817994435;6685.565438246498;6696.196456425211;5742.08126699726;5757.193992841006;5791.160281759121;5803.738831752581;5858.560607954378;25852.612210816853;25895.223143305542;25895.96416143371;26031.21906342813;26163.691815409155;1862.9254829806791;2572.6784151981;2671.2654020144423;3017.170278173498;3024.2741741981986;8718.476891386537;10010.099091081838;10323.277370583986;10624.628138015132;10739.677809665722;1857.7863545692283;1886.8584856135844;1931.9710204346945;1948.7466629338237;1953.42373999669;119615;128723;130055.34972325078;133225.33387333;134380.65619343778;11602.477888495037;11658.475368608433;11816.172867899164;11842;11893.583724569598;14860;15050.698986020217;15078.944473886722;15094.094354338775;15148;8592.011918629312;8717.47695138281;8767.736967890973;8874.86687699685;8875.556222188994;6728.966355168192;7090.503664743522;8201.261886430131;8534.957325213334;8643.956780216058;4535.866033491627;4618.214903466419;4631.814727410866;4633.837815676503;4659.324397962344;1484.2504535209866;1614.6205641674196;1725.4306078993902;1752.553098959757;2025.929092481756;733.6845156582721;891.9331050171263;942.3639043645512;963.3641796414333;982.4792859784326;20071.899640501702;20440.488987775425;20545.48636284075;21021.05405256767;21079.26222582202;902.7968707040864;915.2091481209442;970.6020531582159;1000.034966257565;1037.1547189041057;10744.086752626114;11050.115990720724;11055.944720276348;11079.889201108046;11146;594579.0271048617;602379;603706;610142;621180;119542.402287988;128299.60404751489;130182;130504.347478262;130665;952.3000594562991;975.6146322202832;984.9359791613665;984.9606015759433;986.9605215791288;17527.737083944005;18144.909275453538;18762.718559221896;18765.34321298748;18810.87134771918;53330.46669533255;54312.72843635757;54938.45061549333;55040;56306.87386252334;77335.61332193304;78538.60730696538;78727;78889;79003;6226.813195603958;7339.74310899116;7532.5857077859055;7597.88603170964;7620.085589729047;10107.292489525662;12351;12443.626691199279;12560.560380387009;12659.240445573296;10196.439195844003;10758.354498730101;10866.891331086588;10877.564897404332;10953.780924381308;10036.949815250877;10525.789484210427;10543.841842372218;10639.202059845697;11032.503537340679;10640.467976600985;10832.5125369357;10862;11136.944315278372;11243.325400475998;7181.138263408425;7304.4886857921565;7362.889556656762;7450.813729656802;7468.253174682705;9684.85472717924;10412.583496660049;10665.89334106649;10999.890001099886;11037.613683521038 13:01:16 INFO - PROCESS | 1641 | |3;mootools.html;1305.6017914536067;1512.6520900192954;1576.9592069234307;1656.4450908945503;1843.5298998755316;7818.296353328199;8060.717874874381;8298.045724741656;8848.336374771885;8854.645814167425;6844.5208835381545;8554.52950087745;8595.097514760953;8712.17234362736;8749.168828961254;2395.1497218487402;2430.3438071720625;2432.8661923594195;2436.792872605831;2441.890114944823;2436.50051739393;2449.9265022049367;2453.852768833867;2479.466914613358;2485.378655336166;2410.5419970205694;2421.055788242587;2433.6592876997233;2440.4386990992084;2440.633904914268;2391.8325717199805;2394.760523947609;2415.5651982643117;2419.2742177346813;2433.5497932882386;1992.6413245615784;2428.0651948999584;2431.8297719159664;2440.414300567851;2443.3525115844313;7488.663010164556;7943.960280198562;8674.739757807276;8720.171583699539;8803.823923521557;5292.867678308035;5445;5455.1544510600925;5458.781648734046;5470.097433923398;3505.071156143624;3602.35157671619;3625.0574850538787;3635.1275693833554;3675.1363429594026;920.4293338130335;1068;1121.0639116337786;1121.6578943422253;1140.6920131564432;11179.608713695063;11422.371769552672;11456.083513318914;11473.713157171138;11481.138914581355;4584.908301834012;4734.573888350065;4832.540908613676;4834.419869615598;4883.731394773322;9728.61085556584;9731.805363892683;9766.706998790047;9771.4625695586;9783.608655653836;5383.43473935239;5384.40771515133;5388.54197393226;5396.109641909119;5405.378381486179;4433.6009759121835;4498.865034048984;4915.827946021872;4947.1837146871085;4954.331165292711;3100.488419410817;4021.2560676274984;4034.3948407739076;4130.586941305905;4147.52303485097;1304.1588175626857;1311.6261865368515;1316.7695653260641;1329.2356894785537;1330.3281842669583;914.5975770660888;934.3086116273909;938.5119737736339;939.4645052320112;960.8126415348939;4921.9507804922205;5634.971825140848;5809.970950145223;5853.64878107315;6013.1581578579035;444.95327990561174;461.88452886778305;469.7252107517141;472.773068926917;478.85873667268237;3925.646691797752;3960.386140148282;3982.26328129297;3990.580988996114;4009.8997525061523;10106.140978016803;10461.320014199053;10464.110550603284;10489.475526223658;10541.84187237192;10269.691909242734;10304.793904121876;10388.636397726043;10393.37639741618;10428.27002109845;7730;8077.03075630928;8115.350771938112;8157.1842815717955;8214.876776848352;5502.147167189092;5573.136163894603;5664.915026274692;5667.489925906688;5689.061304884648;7825.843483130419;9512.23902087845;9610.038996100335;9621.989691082335;9642.566084526354;9746.366486178376;9759.560819762986;9812.165965892978;9930.354526955725;9959.601615935282;5896.528277737685;6784.2876497967;6965.686544105426;7345.77962661121;7448.702051917862;7900.170482099296;7998.640061197144;8133.2680058794995;8142.1857814220475;8145.144759800136;7208.35124838767;7408.592527411044;7482.663280152297;7489.812754681177;7579.962100189464;7168.67740951648;7271.854562908818;7280.017197678246;7297.306755858185;7304.890426643498;6828.692708828015;6947.305269473214;6952.304769523007;6961.965190174017;6965.407940324926;4873.805047798049;4916.213405855046;4919.385076865392;5030.37120359955;5083.745812709423;5009.348784657971;5046.747662616781;5085.237214417867;5103.362079740033;5137.8201762938115 13:01:16 INFO - PROCESS | 1641 | |4;prototype.html;281.5902861336755;316.9429502689518;326.16989761058113;329.35939597482906;329.6406916461057;4302.827886884521;4567.840125595605;4939.888525081855;5511.401693508883;5615.887682246353;4853.563179313861;4881.609471242301;5201.271821944931;5330.680159190441;5442.102053161224;3731.291054699605;3971.1462035662325;4175.686823488235;4176.665866730655;4239.7704665646925;4082.4284600156;4202.915941681164;4214.91570168598;4218.6625069994325;4223.134257477225;4086.3257562502154;4122.752634841919;4124.690648201382;4130.896727581804;4145.233131870614;3261.624913134996;3650.3611867923273;4142.233686767942;4173.39485774564;4204.306289462235;3600.747947643666;3619.3123306571665;3647.471116688065;3649.580298265707;3658.9571971987857;4779.474257831635;5159.638825282232;5232.136697444955;5294.947050529484;5312.6281160318795;4025.4766880305665;4070.4097905803787;4606.124836281096;4786.880327991828;4823.324734537167;5641.5204707599905;5725.799597014085;5731.369549349568;5744.597878148531;5768.682722450264;3838.1172330363893;3952.7035472339403;3966.7901290106506;3987.940180897289;3989.7606143631474;5471.781128754845;5847.883042339129;6041.788537401214;6088.847778805521;6132.41742034506;3606.585242697071;4037.1320166164414;4079.8572049978106;4097.569755175723;4109.198706252252;3244.545763593099;3490.6683865032783;4088.795560221977;4137.40007698888;4174.4364510791265;4758.42898852133;4764.761761911891;4790.449098353664;4792.329073929653;4806.831760888352;5709.887341683604;5750.683712395775;5791.88416231673;5799.333076696234;5868.647881127146;1272.8663490333568;1287.5107459165458;1342.744878473087;1351.4053816320788;1355.9389827457787;828.45736042892;908.3051465628799;917.4128557723062;918.7092135549431;934.3412893909777;5226.844658496504;5252.474752524793;5260.9736951315;5267.078261304257;5271.868203294948;4845.425236798054;5379.78480860769;5587.8824235152315;5733.483986441157;5740.65556066629;4227.830886764556;4478.7088839226;4854.83008094715;4999.400071991385;5231.633785634969;2724.6185534025253;2944.661363943131;2946.6022087018405;2965.925851853721;2979.3743313904324;4825.793551612097;5562.610617256834;5743.310802703619;5832.941670583325;5907.168777678933;5304.814331498379;5598.916016259759;5629.6903670298525;5673.404292549306;5857.70711464425;5063.316452278968;5839.620424672383;5840.532757379399;5845.444682755046;5872.354041055481;4861.805527778849;4919.262110683283;5629.54963602919;5643.209950607001;5733.283339582552;4494.191045611821;4767.928481072856;4768.904621907612;5176.628193528642;5619.971900140473;5041.470645582161;5344.9732751336;5633.0705433603;5855.774805573855;5910.8377018295005;3240.303334783033;3340.7828491148;3381.864725411054;3885.9805700971315;3895.8831235062994;5633.549316054788;5691.914621280767;5705.828825135252;5740.540756739368;5873.500752436091;4942.6293028023765;5400;5904.793332233523;5906.704664766658;5923.259592550931;5124.769385377742;5794.652320860761;5875.882482350415;5881.353051164454;5897.67562784051;4803.279508073677;5302.443243459536;5606.915896261641;5725.2843394575675;5762.683052432157;5302.31069960918;5707.258056452634;5847.070466745879;5885.646861188342;5890.322612899571;4924.482929292516;5168.767405466688;5573.052581061311;5758.280214973129;5795.94204057954 13:01:16 INFO - PROCESS | 1641 | |5;yui.html;773.462443601697;777.5295945952702;793.5595744361881;814.7759366174301;825.7027470110763;14718.043327183726;15314.157721325337;15329;15355.846441535581;15442.845571544296;13767.65580860479;13800.723985520308;13928.651783705413;13956.79064814026;13959.511417100404;850.6299759604561;871.4509858788954;883.9337049721264;890.9287257019455;891.3270480787029;877.692807517367;882.8940527136753;886.6098916476761;886.8226354729047;889.5463313710022;901.5357091098057;946.1342871272777;948.7960088580953;951.1344676344528;951.7668171298042;881.066069965835;932.0353434195575;940.6284517615537;940.9764755881089;941.4116177389132;683.8427161752825;697.2191145916606;700.075899812248;702.217028013766;707.3174386716792;14789.778153327708;14799.40802367904;14869.256537173098;15004.624884377869;15088;13801.171929684251;14146.858531414657;14246.857531424657;14347.497837575738;14435.206063666494;11582.247153934968;11778.469968851423;11933.04535637147;11939.641810745692;11961.40192990347;3686.594474607791;3722.1961055991183;3738.476613274144;3846.442265871433;3880.185161116169;89825.55087224522;99787.0021299785;100104.49947750288;100157;103567.48216258945;10446.582136714598;10576.36541807494;10858.837117443245;10976.23166378346;11050.281731687575;20676;21048.26331078405;21182;21340.359789206348;21417.46456338573;7680.116786569504;7838.960805195938;7916.247956444128;7943.126256111823;8014.83970320602;4349.217140914602;4363.912721745547;4432.933505997413;4464.017916058462;4478.932816007762;3330.117518857505;3449.7067749241596;3450.3099380124077;3452.1369657585606;3455.326211388755;547.4990383798859;616.7163104971673;636.2428709835374;644.5005121031145;654.1234745441132;556.6381851796365;581.8109114537792;586.8738221282359;605.2948315212816;605.6124080588427;8863.335249856287;8949.507777072193;9075.228605568469;9084.8637270441;9149.451032938045;594.5927039977543;596.9492593129632;644.2333622988629;646.3342756960338;650.7624716978363;3824.2351529694174;4378.759168245713;4433.556644335541;4445.022095139064;4519.231730605805;83821.74267385995;96747.51626241824;104116;121243;124154;104996;105206;105340.94659053312;106398;110843;89412;89590.55204723934;90675.54662226647;92117.53941230386;92322;8540.10328915455;8650.956745216234;8653.437526560754;8654.30765538768;8824.867626985471;42322.36516452194;54426.45573544214;55010;55882.720586396805;58406.4159358401;70086.29913701002;78546.6072669633;79858.80211796943;81698.59150704209;82020.58989705013;10361.948190259;10687.625933092615;10846.783064338511;10906.836397453886;10935.726606834893;11765.76468470643;12099.33453660057;12111.576094836639;12599.18105323151;12616.053795965156;11794.351310677996;11873.228240164362;12088;12218.816717749418;12327.50689972391;11509.482073306888;11634.418279086181;11644.301341919512;11747.353895535827;11843.407829608657;11172.106231501622;11535.307881527135;11716;12767.425465853874;13708.108972916729;8721.781955451164;10915.454227288445;11009.394483303175;11276.887231127585;11549.249298795552;11410.301741525138;11490.368029758109;11517.796004458145;11606.767864642828;11622 13:01:16 INFO - PROCESS | 1641 | __end_tp_report 13:01:16 INFO - PROCESS | 1641 | __start_cc_report 13:01:16 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,364 13:01:16 INFO - PROCESS | 1641 | __end_cc_report 13:01:16 INFO - PROCESS | 1641 | __startTimestamp1486414876557__endTimestamp 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | ------- Summary: start ------- 13:01:16 INFO - PROCESS | 1641 | Number of tests: 6 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5764.70 Median:6041.49 stddev:683.73 (11.3%) stddev-sans-first:648.16 13:01:16 INFO - PROCESS | 1641 | Values: 2911.4 2953.2 3557.8 3595.3 3598.9 5706.6 5773.0 5808.4 5844.4 5871.7 5840.7 5894.1 5906.9 5935.0 5959.9 3682.4 5001.3 5061.7 5152.9 5158.1 5353.9 5362.7 5379.1 5380.1 5408.9 5237.6 5354.4 5372.4 5373.9 5377.1 5260.3 5292.7 5310.1 5342.5 5364.0 4348.8 4472.9 5206.0 5310.3 5327.8 4895.5 5908.5 5945.6 6005.9 6061.6 6117.3 6119.9 6126.5 6144.4 6176.1 5229.1 6118.7 6216.0 6223.5 6234.8 5959.7 5975.3 5976.8 5981.0 5986.5 6201.6 6264.9 6269.8 6282.2 6360.0 6203.8 6235.7 6244.5 6255.8 6260.2 6275.8 6296.3 6297.1 6312.0 6313.1 6123.8 6165.4 6191.8 6193.1 6205.1 6204.9 6229.5 6248.5 6264.4 6267.2 5011.0 5030.7 5043.9 5047.1 5049.7 4451.9 4469.9 4495.6 4573.6 4576.1 5204.4 5614.9 5895.0 5910.9 5930.6 6227.3 6229.6 6260.3 6282.5 6300.8 5708.9 5798.7 5818.7 5839.5 5916.2 5515.9 5528.7 5529.5 5537.3 5558.6 6426.5 6441.4 6483.4 6488.8 6501.3 6150.5 6171.4 6190.1 6283.9 6301.7 5926.1 6064.9 6355.5 6438.2 6506.6 6215.8 6258.1 6269.3 6281.8 6291.7 6159.4 6231.7 6267.1 6276.4 6281.5 6111.0 6119.4 6142.3 6217.4 6247.1 6174.5 6183.2 6204.4 6217.7 6222.7 5672.0 6013.2 6084.4 6112.2 6116.2 4783.9 5225.7 5398.5 6036.0 6178.5 6041.5 6093.5 6105.8 6107.3 6128.3 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:73683.14 Median:40617.79 stddev:166610.11 (410.2%) stddev-sans-first:166986.86 13:01:16 INFO - PROCESS | 1641 | Values: 489.6 500.2 506.2 545.6 553.3 28421.7 32793.7 41213.8 42923.6 42960.6 42114.8 42804.4 42840.8 42914.0 43047.4 9477.3 9730.0 9769.0 9826.4 9832.7 9733.4 9778.9 9848.3 9857.0 9936.5 9836.0 9866.1 9884.9 9885.9 9887.2 9774.4 9855.0 9866.5 9879.2 9896.6 9686.4 9798.3 9808.0 9816.8 9828.9 40947.4 41332.6 41364.2 41455.2 41600.2 3273.4 3574.7 3616.9 3691.9 3947.4 29909.9 29946.4 30015.5 30276.4 32207.4 3300.6 3320.9 3377.9 3418.9 3463.0 492238.0 497602.0 498717.0 499802.5 500652.0 50554.7 56642.7 57680.7 57742.0 58131.0 59611.7 59813.2 59900.4 60026.7 60045.0 13194.8 13468.5 15786.0 16127.7 16421.3 12855.7 12870.4 12906.6 12940.9 12951.8 14289.4 15038.5 15161.7 15290.3 15422.5 3275.0 3378.3 6055.3 6231.5 6249.5 924.3 987.2 1004.3 1018.4 1123.9 30306.2 30357.0 30645.5 30746.6 31263.4 1108.3 1119.9 1152.9 1183.9 1206.2 12503.2 15953.3 15985.2 16017.8 16040.8 708326.0 724356.0 726128.0 726829.0 727403.0 52010.0 54879.6 58529.4 59013.8 59046.4 1187.5 1360.4 1412.2 1415.6 1422.9 29924.1 30397.1 30446.8 30512.9 31114.8 49350.0 49817.0 49891.0 49958.8 50000.5 569274.0 632701.0 634745.0 637634.0 638321.0 26676.5 26858.0 26946.6 27055.9 27114.0 46362.5 47039.0 47117.5 47253.3 47854.0 39149.4 39439.6 39509.2 40572.6 40663.0 31555.7 38793.8 39085.4 39528.6 40203.8 36995.6 37151.1 37419.4 38917.8 38951.0 33549.0 34773.0 34863.0 35018.1 35247.0 25665.6 25870.4 25892.2 26222.5 26489.0 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:35614.21 Median:26097.46 stddev:101436.33 (388.7%) stddev-sans-first:101686.38 13:01:16 INFO - PROCESS | 1641 | Values: 377.8 384.2 395.2 396.0 406.7 19105.0 21025.2 21324.1 21348.5 21552.8 20367.3 20834.7 20911.3 21203.3 21229.8 5817.7 5835.6 6025.1 6078.9 6079.5 4286.8 4541.3 5974.1 6079.3 6372.5 6608.8 6710.5 6721.5 6723.4 6738.6 6456.9 6668.1 6683.1 6685.6 6696.2 5742.1 5757.2 5791.2 5803.7 5858.6 25852.6 25895.2 25896.0 26031.2 26163.7 1862.9 2572.7 2671.3 3017.2 3024.3 8718.5 10010.1 10323.3 10624.6 10739.7 1857.8 1886.9 1932.0 1948.7 1953.4 119615.0 128723.0 130055.3 133225.3 134380.7 11602.5 11658.5 11816.2 11842.0 11893.6 14860.0 15050.7 15078.9 15094.1 15148.0 8592.0 8717.5 8767.7 8874.9 8875.6 6729.0 7090.5 8201.3 8535.0 8644.0 4535.9 4618.2 4631.8 4633.8 4659.3 1484.3 1614.6 1725.4 1752.6 2025.9 733.7 891.9 942.4 963.4 982.5 20071.9 20440.5 20545.5 21021.1 21079.3 902.8 915.2 970.6 1000.0 1037.2 10744.1 11050.1 11055.9 11079.9 11146.0 594579.0 602379.0 603706.0 610142.0 621180.0 119542.4 128299.6 130182.0 130504.3 130665.0 952.3 975.6 984.9 985.0 987.0 17527.7 18144.9 18762.7 18765.3 18810.9 53330.5 54312.7 54938.5 55040.0 56306.9 77335.6 78538.6 78727.0 78889.0 79003.0 6226.8 7339.7 7532.6 7597.9 7620.1 10107.3 12351.0 12443.6 12560.6 12659.2 10196.4 10758.4 10866.9 10877.6 10953.8 10036.9 10525.8 10543.8 10639.2 11032.5 10640.5 10832.5 10862.0 11136.9 11243.3 7181.1 7304.5 7362.9 7450.8 7468.3 9684.9 10412.6 10665.9 10999.9 11037.6 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5589.28 Median:5065.25 stddev:3081.36 (60.8%) stddev-sans-first:3073.18 13:01:16 INFO - PROCESS | 1641 | Values: 1305.6 1512.7 1577.0 1656.4 1843.5 7818.3 8060.7 8298.0 8848.3 8854.6 6844.5 8554.5 8595.1 8712.2 8749.2 2395.1 2430.3 2432.9 2436.8 2441.9 2436.5 2449.9 2453.9 2479.5 2485.4 2410.5 2421.1 2433.7 2440.4 2440.6 2391.8 2394.8 2415.6 2419.3 2433.5 1992.6 2428.1 2431.8 2440.4 2443.4 7488.7 7944.0 8674.7 8720.2 8803.8 5292.9 5445.0 5455.2 5458.8 5470.1 3505.1 3602.4 3625.1 3635.1 3675.1 920.4 1068.0 1121.1 1121.7 1140.7 11179.6 11422.4 11456.1 11473.7 11481.1 4584.9 4734.6 4832.5 4834.4 4883.7 9728.6 9731.8 9766.7 9771.5 9783.6 5383.4 5384.4 5388.5 5396.1 5405.4 4433.6 4498.9 4915.8 4947.2 4954.3 3100.5 4021.3 4034.4 4130.6 4147.5 1304.2 1311.6 1316.8 1329.2 1330.3 914.6 934.3 938.5 939.5 960.8 4922.0 5635.0 5810.0 5853.6 6013.2 445.0 461.9 469.7 472.8 478.9 3925.6 3960.4 3982.3 3990.6 4009.9 10106.1 10461.3 10464.1 10489.5 10541.8 10269.7 10304.8 10388.6 10393.4 10428.3 7730.0 8077.0 8115.4 8157.2 8214.9 5502.1 5573.1 5664.9 5667.5 5689.1 7825.8 9512.2 9610.0 9622.0 9642.6 9746.4 9759.6 9812.2 9930.4 9959.6 5896.5 6784.3 6965.7 7345.8 7448.7 7900.2 7998.6 8133.3 8142.2 8145.1 7208.4 7408.6 7482.7 7489.8 7580.0 7168.7 7271.9 7280.0 7297.3 7304.9 6828.7 6947.3 6952.3 6962.0 6965.4 4873.8 4916.2 4919.4 5030.4 5083.7 5009.3 5046.7 5085.2 5103.4 5137.8 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4569.65 Median:5052.39 stddev:1399.46 (27.7%) stddev-sans-first:1365.87 13:01:16 INFO - PROCESS | 1641 | Values: 281.6 316.9 326.2 329.4 329.6 4302.8 4567.8 4939.9 5511.4 5615.9 4853.6 4881.6 5201.3 5330.7 5442.1 3731.3 3971.1 4175.7 4176.7 4239.8 4082.4 4202.9 4214.9 4218.7 4223.1 4086.3 4122.8 4124.7 4130.9 4145.2 3261.6 3650.4 4142.2 4173.4 4204.3 3600.7 3619.3 3647.5 3649.6 3659.0 4779.5 5159.6 5232.1 5294.9 5312.6 4025.5 4070.4 4606.1 4786.9 4823.3 5641.5 5725.8 5731.4 5744.6 5768.7 3838.1 3952.7 3966.8 3987.9 3989.8 5471.8 5847.9 6041.8 6088.8 6132.4 3606.6 4037.1 4079.9 4097.6 4109.2 3244.5 3490.7 4088.8 4137.4 4174.4 4758.4 4764.8 4790.4 4792.3 4806.8 5709.9 5750.7 5791.9 5799.3 5868.6 1272.9 1287.5 1342.7 1351.4 1355.9 828.5 908.3 917.4 918.7 934.3 5226.8 5252.5 5261.0 5267.1 5271.9 4845.4 5379.8 5587.9 5733.5 5740.7 4227.8 4478.7 4854.8 4999.4 5231.6 2724.6 2944.7 2946.6 2965.9 2979.4 4825.8 5562.6 5743.3 5832.9 5907.2 5304.8 5598.9 5629.7 5673.4 5857.7 5063.3 5839.6 5840.5 5845.4 5872.4 4861.8 4919.3 5629.5 5643.2 5733.3 4494.2 4767.9 4768.9 5176.6 5620.0 5041.5 5345.0 5633.1 5855.8 5910.8 3240.3 3340.8 3381.9 3886.0 3895.9 5633.5 5691.9 5705.8 5740.5 5873.5 4942.6 5400.0 5904.8 5906.7 5923.3 5124.8 5794.7 5875.9 5881.4 5897.7 4803.3 5302.4 5606.9 5725.3 5762.7 5302.3 5707.3 5847.1 5885.6 5890.3 4924.5 5168.8 5573.1 5758.3 5795.9 13:01:16 INFO - PROCESS | 1641 | 13:01:16 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:21258.42 Median:23101.28 stddev:31882.07 (138.0%) stddev-sans-first:31934.41 13:01:16 INFO - PROCESS | 1641 | Values: 773.5 777.5 793.6 814.8 825.7 14718.0 15314.2 15329.0 15355.8 15442.8 13767.7 13800.7 13928.7 13956.8 13959.5 850.6 871.5 883.9 890.9 891.3 877.7 882.9 886.6 886.8 889.5 901.5 946.1 948.8 951.1 951.8 881.1 932.0 940.6 941.0 941.4 683.8 697.2 700.1 702.2 707.3 14789.8 14799.4 14869.3 15004.6 15088.0 13801.2 14146.9 14246.9 14347.5 14435.2 11582.2 11778.5 11933.0 11939.6 11961.4 3686.6 3722.2 3738.5 3846.4 3880.2 89825.6 99787.0 100104.5 100157.0 103567.5 10446.6 10576.4 10858.8 10976.2 11050.3 20676.0 21048.3 21182.0 21340.4 21417.5 7680.1 7839.0 7916.2 7943.1 8014.8 4349.2 4363.9 4432.9 4464.0 4478.9 3330.1 3449.7 3450.3 3452.1 3455.3 547.5 616.7 636.2 644.5 654.1 556.6 581.8 586.9 605.3 605.6 8863.3 8949.5 9075.2 9084.9 9149.5 594.6 596.9 644.2 646.3 650.8 3824.2 4378.8 4433.6 4445.0 4519.2 83821.7 96747.5 104116.0 121243.0 124154.0 104996.0 105206.0 105340.9 106398.0 110843.0 89412.0 89590.6 90675.5 92117.5 92322.0 8540.1 8651.0 8653.4 8654.3 8824.9 42322.4 54426.5 55010.0 55882.7 58406.4 70086.3 78546.6 79858.8 81698.6 82020.6 10361.9 10687.6 10846.8 10906.8 10935.7 11765.8 12099.3 12111.6 12599.2 12616.1 11794.4 11873.2 12088.0 12218.8 12327.5 11509.5 11634.4 11644.3 11747.4 11843.4 11172.1 11535.3 11716.0 12767.4 13708.1 8721.8 10915.5 11009.4 11276.9 11549.2 11410.3 11490.4 11517.8 11606.8 11622.0 13:01:16 INFO - PROCESS | 1641 | -------- Summary: end -------- 13:01:16 INFO - PROCESS | 1641 | 13:01:17 INFO - TEST-INFO | 1641: exit 0 13:01:17 INFO - TEST-OK | dromaeo_css | took 1113889ms 13:01:17 INFO - TEST-START | kraken 13:01:17 INFO - operating with platform_type : mac_ 13:01:17 INFO - Initialising browser for kraken test... 13:01:17 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpB1oxLb/profile http://localhost:49239/getInfo.html) 13:01:19 INFO - PROCESS | 1653 | 2017-02-06 13:01:19.979 plugin-container[1655:9920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 13:01:19 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:01:19 INFO - PROCESS | 1653 | 2017-02-06 13:01:19.980 plugin-container[1655:9920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 13:01:19 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:01:19 INFO - PROCESS | 1653 | 2017-02-06 13:01:19.980 plugin-container[1655:9920] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:01:20 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 13:01:20 INFO - PROCESS | 1653 | colorDepth:24 13:01:20 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 13:01:20 INFO - PROCESS | 1653 | __metrics 13:01:20 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:01:20 INFO - TEST-INFO | 1653: exit 0 13:01:20 INFO - Browser initialized. 13:01:20 INFO - Running cycle 1/1 for kraken test... 13:01:20 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/tmpB1oxLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:23 INFO - PROCESS | 1656 | 2017-02-06 13:01:23.390 plugin-container[1657:10041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 13:01:23 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:01:23 INFO - PROCESS | 1656 | 2017-02-06 13:01:23.391 plugin-container[1657:10041] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8817, name = 'com.apple.CFPasteboardClient' 13:01:23 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:01:23 INFO - PROCESS | 1656 | 2017-02-06 13:01:23.391 plugin-container[1657:10041] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:01:33 INFO - PROCESS | 1656 | RSS: Main: 177221632 13:01:33 INFO - PROCESS | 1656 | 13:01:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 13:01:37 INFO - PROCESS | 1656 | RSS: Main: 190431232 13:01:37 INFO - PROCESS | 1656 | 13:01:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 13:01:40 INFO - PROCESS | 1656 | RSS: Main: 199368704 13:01:40 INFO - PROCESS | 1656 | 13:01:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 13:01:43 INFO - PROCESS | 1656 | RSS: Main: 202428416 13:01:43 INFO - PROCESS | 1656 | 13:01:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 13:01:46 INFO - PROCESS | 1656 | RSS: Main: 203657216 13:01:46 INFO - PROCESS | 1656 | 13:01:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:01:49 INFO - PROCESS | 1656 | RSS: Main: 203771904 13:01:49 INFO - PROCESS | 1656 | 13:01:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 13:01:52 INFO - PROCESS | 1656 | RSS: Main: 207446016 13:01:52 INFO - PROCESS | 1656 | 13:01:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 13:01:55 INFO - PROCESS | 1656 | RSS: Main: 207953920 13:01:55 INFO - PROCESS | 1656 | 13:01:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 13:01:59 INFO - PROCESS | 1656 | RSS: Main: 207314944 13:01:59 INFO - PROCESS | 1656 | 13:02:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:02:01 INFO - PROCESS | 1656 | RSS: Main: 207339520 13:02:01 INFO - PROCESS | 1656 | 13:02:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:02:04 INFO - PROCESS | 1656 | RSS: Main: 206667776 13:02:04 INFO - PROCESS | 1656 | 13:02:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:02:07 INFO - PROCESS | 1656 | RSS: Main: 206635008 13:02:07 INFO - PROCESS | 1656 | 13:02:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:02:10 INFO - PROCESS | 1656 | RSS: Main: 206704640 13:02:10 INFO - PROCESS | 1656 | 13:02:13 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:02:14 INFO - PROCESS | 1656 | RSS: Main: 207118336 13:02:14 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 13:02:16 INFO - PROCESS | 1656 | RSS: Main: 208834560 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | __start_tp_report 13:02:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 13:02:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 13:02:16 INFO - PROCESS | 1656 | |i|pagename|runs| 13:02:16 INFO - PROCESS | 1656 | |0;ai-astar;120;170;125;117;116;116;124;173;168;121 13:02:16 INFO - PROCESS | 1656 | |1;audio-beat-detection;144;110;114;186;109;113;109;104;131;113 13:02:16 INFO - PROCESS | 1656 | |2;audio-dft;189;199;196;192;192;194;196;194;193;181 13:02:16 INFO - PROCESS | 1656 | |3;audio-fft;82;53;70;107;84;52;74;56;82;73 13:02:16 INFO - PROCESS | 1656 | |4;audio-oscillator;82;69;87;70;70;68;85;67;70;85 13:02:16 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;88;135;87;89;85;89;101;102;87 13:02:16 INFO - PROCESS | 1656 | |6;imaging-darkroom;98;100;98;97;99;96;97;99;109;97 13:02:16 INFO - PROCESS | 1656 | |7;imaging-desaturate;88;89;85;88;99;119;96;138;71;131 13:02:16 INFO - PROCESS | 1656 | |8;json-parse-financial;53;54;53;54;58;59;57;58;58;58 13:02:16 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;88;102;67;94;100;102;90;67;69 13:02:16 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;81;92;88;81;76;92;102;106;109;85 13:02:16 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;136;134;138;148;155;156;163;153;199;175 13:02:16 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;163;164;169;163;180;235;228;178;162;202 13:02:16 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;66;67;66;68;68;67;65;68;65;65 13:02:16 INFO - PROCESS | 1656 | __end_tp_report 13:02:16 INFO - PROCESS | 1656 | __start_cc_report 13:02:16 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,890 13:02:16 INFO - PROCESS | 1656 | __end_cc_report 13:02:16 INFO - PROCESS | 1656 | __startTimestamp1486414936319__endTimestamp 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | ------- Summary: start ------- 13:02:16 INFO - PROCESS | 1656 | Number of tests: 14 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:135.00 Median:124.50 stddev:24.60 (19.8%) stddev-sans-first:25.49 13:02:16 INFO - PROCESS | 1656 | Values: 120.0 170.0 125.0 117.0 116.0 116.0 124.0 173.0 168.0 121.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:113.50 stddev:25.11 (22.1%) stddev-sans-first:25.50 13:02:16 INFO - PROCESS | 1656 | Values: 144.0 110.0 114.0 186.0 109.0 113.0 109.0 104.0 131.0 113.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:192.60 Median:194.00 stddev:4.90 (2.5%) stddev-sans-first:5.02 13:02:16 INFO - PROCESS | 1656 | Values: 189.0 199.0 196.0 192.0 192.0 194.0 196.0 194.0 193.0 181.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:73.30 Median:73.50 stddev:16.92 (23.0%) stddev-sans-first:17.66 13:02:16 INFO - PROCESS | 1656 | Values: 82.0 53.0 70.0 107.0 84.0 52.0 74.0 56.0 82.0 73.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.00 stddev:8.27 (10.9%) stddev-sans-first:8.41 13:02:16 INFO - PROCESS | 1656 | Values: 82.0 69.0 87.0 70.0 70.0 68.0 85.0 67.0 70.0 85.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:87.50 stddev:15.16 (17.3%) stddev-sans-first:15.92 13:02:16 INFO - PROCESS | 1656 | Values: 89.0 88.0 135.0 87.0 89.0 85.0 89.0 101.0 102.0 87.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:97.50 stddev:3.71 (3.8%) stddev-sans-first:3.92 13:02:16 INFO - PROCESS | 1656 | Values: 98.0 100.0 98.0 97.0 99.0 96.0 97.0 99.0 109.0 97.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:88.00 stddev:21.75 (24.7%) stddev-sans-first:22.60 13:02:16 INFO - PROCESS | 1656 | Values: 88.0 89.0 85.0 88.0 99.0 119.0 96.0 138.0 71.0 131.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:58.00 stddev:2.39 (4.1%) stddev-sans-first:2.24 13:02:16 INFO - PROCESS | 1656 | Values: 53.0 54.0 53.0 54.0 58.0 59.0 57.0 58.0 58.0 58.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:84.60 Median:68.00 stddev:15.44 (22.7%) stddev-sans-first:15.00 13:02:16 INFO - PROCESS | 1656 | Values: 67.0 88.0 102.0 67.0 94.0 100.0 102.0 90.0 67.0 69.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:83.00 stddev:11.26 (13.6%) stddev-sans-first:11.32 13:02:16 INFO - PROCESS | 1656 | Values: 81.0 92.0 88.0 81.0 76.0 92.0 102.0 106.0 109.0 85.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:155.50 stddev:19.83 (12.8%) stddev-sans-first:19.71 13:02:16 INFO - PROCESS | 1656 | Values: 136.0 134.0 138.0 148.0 155.0 156.0 163.0 153.0 199.0 175.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:179.00 stddev:27.69 (15.5%) stddev-sans-first:28.27 13:02:16 INFO - PROCESS | 1656 | Values: 163.0 164.0 169.0 163.0 180.0 235.0 228.0 178.0 162.0 202.0 13:02:16 INFO - PROCESS | 1656 | 13:02:16 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 13:02:16 INFO - PROCESS | 1656 | Values: 66.0 67.0 66.0 68.0 68.0 67.0 65.0 68.0 65.0 65.0 13:02:16 INFO - PROCESS | 1656 | -------- Summary: end -------- 13:02:16 INFO - PROCESS | 1656 | 13:02:17 INFO - TEST-INFO | 1656: exit 0 13:02:17 INFO - TEST-OK | kraken | took 60148ms 13:02:17 INFO - SUITE-END | took 1174s 13:02:17 INFO - Completed test suite (00:19:34) 13:02:17 INFO - javascript benchmark 13:02:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7279.5167381014535, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2911.3740545782653, 2953.246922034881, 3557.7687450315743, 3595.334863050334, 3598.85604575817, 5706.600537962339, 5773.047447171217, 5808.419158084194, 5844.415558444153, 5871.735771890265, 5840.6787626680625, 5894.086416605433, 5906.852328691774, 5935.020721580934, 5959.88080238395, 3682.3739964206015, 5001.274815151801, 5061.658660454982, 5152.9484705152845, 5158.097332966725, 5353.946460535403, 5362.705051222181, 5379.112446446351, 5380.139177731564, 5408.864778380553, 5237.6071794615555, 5354.43778403266, 5372.382176049765, 5373.946260537384, 5377.11277639189, 5260.263563101169, 5292.735363231843, 5310.123829568117, 5342.492463215988, 5364.0, 4348.782560871944, 4472.888177795581, 5205.973970130125, 5310.283111779938, 5327.840164795062, 4895.510448955111, 5908.527317814607, 5945.554083443759, 6005.939940600625, 6061.636301821861, 6117.327094019654, 6119.929102025404, 6126.5176737973225, 6144.354842741537, 6176.104464852616, 5229.137192363255, 6118.663473508956, 6216.0, 6223.533235007348, 6234.750609975596, 5959.702014899238, 5975.25309336333, 5976.760929562813, 5981.043033114681, 5986.4612184903135, 6201.565890387629, 6264.937350626436, 6269.811905642838, 6282.151909492251, 6360.0, 6203.751849926042, 6235.688215589203, 6244.500439964792, 6255.843603909848, 6260.248770147611, 6275.780347687809, 6296.307406185316, 6297.118403423525, 6311.958526843111, 6313.147725057059, 6123.770712314271, 6165.445109940127, 6191.845203869849, 6193.071039344134, 6205.100260462208, 6204.906926396107, 6229.470495007975, 6248.4688801452385, 6264.436200741955, 6267.1539342188225, 5010.997800439926, 5030.7233102179, 5043.899122017612, 5047.1419858623385, 5049.722265275445, 4451.933221001623, 4469.865904022885, 4495.64034877209, 4573.56551127649, 4576.061907308994, 5204.375474943031, 5614.859628509238, 5894.997850365362, 5910.852228694317, 5930.644161350333, 6227.314995350508, 6229.595076320024, 6260.342664020303, 6282.465990390777, 6300.779472718433, 5708.942910570924, 5798.6520808750765, 5818.709064546841, 5839.503642190376, 5916.201312822714, 5515.889682206333, 5528.7235638218735, 5529.529989950819, 5537.307836520435, 5558.610897237155, 6426.485881129498, 6441.355864413615, 6483.4164925156965, 6488.837779055561, 6501.349865013555, 6150.477209437069, 6171.382861713792, 6190.071489276645, 6283.874322513433, 6301.684915754286, 5926.140709597171, 6064.878702426015, 6355.459785918064, 6438.177614198771, 6506.577072490273, 6215.751369945332, 6258.061290806416, 6269.279032911274, 6281.842953926189, 6291.748330066929, 6159.353267906805, 6231.688415579293, 6267.091271765477, 6276.435120839146, 6281.466075383643, 6110.984061328701, 6119.41115851624, 6142.314611233224, 6217.440430361289, 6247.12540244357, 6174.536909731878, 6183.196184495987, 6204.410580994799, 6217.689115544295, 6222.657753823583, 5671.971640141938, 6013.218281623361, 6084.39156084388, 6112.235970503687, 6116.204893363834, 4783.856484305476, 5225.712585807665, 5398.514133727984, 6036.034234522455, 6178.5366097543765, 6041.486473649789, 6093.500797448272, 6105.755769769159, 6107.267127944675, 6128.32588415265], "value": 5720.802456609516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.554505400086, 500.1672215760758, 506.21789335476683, 545.6126150433191, 553.3000754046133, 28421.715782842166, 32793.67206327936, 41213.79393103034, 42923.570764292344, 42960.570394296046, 42114.78942605283, 42804.35793463101, 42840.78579607105, 42914.0, 43047.35428968568, 9477.289203309761, 9730.026997300283, 9769.023097690246, 9826.410415375065, 9832.705018849447, 9733.415995040321, 9778.853317200248, 9848.310618256724, 9857.0, 9936.50317484123, 9836.0, 9866.112049915506, 9884.90115098847, 9885.851712224287, 9887.159591434736, 9774.413535187876, 9855.014498550123, 9866.45734484603, 9879.209663226997, 9896.604135834557, 9686.370385924964, 9798.26513011527, 9808.019198080136, 9816.803663926681, 9828.852567211497, 40947.38578921289, 41332.586674133476, 41364.1727165458, 41455.1708965822, 41600.1679966402, 3273.4107860585086, 3574.7140228781896, 3616.8734094306574, 3691.9446208306895, 3947.388154836005, 29909.850450747825, 29946.401071978657, 30015.549766753516, 30276.394472110656, 32207.35585288281, 3300.5709257796334, 3320.933581328384, 3377.8986630401128, 3418.8632454701783, 3463.0, 492238.0, 497602.0, 498717.0, 499802.50098749634, 500652.0, 50554.74722626364, 56642.716786416626, 57680.711596441746, 57742.0, 58131.0, 59611.70194149001, 59813.20560383196, 59900.400995990356, 60026.69986650126, 60045.0, 13194.802077968838, 13468.461261549624, 15786.0, 16127.677446451005, 16421.261043253082, 12855.678608034686, 12870.356482175854, 12906.612801615967, 12940.935295323652, 12951.805722914163, 14289.356978935974, 15038.54884353471, 15161.696766064617, 15290.311935962685, 15422.46021389246, 3274.9836250818594, 3378.3074469733647, 6055.303640081359, 6231.532635052389, 6249.531285153541, 924.311388015919, 987.170776547689, 1004.3321191407778, 1018.3737001744022, 1123.8707548632012, 30306.242343941136, 30357.0, 30645.540316895265, 30746.610031040786, 31263.37473250522, 1108.3294606762954, 1119.9384033878214, 1152.8558930133734, 1183.8756930522343, 1206.203905422417, 12503.249805011728, 15953.282102305424, 15985.200739962955, 16017.759733604005, 16040.839591604168, 708326.0, 724356.0, 726128.0, 726829.0, 727403.0, 52010.0, 54879.62800930009, 58529.41470585325, 59013.819723606146, 59046.40953590409, 1187.4775098956432, 1360.3606305036617, 1412.1950488221821, 1415.6460884778805, 1422.9359678814478, 29924.102276931728, 30397.088087357413, 30446.84776576103, 30512.932047378235, 31114.844425777726, 49350.0, 49817.00365992732, 49891.0, 49958.75020624873, 50000.49999499958, 569274.0, 632701.0, 634745.0, 637634.0, 638321.0, 26676.466470670865, 26858.0, 26946.59580106339, 27055.86472067627, 27114.0, 46362.53637463582, 47039.0, 47117.52882471131, 47253.2912006327, 47854.0, 39149.41275880921, 39439.60560394359, 39509.2098158041, 40572.594274058065, 40662.983425414604, 31555.684443155274, 38793.80603096967, 39085.41371879367, 39528.604713953646, 40203.79388618346, 36995.63004369922, 37151.07122321964, 37419.43870841994, 38917.80541097277, 38951.0, 33548.99353019414, 34773.0, 34863.0, 35018.07394111594, 35247.0, 25665.61501577515, 25870.353241169123, 25892.22323330303, 26222.475550489264, 26489.0], "value": 19872.23670347783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.79410221429316, 384.1740258444344, 395.15042658284676, 395.99010024749396, 406.67872380819153, 19105.0, 21025.218065032084, 21324.147034118636, 21348.46628834276, 21552.784472155272, 20367.28714494993, 20834.68747968782, 20911.268105616306, 21203.257885973995, 21229.787702122972, 5817.709114544277, 5835.620684655505, 6025.096235564656, 6078.878422431549, 6079.4528492435675, 4286.76422796746, 4541.341505481703, 5974.074018527113, 6079.331273559905, 6372.490200783949, 6608.7686930957425, 6710.496712746539, 6721.529492935497, 6723.428508576777, 6738.59568425896, 6456.903146452807, 6668.133142691468, 6683.0977817994435, 6685.565438246498, 6696.196456425211, 5742.08126699726, 5757.193992841006, 5791.160281759121, 5803.738831752581, 5858.560607954378, 25852.612210816853, 25895.223143305542, 25895.96416143371, 26031.21906342813, 26163.691815409155, 1862.9254829806791, 2572.6784151981, 2671.2654020144423, 3017.170278173498, 3024.2741741981986, 8718.476891386537, 10010.099091081838, 10323.277370583986, 10624.628138015132, 10739.677809665722, 1857.7863545692283, 1886.8584856135844, 1931.9710204346945, 1948.7466629338237, 1953.42373999669, 119615.0, 128723.0, 130055.34972325078, 133225.33387333, 134380.65619343778, 11602.477888495037, 11658.475368608433, 11816.172867899164, 11842.0, 11893.583724569598, 14860.0, 15050.698986020217, 15078.944473886722, 15094.094354338775, 15148.0, 8592.011918629312, 8717.47695138281, 8767.736967890973, 8874.86687699685, 8875.556222188994, 6728.966355168192, 7090.503664743522, 8201.261886430131, 8534.957325213334, 8643.956780216058, 4535.866033491627, 4618.214903466419, 4631.814727410866, 4633.837815676503, 4659.324397962344, 1484.2504535209866, 1614.6205641674196, 1725.4306078993902, 1752.553098959757, 2025.929092481756, 733.6845156582721, 891.9331050171263, 942.3639043645512, 963.3641796414333, 982.4792859784326, 20071.899640501702, 20440.488987775425, 20545.48636284075, 21021.05405256767, 21079.26222582202, 902.7968707040864, 915.2091481209442, 970.6020531582159, 1000.034966257565, 1037.1547189041057, 10744.086752626114, 11050.115990720724, 11055.944720276348, 11079.889201108046, 11146.0, 594579.0271048617, 602379.0, 603706.0, 610142.0, 621180.0, 119542.402287988, 128299.60404751489, 130182.0, 130504.347478262, 130665.0, 952.3000594562991, 975.6146322202832, 984.9359791613665, 984.9606015759433, 986.9605215791288, 17527.737083944005, 18144.909275453538, 18762.718559221896, 18765.34321298748, 18810.87134771918, 53330.46669533255, 54312.72843635757, 54938.45061549333, 55040.0, 56306.87386252334, 77335.61332193304, 78538.60730696538, 78727.0, 78889.0, 79003.0, 6226.813195603958, 7339.74310899116, 7532.5857077859055, 7597.88603170964, 7620.085589729047, 10107.292489525662, 12351.0, 12443.626691199279, 12560.560380387009, 12659.240445573296, 10196.439195844003, 10758.354498730101, 10866.891331086588, 10877.564897404332, 10953.780924381308, 10036.949815250877, 10525.789484210427, 10543.841842372218, 10639.202059845697, 11032.503537340679, 10640.467976600985, 10832.5125369357, 10862.0, 11136.944315278372, 11243.325400475998, 7181.138263408425, 7304.4886857921565, 7362.889556656762, 7450.813729656802, 7468.253174682705, 9684.85472717924, 10412.583496660049, 10665.89334106649, 10999.890001099886, 11037.613683521038], "value": 9607.740300430925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.6017914536067, 1512.6520900192954, 1576.9592069234307, 1656.4450908945503, 1843.5298998755316, 7818.296353328199, 8060.717874874381, 8298.045724741656, 8848.336374771885, 8854.645814167425, 6844.5208835381545, 8554.52950087745, 8595.097514760953, 8712.17234362736, 8749.168828961254, 2395.1497218487402, 2430.3438071720625, 2432.8661923594195, 2436.792872605831, 2441.890114944823, 2436.50051739393, 2449.9265022049367, 2453.852768833867, 2479.466914613358, 2485.378655336166, 2410.5419970205694, 2421.055788242587, 2433.6592876997233, 2440.4386990992084, 2440.633904914268, 2391.8325717199805, 2394.760523947609, 2415.5651982643117, 2419.2742177346813, 2433.5497932882386, 1992.6413245615784, 2428.0651948999584, 2431.8297719159664, 2440.414300567851, 2443.3525115844313, 7488.663010164556, 7943.960280198562, 8674.739757807276, 8720.171583699539, 8803.823923521557, 5292.867678308035, 5445.0, 5455.1544510600925, 5458.781648734046, 5470.097433923398, 3505.071156143624, 3602.35157671619, 3625.0574850538787, 3635.1275693833554, 3675.1363429594026, 920.4293338130335, 1068.0, 1121.0639116337786, 1121.6578943422253, 1140.6920131564432, 11179.608713695063, 11422.371769552672, 11456.083513318914, 11473.713157171138, 11481.138914581355, 4584.908301834012, 4734.573888350065, 4832.540908613676, 4834.419869615598, 4883.731394773322, 9728.61085556584, 9731.805363892683, 9766.706998790047, 9771.4625695586, 9783.608655653836, 5383.43473935239, 5384.40771515133, 5388.54197393226, 5396.109641909119, 5405.378381486179, 4433.6009759121835, 4498.865034048984, 4915.827946021872, 4947.1837146871085, 4954.331165292711, 3100.488419410817, 4021.2560676274984, 4034.3948407739076, 4130.586941305905, 4147.52303485097, 1304.1588175626857, 1311.6261865368515, 1316.7695653260641, 1329.2356894785537, 1330.3281842669583, 914.5975770660888, 934.3086116273909, 938.5119737736339, 939.4645052320112, 960.8126415348939, 4921.9507804922205, 5634.971825140848, 5809.970950145223, 5853.64878107315, 6013.1581578579035, 444.95327990561174, 461.88452886778305, 469.7252107517141, 472.773068926917, 478.85873667268237, 3925.646691797752, 3960.386140148282, 3982.26328129297, 3990.580988996114, 4009.8997525061523, 10106.140978016803, 10461.320014199053, 10464.110550603284, 10489.475526223658, 10541.84187237192, 10269.691909242734, 10304.793904121876, 10388.636397726043, 10393.37639741618, 10428.27002109845, 7730.0, 8077.03075630928, 8115.350771938112, 8157.1842815717955, 8214.876776848352, 5502.147167189092, 5573.136163894603, 5664.915026274692, 5667.489925906688, 5689.061304884648, 7825.843483130419, 9512.23902087845, 9610.038996100335, 9621.989691082335, 9642.566084526354, 9746.366486178376, 9759.560819762986, 9812.165965892978, 9930.354526955725, 9959.601615935282, 5896.528277737685, 6784.2876497967, 6965.686544105426, 7345.77962661121, 7448.702051917862, 7900.170482099296, 7998.640061197144, 8133.2680058794995, 8142.1857814220475, 8145.144759800136, 7208.35124838767, 7408.592527411044, 7482.663280152297, 7489.812754681177, 7579.962100189464, 7168.67740951648, 7271.854562908818, 7280.017197678246, 7297.306755858185, 7304.890426643498, 6828.692708828015, 6947.305269473214, 6952.304769523007, 6961.965190174017, 6965.407940324926, 4873.805047798049, 4916.213405855046, 4919.385076865392, 5030.37120359955, 5083.745812709423, 5009.348784657971, 5046.747662616781, 5085.237214417867, 5103.362079740033, 5137.8201762938115], "value": 4467.013223066076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.5902861336755, 316.9429502689518, 326.16989761058113, 329.35939597482906, 329.6406916461057, 4302.827886884521, 4567.840125595605, 4939.888525081855, 5511.401693508883, 5615.887682246353, 4853.563179313861, 4881.609471242301, 5201.271821944931, 5330.680159190441, 5442.102053161224, 3731.291054699605, 3971.1462035662325, 4175.686823488235, 4176.665866730655, 4239.7704665646925, 4082.4284600156, 4202.915941681164, 4214.91570168598, 4218.6625069994325, 4223.134257477225, 4086.3257562502154, 4122.752634841919, 4124.690648201382, 4130.896727581804, 4145.233131870614, 3261.624913134996, 3650.3611867923273, 4142.233686767942, 4173.39485774564, 4204.306289462235, 3600.747947643666, 3619.3123306571665, 3647.471116688065, 3649.580298265707, 3658.9571971987857, 4779.474257831635, 5159.638825282232, 5232.136697444955, 5294.947050529484, 5312.6281160318795, 4025.4766880305665, 4070.4097905803787, 4606.124836281096, 4786.880327991828, 4823.324734537167, 5641.5204707599905, 5725.799597014085, 5731.369549349568, 5744.597878148531, 5768.682722450264, 3838.1172330363893, 3952.7035472339403, 3966.7901290106506, 3987.940180897289, 3989.7606143631474, 5471.781128754845, 5847.883042339129, 6041.788537401214, 6088.847778805521, 6132.41742034506, 3606.585242697071, 4037.1320166164414, 4079.8572049978106, 4097.569755175723, 4109.198706252252, 3244.545763593099, 3490.6683865032783, 4088.795560221977, 4137.40007698888, 4174.4364510791265, 4758.42898852133, 4764.761761911891, 4790.449098353664, 4792.329073929653, 4806.831760888352, 5709.887341683604, 5750.683712395775, 5791.88416231673, 5799.333076696234, 5868.647881127146, 1272.8663490333568, 1287.5107459165458, 1342.744878473087, 1351.4053816320788, 1355.9389827457787, 828.45736042892, 908.3051465628799, 917.4128557723062, 918.7092135549431, 934.3412893909777, 5226.844658496504, 5252.474752524793, 5260.9736951315, 5267.078261304257, 5271.868203294948, 4845.425236798054, 5379.78480860769, 5587.8824235152315, 5733.483986441157, 5740.65556066629, 4227.830886764556, 4478.7088839226, 4854.83008094715, 4999.400071991385, 5231.633785634969, 2724.6185534025253, 2944.661363943131, 2946.6022087018405, 2965.925851853721, 2979.3743313904324, 4825.793551612097, 5562.610617256834, 5743.310802703619, 5832.941670583325, 5907.168777678933, 5304.814331498379, 5598.916016259759, 5629.6903670298525, 5673.404292549306, 5857.70711464425, 5063.316452278968, 5839.620424672383, 5840.532757379399, 5845.444682755046, 5872.354041055481, 4861.805527778849, 4919.262110683283, 5629.54963602919, 5643.209950607001, 5733.283339582552, 4494.191045611821, 4767.928481072856, 4768.904621907612, 5176.628193528642, 5619.971900140473, 5041.470645582161, 5344.9732751336, 5633.0705433603, 5855.774805573855, 5910.8377018295005, 3240.303334783033, 3340.7828491148, 3381.864725411054, 3885.9805700971315, 3895.8831235062994, 5633.549316054788, 5691.914621280767, 5705.828825135252, 5740.540756739368, 5873.500752436091, 4942.6293028023765, 5400.0, 5904.793332233523, 5906.704664766658, 5923.259592550931, 5124.769385377742, 5794.652320860761, 5875.882482350415, 5881.353051164454, 5897.67562784051, 4803.279508073677, 5302.443243459536, 5606.915896261641, 5725.2843394575675, 5762.683052432157, 5302.31069960918, 5707.258056452634, 5847.070466745879, 5885.646861188342, 5890.322612899571, 4924.482929292516, 5168.767405466688, 5573.052581061311, 5758.280214973129, 5795.94204057954], "value": 4126.208090476069, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.462443601697, 777.5295945952702, 793.5595744361881, 814.7759366174301, 825.7027470110763, 14718.043327183726, 15314.157721325337, 15329.0, 15355.846441535581, 15442.845571544296, 13767.65580860479, 13800.723985520308, 13928.651783705413, 13956.79064814026, 13959.511417100404, 850.6299759604561, 871.4509858788954, 883.9337049721264, 890.9287257019455, 891.3270480787029, 877.692807517367, 882.8940527136753, 886.6098916476761, 886.8226354729047, 889.5463313710022, 901.5357091098057, 946.1342871272777, 948.7960088580953, 951.1344676344528, 951.7668171298042, 881.066069965835, 932.0353434195575, 940.6284517615537, 940.9764755881089, 941.4116177389132, 683.8427161752825, 697.2191145916606, 700.075899812248, 702.217028013766, 707.3174386716792, 14789.778153327708, 14799.40802367904, 14869.256537173098, 15004.624884377869, 15088.0, 13801.171929684251, 14146.858531414657, 14246.857531424657, 14347.497837575738, 14435.206063666494, 11582.247153934968, 11778.469968851423, 11933.04535637147, 11939.641810745692, 11961.40192990347, 3686.594474607791, 3722.1961055991183, 3738.476613274144, 3846.442265871433, 3880.185161116169, 89825.55087224522, 99787.0021299785, 100104.49947750288, 100157.0, 103567.48216258945, 10446.582136714598, 10576.36541807494, 10858.837117443245, 10976.23166378346, 11050.281731687575, 20676.0, 21048.26331078405, 21182.0, 21340.359789206348, 21417.46456338573, 7680.116786569504, 7838.960805195938, 7916.247956444128, 7943.126256111823, 8014.83970320602, 4349.217140914602, 4363.912721745547, 4432.933505997413, 4464.017916058462, 4478.932816007762, 3330.117518857505, 3449.7067749241596, 3450.3099380124077, 3452.1369657585606, 3455.326211388755, 547.4990383798859, 616.7163104971673, 636.2428709835374, 644.5005121031145, 654.1234745441132, 556.6381851796365, 581.8109114537792, 586.8738221282359, 605.2948315212816, 605.6124080588427, 8863.335249856287, 8949.507777072193, 9075.228605568469, 9084.8637270441, 9149.451032938045, 594.5927039977543, 596.9492593129632, 644.2333622988629, 646.3342756960338, 650.7624716978363, 3824.2351529694174, 4378.759168245713, 4433.556644335541, 4445.022095139064, 4519.231730605805, 83821.74267385995, 96747.51626241824, 104116.0, 121243.0, 124154.0, 104996.0, 105206.0, 105340.94659053312, 106398.0, 110843.0, 89412.0, 89590.55204723934, 90675.54662226647, 92117.53941230386, 92322.0, 8540.10328915455, 8650.956745216234, 8653.437526560754, 8654.30765538768, 8824.867626985471, 42322.36516452194, 54426.45573544214, 55010.0, 55882.720586396805, 58406.4159358401, 70086.29913701002, 78546.6072669633, 79858.80211796943, 81698.59150704209, 82020.58989705013, 10361.948190259, 10687.625933092615, 10846.783064338511, 10906.836397453886, 10935.726606834893, 11765.76468470643, 12099.33453660057, 12111.576094836639, 12599.18105323151, 12616.053795965156, 11794.351310677996, 11873.228240164362, 12088.0, 12218.816717749418, 12327.50689972391, 11509.482073306888, 11634.418279086181, 11644.301341919512, 11747.353895535827, 11843.407829608657, 11172.106231501622, 11535.307881527135, 11716.0, 12767.425465853874, 13708.108972916729, 8721.781955451164, 10915.454227288445, 11009.394483303175, 11276.887231127585, 11549.249298795552, 11410.301741525138, 11490.368029758109, 11517.796004458145, 11606.767864642828, 11622.0], "value": 7390.5325066811365, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 170.0, 125.0, 117.0, 116.0, 116.0, 124.0, 173.0, 168.0, 121.0], "value": 135.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 114.0, 186.0, 109.0, 113.0, 109.0, 104.0, 131.0, 113.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 199.0, 196.0, 192.0, 192.0, 194.0, 196.0, 194.0, 193.0, 181.0], "value": 192.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 53.0, 70.0, 107.0, 84.0, 52.0, 74.0, 56.0, 82.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 87.0, 70.0, 70.0, 68.0, 85.0, 67.0, 70.0, 85.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 135.0, 87.0, 89.0, 85.0, 89.0, 101.0, 102.0, 87.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 98.0, 97.0, 99.0, 96.0, 97.0, 99.0, 109.0, 97.0], "value": 99.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 85.0, 88.0, 99.0, 119.0, 96.0, 138.0, 71.0, 131.0], "value": 100.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 58.0, 59.0, 57.0, 58.0, 58.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 88.0, 102.0, 67.0, 94.0, 100.0, 102.0, 90.0, 67.0, 69.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 88.0, 81.0, 76.0, 92.0, 102.0, 106.0, 109.0, 85.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 138.0, 148.0, 155.0, 156.0, 163.0, 153.0, 199.0, 175.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 169.0, 163.0, 180.0, 235.0, 228.0, 178.0, 162.0, 202.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 68.0, 68.0, 67.0, 65.0, 68.0, 65.0, 65.0], "value": 66.5, "unit": "score"}]}]} 13:02:17 INFO - Return code: 0 13:02:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:02:17 ERROR - # TBPL SUCCESS # 13:02:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:02:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:02:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:02:17 INFO - 2017-02-06 13:02:17.638 screenresolution[1661:10420] starting screenresolution argv=screenresolution get 13:02:17 INFO - 2017-02-06 13:02:17.640 screenresolution[1661:10420] Display 0: 1600x1200x32@60 13:02:17 INFO - 2017-02-06 13:02:17.646 screenresolution[1662:10423] starting screenresolution argv=screenresolution list 13:02:17 INFO - Available Modes on Display 0 13:02:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:02:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:02:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:02:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:02:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:02:17 INFO - Intel Iris: 13:02:17 INFO - Chipset Model: Intel Iris 13:02:17 INFO - Type: GPU 13:02:17 INFO - Bus: Built-In 13:02:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:02:17 INFO - Vendor: Intel (0x8086) 13:02:17 INFO - Device ID: 0x0a2e 13:02:17 INFO - Revision ID: 0x0009 13:02:17 INFO - Displays: 13:02:17 INFO - Display: 13:02:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:02:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:02:17 INFO - Display Serial Number: 1600x1200 60 13:02:17 INFO - Main Display: Yes 13:02:17 INFO - Mirror: Off 13:02:17 INFO - Online: Yes 13:02:17 INFO - Rotation: Supported 13:02:17 INFO - Return code: 0 13:02:17 INFO - Running post-action listener: _resource_record_post_action 13:02:17 INFO - [mozharness: 2017-02-06 21:02:17.894323Z] Finished run-tests step (success) 13:02:17 INFO - Running post-run listener: _resource_record_post_run 13:02:17 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39307264; Write bytes: 503077376; Read time: 251; Write time: 1612 13:02:17 INFO - TinderboxPrint: CPU usage
54.3% 13:02:17 INFO - TinderboxPrint: I/O read bytes / time
39,307,264 / 251 13:02:17 INFO - TinderboxPrint: I/O write bytes / time
503,077,376 / 1,612 13:02:17 INFO - TinderboxPrint: CPU idle
2,189.1 (45.7%) 13:02:17 INFO - TinderboxPrint: CPU system
966.3 (20.2%) 13:02:17 INFO - TinderboxPrint: CPU user
1,630.2 (34.1%) 13:02:17 INFO - TinderboxPrint: Swap in / out
231,112,704 / 0 13:02:17 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187578880; Write bytes: 186155008; Read time: 16878; Write time: 403 13:02:17 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37283840; Write bytes: 307667456; Read time: 232; Write time: 1170 13:02:18 INFO - Running post-run listener: _upload_blobber_files 13:02:18 INFO - Blob upload gear active. 13:02:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:02:18 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 13:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:02:18 INFO - (blobuploader) - INFO - Open directory for files ... 13:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:02:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:19 INFO - (blobuploader) - INFO - Done attempting. 13:02:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:02:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:20 INFO - (blobuploader) - INFO - Done attempting. 13:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:02:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:02:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:02:23 INFO - (blobuploader) - INFO - Done attempting. 13:02:23 INFO - (blobuploader) - INFO - Iteration through files over. 13:02:23 INFO - Return code: 0 13:02:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:02:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:02:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15898cbfb85a5ce53c5c1f91918f495de5af9fc2aa91c680820259dbb43eb30c8d58601f6a9d5185c4c23748828b10149c787d9e3d6b3158296dfbd70bc7eaec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3d0e0a921d5311e6d50bf4ec81a71c764d837035a9ac00f1fa2eba1f7f17db7649b3645043d47c18380d905a4972daab6a5a5fbb60529dc7ef6cb01f1787e46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2d7c99a32e3342aa1293c27170338f6e612d78821253915d83bbfd572a8bbe67d18f26a7712197077acbbabacb892da0d663b239059c1b44eed3fe51ddd534"} 13:02:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:02:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:02:23 INFO - Contents: 13:02:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15898cbfb85a5ce53c5c1f91918f495de5af9fc2aa91c680820259dbb43eb30c8d58601f6a9d5185c4c23748828b10149c787d9e3d6b3158296dfbd70bc7eaec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3d0e0a921d5311e6d50bf4ec81a71c764d837035a9ac00f1fa2eba1f7f17db7649b3645043d47c18380d905a4972daab6a5a5fbb60529dc7ef6cb01f1787e46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2d7c99a32e3342aa1293c27170338f6e612d78821253915d83bbfd572a8bbe67d18f26a7712197077acbbabacb892da0d663b239059c1b44eed3fe51ddd534"} 13:02:23 INFO - Running post-run listener: copy_logs_to_upload_dir 13:02:23 INFO - Copying logs to upload dir... 13:02:23 INFO - mkdir: /builds/slave/test/build/upload/logs 13:02:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.042313 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-06 13:02:23.526595) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 13:02:23.529700) ========= 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.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15898cbfb85a5ce53c5c1f91918f495de5af9fc2aa91c680820259dbb43eb30c8d58601f6a9d5185c4c23748828b10149c787d9e3d6b3158296dfbd70bc7eaec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3d0e0a921d5311e6d50bf4ec81a71c764d837035a9ac00f1fa2eba1f7f17db7649b3645043d47c18380d905a4972daab6a5a5fbb60529dc7ef6cb01f1787e46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2d7c99a32e3342aa1293c27170338f6e612d78821253915d83bbfd572a8bbe67d18f26a7712197077acbbabacb892da0d663b239059c1b44eed3fe51ddd534"} build_url:https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/IJRXtFsWQmKiyHHVIob-zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/15898cbfb85a5ce53c5c1f91918f495de5af9fc2aa91c680820259dbb43eb30c8d58601f6a9d5185c4c23748828b10149c787d9e3d6b3158296dfbd70bc7eaec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3d0e0a921d5311e6d50bf4ec81a71c764d837035a9ac00f1fa2eba1f7f17db7649b3645043d47c18380d905a4972daab6a5a5fbb60529dc7ef6cb01f1787e46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc2d7c99a32e3342aa1293c27170338f6e612d78821253915d83bbfd572a8bbe67d18f26a7712197077acbbabacb892da0d663b239059c1b44eed3fe51ddd534"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 13:02:23.564200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:02:23.564557) ========= 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.COa3BN4Rbi/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.SerCndsYDR/Listeners TMPDIR=/var/folders/kh/k_6wkq590f76m8yt0lypmfdm00000w/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.004993 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 13:02:23.613309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 13:02:23.613643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 13:02:23.613980) ========= ========= Total master_lag: 0.18 =========