builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1485196132.31 results: success (0) buildid: 20170123075244 builduid: de2d288e14664dc5a8797fc1b1670b96 revision: 1d6ee363bbd36ba07b1471c0431226c12368a555 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.314170) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.314603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.314875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.341589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.341878) ========= 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.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-23 10:28:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.9M=0s 2017-01-23 10:28:52 (28.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.174903 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.540939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.541249) ========= 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.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.026745 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.590936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:52.591384) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1d6ee363bbd36ba07b1471c0431226c12368a555 --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 1d6ee363bbd36ba07b1471c0431226c12368a555 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-23 10:28:52,681 truncating revision to first 12 chars 2017-01-23 10:28:52,681 Setting DEBUG logging. 2017-01-23 10:28:52,681 attempt 1/10 2017-01-23 10:28:52,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1d6ee363bbd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 10:28:52,990 unpacking tar archive at: mozilla-beta-1d6ee363bbd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:53.202045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:53.202358) ========= script_repo_revision: 1d6ee363bbd36ba07b1471c0431226c12368a555 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:53.202806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:53.203068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 10:28:53.222696) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 10:28:53.222962) ========= /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.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:28:53 INFO - MultiFileLogger online at 20170123 10:28:53 in /builds/slave/test 10:28:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:28:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:53 INFO - {'append_to_log': False, 10:28:53 INFO - 'base_work_dir': '/builds/slave/test', 10:28:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:28:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:53 INFO - 'branch': 'Mozilla-Beta', 10:28:53 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:53 INFO - 'config_files': ('talos/mac_config.py',), 10:28:53 INFO - 'default_actions': ('clobber', 10:28:53 INFO - 'read-buildbot-config', 10:28:53 INFO - 'download-and-extract', 10:28:53 INFO - 'populate-webroot', 10:28:53 INFO - 'create-virtualenv', 10:28:53 INFO - 'install', 10:28:53 INFO - 'run-tests'), 10:28:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:53 INFO - 'download_minidump_stackwalk': True, 10:28:53 INFO - 'download_symbols': 'ondemand', 10:28:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:53 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:53 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:53 INFO - 'installer_path': 'installer.exe', 10:28:53 INFO - 'log_level': 'info', 10:28:53 INFO - 'log_name': 'talos', 10:28:53 INFO - 'log_to_console': True, 10:28:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:28:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:28:53 INFO - 'opt_config_files': (), 10:28:53 INFO - 'pip_index': False, 10:28:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:53 INFO - 'cmd': ('bash', 10:28:53 INFO - '-c', 10:28:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:53 INFO - 'enabled': True, 10:28:53 INFO - 'halt_on_failure': False, 10:28:53 INFO - 'name': 'check_screen_resolution'},), 10:28:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:28:53 INFO - 'cmd': ('bash', 10:28:53 INFO - '-c', 10:28:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:28:53 INFO - 'enabled': True, 10:28:53 INFO - 'halt_on_failure': False, 10:28:53 INFO - 'name': 'check_screen_resolution'},), 10:28:53 INFO - 'run_cmd_checks_enabled': True, 10:28:53 INFO - 'sps_profile': False, 10:28:53 INFO - 'sps_profile_interval': 0, 10:28:53 INFO - 'suite': 'dromaeojs-e10s', 10:28:53 INFO - 'system_bits': '32', 10:28:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:53 INFO - 'title': 't-yosemite-r7-0140', 10:28:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:53 INFO - 'use_talos_json': True, 10:28:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:53 INFO - 'work_dir': 'build'} 10:28:53 INFO - [mozharness: 2017-01-23 18:28:53.424342Z] Running clobber step. 10:28:53 INFO - Running pre-action listener: _resource_record_pre_action 10:28:53 INFO - Running main action method: clobber 10:28:53 INFO - rmtree: /builds/slave/test/build 10:28:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:55 INFO - Running post-action listener: _resource_record_post_action 10:28:55 INFO - [mozharness: 2017-01-23 18:28:55.923975Z] Finished clobber step (success) 10:28:55 INFO - [mozharness: 2017-01-23 18:28:55.924129Z] Running read-buildbot-config step. 10:28:55 INFO - Running pre-action listener: _resource_record_pre_action 10:28:55 INFO - Running main action method: read_buildbot_config 10:28:55 INFO - Using buildbot properties: 10:28:55 INFO - { 10:28:55 INFO - "project": "", 10:28:55 INFO - "product": "firefox", 10:28:55 INFO - "script_repo_revision": "production", 10:28:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:28:55 INFO - "repository": "", 10:28:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:28:55 INFO - "buildid": "20170123075244", 10:28:55 INFO - "pgo_build": "False", 10:28:55 INFO - "basedir": "/builds/slave/test", 10:28:55 INFO - "buildnumber": 46, 10:28:55 INFO - "slavename": "t-yosemite-r7-0140", 10:28:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:28:55 INFO - "platform": "yosemite_r7", 10:28:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:28:55 INFO - "branch": "mozilla-beta", 10:28:55 INFO - "repo_path": "releases/mozilla-beta", 10:28:55 INFO - "revision": "1d6ee363bbd36ba07b1471c0431226c12368a555", 10:28:55 INFO - "stage_platform": "macosx64", 10:28:55 INFO - "builduid": "de2d288e14664dc5a8797fc1b1670b96", 10:28:55 INFO - "slavebuilddir": "test" 10:28:55 INFO - } 10:28:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:28:55 INFO - Running post-action listener: _resource_record_post_action 10:28:55 INFO - [mozharness: 2017-01-23 18:28:55.927415Z] Finished read-buildbot-config step (success) 10:28:55 INFO - [mozharness: 2017-01-23 18:28:55.927531Z] Running download-and-extract step. 10:28:55 INFO - Running pre-action listener: _resource_record_pre_action 10:28:55 INFO - Running main action method: download_and_extract 10:28:55 INFO - mkdir: /builds/slave/test/build/tests 10:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:28:55 INFO - trying https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:28:55 INFO - Downloading https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 10:28:57 INFO - Downloaded 1165 bytes. 10:28:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:28:57 INFO - Using the following test package requirements: 10:28:57 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:28:57 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:28:57 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:28:57 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:28:57 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:28:57 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:28:57 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:28:57 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:28:57 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:28:57 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:28:57 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:28:57 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:28:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:28:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:28:57 INFO - Fetch https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:28:57 INFO - Http code: 200 10:28:57 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 10:28:57 INFO - x-amz-cf-id: 7A5co3EDDWwG4Yk4dRA82kih4qdDQI_ThfzQjvBAMgW71Oga5I9SlQ== 10:28:57 INFO - x-amz-version-id: .8BM0YAXt7es1t3Ogo7lJ1hRmZvkqRak 10:28:58 INFO - Expected file size: 16086052 10:28:58 INFO - Obtained file size: 16086052 10:29:04 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:29:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:29:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:29:04 INFO - Fetch https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:29:05 INFO - Http code: 200 10:29:05 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 10:29:05 INFO - x-amz-cf-id: v12gIlqeAaqaQc2nCBu14twOoQXXJ3lcuoFact08d96E6RuTU2kvng== 10:29:05 INFO - x-amz-version-id: .8BM0YAXt7es1t3Ogo7lJ1hRmZvkqRak 10:29:05 INFO - Expected file size: 16086052 10:29:05 INFO - Obtained file size: 16086052 10:29:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:29:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:29:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:29:13 INFO - Http code: 200 10:29:13 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 10:29:13 INFO - x-amz-cf-id: jNi3WHJ0fOmL7rAzqS4q2pQCotxT9LLXixzdEucVCD1s93yXHjjEjg== 10:29:13 INFO - x-amz-version-id: zpqv5hJ43DjTSZgBb4tWR2R1gli79_a_ 10:29:13 INFO - Expected file size: 14402992 10:29:13 INFO - Obtained file size: 14402992 10:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:13 INFO - trying https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:29:13 INFO - Downloading https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 10:29:16 INFO - Downloaded 82108746 bytes. 10:29:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:29:16 INFO - mkdir: /builds/slave/test/properties 10:29:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:16 INFO - Contents: 10:29:16 INFO - build_url:https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:29:17 INFO - Running post-action listener: _resource_record_post_action 10:29:17 INFO - Running post-action listener: set_extra_try_arguments 10:29:17 INFO - [mozharness: 2017-01-23 18:29:17.212414Z] Finished download-and-extract step (success) 10:29:17 INFO - [mozharness: 2017-01-23 18:29:17.212543Z] Running populate-webroot step. 10:29:17 INFO - Running pre-action listener: _resource_record_pre_action 10:29:17 INFO - Running main action method: populate_webroot 10:29:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:17 INFO - '--tppagecycles', 10:29:17 INFO - '7'], 10:29:17 INFO - 'tests': ['tsvgm']}}, 10:29:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['damp', 'tps']}, 10:29:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'tests': ['damp', 'tps']}, 10:29:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['dromaeo_dom']}, 10:29:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['basic_compositor_video']}, 10:29:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:29:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['a11yr', 10:29:17 INFO - 'ts_paint', 10:29:17 INFO - 'tpaint', 10:29:17 INFO - 'sessionrestore', 10:29:17 INFO - 'sessionrestore_no_auto_restore', 10:29:17 INFO - 'tabpaint']}, 10:29:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['tsvgx', 10:29:17 INFO - 'tsvgr_opacity', 10:29:17 INFO - 'tart', 10:29:17 INFO - 'tscrollx', 10:29:17 INFO - 'cart']}, 10:29:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:17 INFO - 'tsvgr_opacity', 10:29:17 INFO - 'tart', 10:29:17 INFO - 'tscrollx', 10:29:17 INFO - 'cart']}, 10:29:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'talos_options': ['--disable-e10s'], 10:29:17 INFO - 'tests': ['tp5o']}, 10:29:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'tests': ['tp5o']}, 10:29:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'talos_options': ['--disable-e10s', 10:29:17 INFO - '--xperf_path', 10:29:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:17 INFO - 'tests': ['tp5n']}, 10:29:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:17 INFO - 'talos_options': ['--xperf_path', 10:29:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:17 INFO - 'tests': ['tp5n']}}, 10:29:17 INFO - 'talos.zip': {'path': '', 10:29:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:17 INFO - Running post-action listener: _resource_record_post_action 10:29:17 INFO - [mozharness: 2017-01-23 18:29:17.231038Z] Finished populate-webroot step (success) 10:29:17 INFO - [mozharness: 2017-01-23 18:29:17.231167Z] Running create-virtualenv step. 10:29:17 INFO - Running pre-action listener: _resource_record_pre_action 10:29:17 INFO - Running main action method: create_virtualenv 10:29:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:29:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:17 INFO - Using real prefix '/tools/python27' 10:29:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:20 INFO - Installing pip.................done. 10:29:20 INFO - Return code: 0 10:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:29:21 INFO - Reading from file tmpfile_stdout 10:29:21 INFO - Output received: 10:29:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:29:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:21 INFO - 'HOME': '/Users/cltbld', 10:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:21 INFO - 'LOGNAME': 'cltbld', 10:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:21 INFO - 'MOZ_NO_REMOTE': '1', 10:29:21 INFO - 'NO_EM_RESTART': '1', 10:29:21 INFO - 'PAGER': '/bin/cat', 10:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:21 INFO - 'PWD': '/builds/slave/test', 10:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:21 INFO - 'SHELL': '/bin/bash', 10:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:21 INFO - 'USER': 'cltbld', 10:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:21 INFO - 'XPC_FLAGS': '0x0', 10:29:21 INFO - 'XPC_SERVICE_NAME': '0', 10:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:29:21 INFO - Cleaning up... 10:29:21 INFO - Return code: 0 10:29:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:21 INFO - 'HOME': '/Users/cltbld', 10:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:21 INFO - 'LOGNAME': 'cltbld', 10:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:21 INFO - 'MOZ_NO_REMOTE': '1', 10:29:21 INFO - 'NO_EM_RESTART': '1', 10:29:21 INFO - 'PAGER': '/bin/cat', 10:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:21 INFO - 'PWD': '/builds/slave/test', 10:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:21 INFO - 'SHELL': '/bin/bash', 10:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:21 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:21 INFO - 'USER': 'cltbld', 10:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:21 INFO - 'XPC_FLAGS': '0x0', 10:29:21 INFO - 'XPC_SERVICE_NAME': '0', 10:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:21 INFO - Downloading/unpacking psutil>=3.1.1 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:29:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:25 INFO - Installing collected packages: psutil 10:29:25 INFO - Running setup.py install for psutil 10:29:25 INFO - building 'psutil._psutil_osx' extension 10:29:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:29:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:29:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:29:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:29:26 INFO - building 'psutil._psutil_posix' extension 10:29:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:29:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:29:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:29:26 INFO - ^ 10:29:26 INFO - 1 warning generated. 10:29:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:26 INFO - Successfully installed psutil 10:29:26 INFO - Cleaning up... 10:29:26 INFO - Return code: 0 10:29:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:26 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:29:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:26 INFO - 'HOME': '/Users/cltbld', 10:29:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:26 INFO - 'LOGNAME': 'cltbld', 10:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:26 INFO - 'MOZ_NO_REMOTE': '1', 10:29:26 INFO - 'NO_EM_RESTART': '1', 10:29:26 INFO - 'PAGER': '/bin/cat', 10:29:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:26 INFO - 'PWD': '/builds/slave/test', 10:29:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:26 INFO - 'SHELL': '/bin/bash', 10:29:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:26 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:26 INFO - 'USER': 'cltbld', 10:29:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:26 INFO - 'XPC_FLAGS': '0x0', 10:29:26 INFO - 'XPC_SERVICE_NAME': '0', 10:29:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:29:29 INFO - Installing collected packages: mozsystemmonitor 10:29:29 INFO - Running setup.py install for mozsystemmonitor 10:29:29 INFO - Successfully installed mozsystemmonitor 10:29:29 INFO - Cleaning up... 10:29:29 INFO - Return code: 0 10:29:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:29 INFO - 'HOME': '/Users/cltbld', 10:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:29 INFO - 'LOGNAME': 'cltbld', 10:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:29 INFO - 'MOZ_NO_REMOTE': '1', 10:29:29 INFO - 'NO_EM_RESTART': '1', 10:29:29 INFO - 'PAGER': '/bin/cat', 10:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:29 INFO - 'PWD': '/builds/slave/test', 10:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:29 INFO - 'SHELL': '/bin/bash', 10:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:29 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:29 INFO - 'USER': 'cltbld', 10:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:29 INFO - 'XPC_FLAGS': '0x0', 10:29:29 INFO - 'XPC_SERVICE_NAME': '0', 10:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:33 INFO - warning: no files found matching '*.txt' 10:29:33 INFO - no previously-included directories found matching 'build' 10:29:33 INFO - no previously-included directories found matching 'dist' 10:29:33 INFO - no previously-included directories found matching '.git*' 10:29:33 INFO - Installing collected packages: jsonschema, functools32 10:29:33 INFO - Running setup.py install for functools32 10:29:33 INFO - warning: no files found matching '*.txt' 10:29:33 INFO - no previously-included directories found matching 'build' 10:29:33 INFO - no previously-included directories found matching 'dist' 10:29:33 INFO - no previously-included directories found matching '.git*' 10:29:33 INFO - Successfully installed jsonschema functools32 10:29:33 INFO - Cleaning up... 10:29:33 INFO - Return code: 0 10:29:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:33 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:33 INFO - 'HOME': '/Users/cltbld', 10:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:33 INFO - 'LOGNAME': 'cltbld', 10:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:33 INFO - 'MOZ_NO_REMOTE': '1', 10:29:33 INFO - 'NO_EM_RESTART': '1', 10:29:33 INFO - 'PAGER': '/bin/cat', 10:29:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:33 INFO - 'PWD': '/builds/slave/test', 10:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:33 INFO - 'SHELL': '/bin/bash', 10:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:33 INFO - 'USER': 'cltbld', 10:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:33 INFO - 'XPC_FLAGS': '0x0', 10:29:33 INFO - 'XPC_SERVICE_NAME': '0', 10:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:29:33 INFO - Cleaning up... 10:29:33 INFO - Return code: 0 10:29:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:33 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:33 INFO - 'HOME': '/Users/cltbld', 10:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:33 INFO - 'LOGNAME': 'cltbld', 10:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:33 INFO - 'MOZ_NO_REMOTE': '1', 10:29:33 INFO - 'NO_EM_RESTART': '1', 10:29:33 INFO - 'PAGER': '/bin/cat', 10:29:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:33 INFO - 'PWD': '/builds/slave/test', 10:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:33 INFO - 'SHELL': '/bin/bash', 10:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:33 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:33 INFO - 'USER': 'cltbld', 10:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:33 INFO - 'XPC_FLAGS': '0x0', 10:29:33 INFO - 'XPC_SERVICE_NAME': '0', 10:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:36 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:37 INFO - Downloading docopt-0.6.1.tar.gz 10:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:37 INFO - Running setup.py install for blobuploader 10:29:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:37 INFO - Running setup.py install for requests 10:29:38 INFO - Running setup.py install for docopt 10:29:38 INFO - Successfully installed blobuploader requests docopt 10:29:38 INFO - Cleaning up... 10:29:38 INFO - Return code: 0 10:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:38 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:29:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:38 INFO - 'HOME': '/Users/cltbld', 10:29:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:38 INFO - 'LOGNAME': 'cltbld', 10:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:38 INFO - 'MOZ_NO_REMOTE': '1', 10:29:38 INFO - 'NO_EM_RESTART': '1', 10:29:38 INFO - 'PAGER': '/bin/cat', 10:29:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:38 INFO - 'PWD': '/builds/slave/test', 10:29:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:38 INFO - 'SHELL': '/bin/bash', 10:29:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:38 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:38 INFO - 'USER': 'cltbld', 10:29:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:38 INFO - 'XPC_FLAGS': '0x0', 10:29:38 INFO - 'XPC_SERVICE_NAME': '0', 10:29:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:38 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-j0xl5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-T5fSIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-AoOkk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Tbyk1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-vbNZPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-bdkcKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-wFkUta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-TDxArT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-LgUoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yvXNIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:39 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MK4h55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Jns5Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ikX94G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-cGxHIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yhdAQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-7ToMxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:40 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Vwlm6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:40 INFO - Running setup.py install for manifestparser 10:29:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:40 INFO - Running setup.py install for mozcrash 10:29:40 INFO - Running setup.py install for mozdebug 10:29:41 INFO - Running setup.py install for mozdevice 10:29:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Running setup.py install for mozfile 10:29:41 INFO - Running setup.py install for mozhttpd 10:29:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Running setup.py install for mozinfo 10:29:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Running setup.py install for mozInstall 10:29:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:41 INFO - Running setup.py install for mozleak 10:29:41 INFO - Running setup.py install for mozlog 10:29:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Running setup.py install for moznetwork 10:29:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Running setup.py install for mozprocess 10:29:42 INFO - Running setup.py install for mozprofile 10:29:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Running setup.py install for mozrunner 10:29:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Running setup.py install for mozscreenshot 10:29:42 INFO - Running setup.py install for moztest 10:29:43 INFO - Running setup.py install for mozversion 10:29:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:43 INFO - Cleaning up... 10:29:43 INFO - Return code: 0 10:29:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:43 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:29:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:43 INFO - 'HOME': '/Users/cltbld', 10:29:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:43 INFO - 'LOGNAME': 'cltbld', 10:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:43 INFO - 'MOZ_NO_REMOTE': '1', 10:29:43 INFO - 'NO_EM_RESTART': '1', 10:29:43 INFO - 'PAGER': '/bin/cat', 10:29:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:43 INFO - 'PWD': '/builds/slave/test', 10:29:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:43 INFO - 'SHELL': '/bin/bash', 10:29:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:43 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:43 INFO - 'USER': 'cltbld', 10:29:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:43 INFO - 'XPC_FLAGS': '0x0', 10:29:43 INFO - 'XPC_SERVICE_NAME': '0', 10:29:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:43 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-9mOm_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:43 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-EEceJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:43 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Rh61NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:43 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-uVrPfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:43 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DKWWkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-ZUK6Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-4d8kfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8DGd0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6Mq1JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-HHmKpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-_adwlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-cQkg4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-vVQUSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:44 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-yC4d9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:45 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-MUbGh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:45 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-zbeyB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:45 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-nBParE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:29:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:47 INFO - Downloading blessings-1.6.tar.gz 10:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:47 INFO - Installing collected packages: blessings 10:29:47 INFO - Running setup.py install for blessings 10:29:48 INFO - Successfully installed blessings 10:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:48 INFO - Reading from file tmpfile_stdout 10:29:48 INFO - Current package versions: 10:29:48 INFO - blessings == 1.6 10:29:48 INFO - blobuploader == 1.2.4 10:29:48 INFO - docopt == 0.6.1 10:29:48 INFO - functools32 == 3.2.3-2 10:29:48 INFO - jsonschema == 2.5.1 10:29:48 INFO - manifestparser == 1.1 10:29:48 INFO - mozInstall == 1.12 10:29:48 INFO - mozcrash == 1.0 10:29:48 INFO - mozdebug == 0.1 10:29:48 INFO - mozdevice == 0.48 10:29:48 INFO - mozfile == 1.2 10:29:48 INFO - mozhttpd == 0.7 10:29:48 INFO - mozinfo == 0.9 10:29:48 INFO - mozleak == 0.1 10:29:48 INFO - mozlog == 3.4 10:29:48 INFO - moznetwork == 0.27 10:29:48 INFO - mozprocess == 0.23 10:29:48 INFO - mozprofile == 0.28 10:29:48 INFO - mozrunner == 6.13 10:29:48 INFO - mozscreenshot == 0.1 10:29:48 INFO - mozsystemmonitor == 0.3 10:29:48 INFO - moztest == 0.8 10:29:48 INFO - mozversion == 1.4 10:29:48 INFO - psutil == 3.1.1 10:29:48 INFO - requests == 1.2.3 10:29:48 INFO - wsgiref == 0.1.2 10:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:49 INFO - 'HOME': '/Users/cltbld', 10:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:49 INFO - 'LOGNAME': 'cltbld', 10:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:49 INFO - 'MOZ_NO_REMOTE': '1', 10:29:49 INFO - 'NO_EM_RESTART': '1', 10:29:49 INFO - 'PAGER': '/bin/cat', 10:29:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:49 INFO - 'PWD': '/builds/slave/test', 10:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:49 INFO - 'SHELL': '/bin/bash', 10:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:49 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:49 INFO - 'USER': 'cltbld', 10:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:49 INFO - 'XPC_FLAGS': '0x0', 10:29:49 INFO - 'XPC_SERVICE_NAME': '0', 10:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:29:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:29:49 INFO - Cleaning up... 10:29:49 INFO - Return code: 0 10:29:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:50 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 0x103294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10320a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99b845b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, '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.zPDhBByVgb/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.vd16jZ5MsW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:29:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:29:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:50 INFO - 'HOME': '/Users/cltbld', 10:29:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:50 INFO - 'LOGNAME': 'cltbld', 10:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:50 INFO - 'MOZ_NO_REMOTE': '1', 10:29:50 INFO - 'NO_EM_RESTART': '1', 10:29:50 INFO - 'PAGER': '/bin/cat', 10:29:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:50 INFO - 'PWD': '/builds/slave/test', 10:29:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:50 INFO - 'SHELL': '/bin/bash', 10:29:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:29:50 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:29:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:50 INFO - 'USER': 'cltbld', 10:29:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:50 INFO - 'XPC_FLAGS': '0x0', 10:29:50 INFO - 'XPC_SERVICE_NAME': '0', 10:29:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:29:50 INFO - Cleaning up... 10:29:50 INFO - Return code: 0 10:29:50 INFO - Running post-action listener: _resource_record_post_action 10:29:50 INFO - Running post-action listener: _start_resource_monitoring 10:29:50 INFO - Starting resource monitoring. 10:29:50 INFO - [mozharness: 2017-01-23 18:29:50.684055Z] Finished create-virtualenv step (success) 10:29:50 INFO - [mozharness: 2017-01-23 18:29:50.685043Z] Running install step. 10:29:50 INFO - Running pre-action listener: _resource_record_pre_action 10:29:50 INFO - Running main action method: install 10:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:50 INFO - Reading from file tmpfile_stdout 10:29:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:51 INFO - Reading from file tmpfile_stdout 10:29:51 INFO - Output received: 10:29:51 INFO - Usage: mozinstall [options] installer 10:29:51 INFO - Options: 10:29:51 INFO - -h, --help show this help message and exit 10:29:51 INFO - -d DEST, --destination=DEST 10:29:51 INFO - Directory to install application into. [default: 10:29:51 INFO - "/builds/slave/test"] 10:29:51 INFO - --app=APP Application being installed. [default: firefox] 10:29:51 INFO - mkdir: /builds/slave/test/build/application 10:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:30:12 INFO - Reading from file tmpfile_stdout 10:30:12 INFO - Output received: 10:30:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:30:12 INFO - Running post-action listener: _resource_record_post_action 10:30:12 INFO - [mozharness: 2017-01-23 18:30:12.195404Z] Finished install step (success) 10:30:12 INFO - [mozharness: 2017-01-23 18:30:12.195512Z] Running run-tests step. 10:30:12 INFO - Running pre-action listener: _resource_record_pre_action 10:30:12 INFO - Running main action method: run_tests 10:30:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:30:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:30:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:30:12 INFO - 2017-01-23 10:30:12.208 screenresolution[1623:7286] starting screenresolution argv=screenresolution get 10:30:12 INFO - 2017-01-23 10:30:12.210 screenresolution[1623:7286] Display 0: 1600x1200x32@60 10:30:12 INFO - 2017-01-23 10:30:12.215 screenresolution[1624:7288] starting screenresolution argv=screenresolution list 10:30:12 INFO - Available Modes on Display 0 10:30:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:30:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:30:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:30:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:30:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:30:12 INFO - Intel Iris: 10:30:12 INFO - Chipset Model: Intel Iris 10:30:12 INFO - Type: GPU 10:30:12 INFO - Bus: Built-In 10:30:12 INFO - VRAM (Dynamic, Max): 1536 MB 10:30:12 INFO - Vendor: Intel (0x8086) 10:30:12 INFO - Device ID: 0x0a2e 10:30:12 INFO - Revision ID: 0x0009 10:30:12 INFO - Displays: 10:30:12 INFO - Display: 10:30:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:30:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:30:12 INFO - Display Serial Number: 1600x1200 60 10:30:12 INFO - Main Display: Yes 10:30:12 INFO - Mirror: Off 10:30:12 INFO - Online: Yes 10:30:12 INFO - Rotation: Supported 10:30:12 INFO - Return code: 0 10:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:12 INFO - Python 2.7.3 10:30:12 INFO - Return code: 0 10:30:12 INFO - grabbing minidump binary from tooltool 10:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:12 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 0x1030a8d30>, '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 0x102f0edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1030a0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:30:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:30:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:30:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:12 INFO - Return code: 0 10:30:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:30:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:30:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:12 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/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:30:12 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/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:30:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zPDhBByVgb/Render', 10:30:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:30:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:30:12 INFO - 'HOME': '/Users/cltbld', 10:30:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:30:12 INFO - 'LOGNAME': 'cltbld', 10:30:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:12 INFO - 'MOZ_NO_REMOTE': '1', 10:30:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:12 INFO - 'NO_EM_RESTART': '1', 10:30:12 INFO - 'PAGER': '/bin/cat', 10:30:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:12 INFO - 'PWD': '/builds/slave/test', 10:30:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:30:12 INFO - 'SHELL': '/bin/bash', 10:30:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vd16jZ5MsW/Listeners', 10:30:12 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 10:30:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:30:12 INFO - 'USER': 'cltbld', 10:30:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:30:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:12 INFO - 'XPC_FLAGS': '0x0', 10:30:12 INFO - 'XPC_SERVICE_NAME': '0', 10:30:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:30:12 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/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:30:12 INFO - mozversion application_buildid: 20170123075244 10:30:12 INFO - mozversion application_changeset: 1d6ee363bbd36ba07b1471c0431226c12368a555 10:30:12 INFO - mozversion application_display_name: Firefox 10:30:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:12 INFO - mozversion application_name: Firefox 10:30:12 INFO - mozversion application_remotingname: firefox 10:30:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:30:12 INFO - mozversion application_vendor: Mozilla 10:30:12 INFO - mozversion application_version: 52.0 10:30:12 INFO - mozversion platform_buildid: 20170123075244 10:30:12 INFO - mozversion platform_changeset: 1d6ee363bbd36ba07b1471c0431226c12368a555 10:30:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:30:12 INFO - mozversion platform_version: 52.0 10:30:12 INFO - using testdate: 1485196212 10:30:12 INFO - actual date: 1485196212 10:30:12 INFO - starting webserver on 'localhost:49243' 10:30:12 INFO - SUITE-START | Running 2 tests 10:30:12 INFO - TEST-START | dromaeo_css 10:30:12 INFO - operating with platform_type : mac_ 10:30:12 INFO - Initialising browser for dromaeo_css test... 10:30:12 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp0RK9fm/profile http://localhost:49243/getInfo.html) 10:30:15 INFO - PROCESS | 1634 | 2017-01-23 10:30:15.689 plugin-container[1637:7470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 10:30:15 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:30:15 INFO - PROCESS | 1634 | 2017-01-23 10:30:15.690 plugin-container[1637:7470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e13, name = 'com.apple.CFPasteboardClient' 10:30:15 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:30:15 INFO - PROCESS | 1634 | 2017-01-23 10:30:15.690 plugin-container[1637:7470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:30:15 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 10:30:15 INFO - PROCESS | 1634 | colorDepth:24 10:30:15 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 10:30:15 INFO - PROCESS | 1634 | __metrics 10:30:15 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 10:30:16 INFO - TEST-INFO | 1634: exit 0 10:30:16 INFO - Browser initialized. 10:30:16 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:16 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp0RK9fm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:18 INFO - PROCESS | 1638 | 2017-01-23 10:30:18.856 plugin-container[1639:7600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 10:30:18 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:30:18 INFO - PROCESS | 1638 | 2017-01-23 10:30:18.857 plugin-container[1639:7600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 10:30:18 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:30:18 INFO - PROCESS | 1638 | 2017-01-23 10:30:18.857 plugin-container[1639:7600] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:30:28 INFO - PROCESS | 1638 | RSS: Main: 178028544 10:30:28 INFO - PROCESS | 1638 | 10:33:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:33:33 INFO - PROCESS | 1638 | RSS: Main: 182800384 10:33:33 INFO - PROCESS | 1638 | 10:36:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:36:35 INFO - PROCESS | 1638 | RSS: Main: 197656576 10:36:35 INFO - PROCESS | 1638 | 10:39:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:39:38 INFO - PROCESS | 1638 | RSS: Main: 199700480 10:39:38 INFO - PROCESS | 1638 | 10:42:40 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:42:40 INFO - PROCESS | 1638 | RSS: Main: 204132352 10:42:40 INFO - PROCESS | 1638 | 10:45:43 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:45:44 INFO - PROCESS | 1638 | RSS: Main: 205451264 10:45:44 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:48:46 INFO - PROCESS | 1638 | RSS: Main: 205860864 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | __start_tp_report 10:48:46 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 10:48:46 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 10:48:46 INFO - PROCESS | 1638 | |i|pagename|runs| 10:48:46 INFO - PROCESS | 1638 | |0;dojo.html;3616.3129005488954;3638.69071128954;3644.6173151819075;3648.4709717091023;3676.8896933092014;6041.275046994361;6092.4212199841;6097.054956481752;6103.420175083365;6108.541859360555;5444.945550544493;5690.260266165403;5777.248957635512;6035;6151.784687535937;4443.022535042293;4924;4978.87552811179;5346.6791992480385;5425.565954723633;4558.339040839076;5493.450654934494;5501.6181229773465;5523.696196709179;5532.917006244909;5322.467753224666;5366.382865970405;5472.50747432731;5489.862753431156;5537.556995440375;4793.880152996168;4812.350332705092;5275.815346462894;5386.434424385422;5474.616776825624;5353.544948679367;5450.100733378988;5470.91793623096;5478.260434841285;5503.477169668875;5827.766889324422;6047.183630209909;6070.21087258658;6141.631502109888;6152.354002829683;6247.62514249142;6263.530235232376;6272.6236425814595;6275.341089185661;6302.086197501337;6425.22897252328;6429.549931504796;6432.967835160841;6503.317151699051;6510.674466276667;6244.843878903063;6247.187865577536;6252.280987686474;6265.906011409833;6270.65511396873;5442.8911421771345;5504.53211477029;6477.125588045647;6543.149390579194;6548.1814773153355;6318.8420289492215;6321.52588555851;6330.620162790247;6330.715117819709;6333.65164915934;6268.843278917972;6273.404026617464;6453;6472.093906853044;6511.3163117871945;6268.373162683695;6304.306526282106;6312.684365781693;6383.6808159592765;6384.106225128486;6340.651264180422;6374.649394283359;6382.521310901701;6388.776392826228;6411.647359395185;5047.873803154877;5209.270702101709;5220.112580861262;5233.188855727369;5253.212018197301;4605.8848528786375;4624.745638989888;4628.9537104628525;4658.34783130362;4753.287006948916;5430.864228394322;5748.655080695172;5953.464188222994;6223.626582405071;6279.748810047547;4913.557779799764;6025.758969641253;6436.195475565554;6496.675166241669;6504.804855854332;6111.449969502766;6155.753769849245;6177.536684748662;6196.969015154896;6197.845053873599;5710.714464276853;5713.857153571111;5728.283964504437;5729.88540229193;5779.797707080232;5539.556835453154;6682.264950855402;6710.966445167743;6715.496337774589;6723.294054124247;6206.224221972254;6332.905006425;6339.619622822645;6440;6483;5434.456554344534;6541.574797638329;6668.233153187445;6699.39705426514;6705.698243579148;6371.840703982438;6373;6382.20222472191;6383.776567820104;6388.8083357499345;6258.186435763321;6286.779962701284;6392.264889537762;6396.488280937607;6453.645049522322;6218.720157592828;6221.4089661482085;6257.342978987323;6308.905366419599;6332.176817013758;6258;6290.0879372491645;6308.179936608211;6322.304546499973;6388.712507937061;6138.020573254662;6208.906866397098;6254.437100660963;6289.7484100635465;6311.8106456804535;6178.752849885954;6238;6273.027680709497;6275;6313.873722525432;6300.7479700811455;6302.1492098566105;6305.873882522415;6316.368363163647;6332.746690132343 10:48:46 INFO - PROCESS | 1638 | |1;ext.html;456.55713957461273;499.92001279795227;503.87403149212696;508.2274942088026;524.8034481382449;36190.63809361909;42364.364534532004;42472.57527424725;42517.57482425179;42529.51146709866;43454.78272608633;44035.3394699079;44055;44097.55902440983;44119.33820992688;9614.13472787449;9799.755006124833;9815.214782817393;9815.607375704963;9834.508274586278;9806;9899.802003959916;9904.653337133203;9905.75235619108;9921.057499537568;9860.30977831552;9874.950625246864;9893.802123957517;9902.752431189241;9926.45404502752;9840.015998400175;9850.60597576096;9900.455474948874;9906.504674766305;9939.50302484873;9746.951265243699;9789.070038346346;9847.60609575616;9862.408255504693;9885.258605604537;41572.37641435381;41595.58404415947;41800.16399671989;41802.79098604518;41955.79022104901;3371.724418916644;3510.9993651809114;3595.856165753367;3611.404118320474;3706.666400023984;31220.37559248825;31377;31405.685943140506;31854.681453185403;31933;3284.096873359821;3297.0438572813855;3375.4261775498226;3384.2554637979606;3390.847411866472;463731;463992;466029.9999999966;468643;473420;63470;63588;63822.042669359995;63886;64195;64806.70386592336;65448.672756636865;65875.67062164658;65947;65980;14024.789628155586;16829.242684079247;17028.233729482203;17097.743533847002;17123.571910702332;13110.672233194246;13168.012399070109;13198.60404187876;13259.66850828737;13262.867371326356;17729.46811595654;17832.821671783116;18103.275868965095;18149.092545372678;18327.35854245095;6432.35676432353;6496.512761542903;6644.800655980328;7217.314355136254;7384.298491643285;665.7436886798521;907.6278725722422;953.3564843730593;1019.3476175247847;1036.0623635609786;30215.546766798514;30438.847805761274;30724;30900.53649195264;31102.53346199809;868.9869651955225;1015.8374660054355;1082.6048492300254;1101.9366311509432;1104.5305745058317;12893.484260629657;15881.920590397205;15885.841141588668;15987.520374388787;16050;678993;685818;687353;689399;690802;48048.759756201696;60986.69506652527;60992;61031.38968610257;61137.69431152816;1420.9147451152965;1431.9427222910967;1443.9711205775825;1451.9128852268898;1452.8765054970233;29527;30296;30567.694323057374;30747.692523074482;30872.84563577168;51896;52804.20793688021;52875;52886;52903.470965291395;588265;604250;605215;605552;609531;22544.436389090402;27341;27778.861105695152;28307.858460707565;28581.857090714413;48507.78730531765;49011;49027.01945961132;49279;49625;39928.800355998035;40034.39948400835;40886;41633.79183104186;42031.57968420399;40109.398359025225;40457.797711011255;41481.170376592905;41641.37537936873;43042.13915721731;38387.6161238384;39020.804895975336;39199.41200881932;39327.2134557313;39811.805645830675;34398;35807.46288805722;35914.92255232347;35925.461118083775;36369.636303636624;26534.601980969914;26648.333791655365;26672;26681.599776003764;27233.72766272312 10:48:46 INFO - PROCESS | 1638 | |2;jquery.html;328.32365327425504;387.06330679754996;389.30120433821287;396.48457005892334;398.8903051660795;17907.64184716305;20261.493462663442;20825.27111551096;21131.943402829853;21305.147794088258;12002.579909703161;12079.4564244609;17727.55681107973;19995;20703.171873125095;5343.839684809443;5453.100238460649;5570.136628822539;5571.554275657938;5583.637063590853;5591.329040515144;5971.731272092767;6025.427584379477;6080.969595152018;6083.270007599094;5774.682392468412;5944.078667806497;5946.316173640043;6044.153818465396;6051.878962420749;5977.671228082454;6070.484008859252;6101.298350689639;6106.328303886569;6110.755569777226;5154.613403994678;5324.5740340772645;5395.244665746799;5414.7834086636485;5441.211024401479;24923.750762492324;24939.50120997588;25875;25923.48153036929;25950.610740838903;2077.480629842539;2184.748753893291;2334.509752951882;2427.5023620157826;2434.793042591364;10163.796724065478;10446.164306855433;10465.162786977024;10704;10845.969632884864;1871.56018335691;1888.8394486468667;1917.0702209428416;1961.7057441383763;2037.74528183977;114314;116179.4191029048;116728;122940;127530;11784.88215117855;11858.169928105122;11942.462589183508;11957.52169913211;11959.820602690967;15167.317470713844;15342.769858452131;15347.539573812803;15372.154531500652;15386.153761542999;8696.17386348296;8862.291016718647;8902.332325075646;8908.55457227149;8947.552622368856;7187.065681461377;8736.519491427905;8748.47509149453;8827.646894124164;8834.911650883538;3905.9804700976315;4627.583517483443;4679.22792739201;4719.433667959866;4737.336772851803;2004.2383894120142;2057.4753437873246;2058.3927741316347;2067.7208576842236;2078.91684332625;769.2154002917105;871.4335681806749;872.5515644030878;876.5529579914289;915.4873270968279;16627.833721662628;20978.580428391346;21289.467763305733;21997.780022199895;22129.446763831034;952.7903861150675;955.4171955107379;976.7802244494932;977.7164622259608;1006.4313662780505;11075.224734268524;11491.71270718222;11628;11631.418429078512;11669.35818529972;595952;600159;605060;612287;614115;82296;105404;138854;138857;141438.87841682383;794.4716763352421;964.744342749172;992.5136683025265;993.9353941993892;998.650472334677;19100.426987190407;19825.702614460508;19875.80745155295;19892.801071989095;19921.9042952639;55280.72359638176;55557.166642499586;57255;57342.85314293774;58145.70927145337;80047.99880002813;81677.77483337636;83814.58092709497;84962;86993.56503217696;6345;7217.84514477681;7691.653875575725;7736.381089512713;8018.518888866687;11354.772904542027;11564.826527601925;12272.202306850026;13117.93441032827;13306.534271300457;11102.111831053335;11337.773244535229;11480.598179063692;11490.080793536665;11698.06415486776;11105.278156919774;11160.720981975515;11206.103511719206;11285.661430157108;11624;11232.269902456314;11333.773324533628;11535.8269625954;11560.595379161688;11666.650000499998;7648.426368022532;7656.617169141632;7697.230276972258;7750;7822.960885195537;9255.305852061258;9709.6116155353;11062.115030797679;11248.756939898434;11338.376389298668 10:48:46 INFO - PROCESS | 1638 | |3;mootools.html;1401.747685416625;1504.0299007140395;1723.0437107405394;1737.756714060031;1908.8759230650007;7103.9644801775985;7709.036370453693;7907.44647874649;8558.44370115942;8584.957075214623;7991;8358.414910956235;8370.665173393072;8379.162083791618;8448;2356.4344557306295;2383.904643814254;2394.736578976311;2401.86789726565;2414.4326083370393;2013.9697904531445;2428.8421252618523;2455.9263222103277;2456.336789066951;2456.6437866509345;2391.175044609607;2395.796357309622;2401.687780588521;2411.3368823573483;2418.9879050604723;2260.7174103237094;2373.750756170603;2400.9039638414442;2403.567357875582;2404.89177986991;2394.7964423024064;2402.7356990731005;2413.3725231439953;2420.225527831095;2422.903083876643;8282.875756863652;8379;8442.704505342344;8462.492250464991;8487.10885357041;5157.767900444489;5312.92030619541;5317.335333083364;5327.360716713981;5327.973360133214;3423.3837909176336;3437.6390478999847;3469.4795780632853;3490.947635785465;3520.6655367740022;1032.6695457453618;1040.9323393979366;1079.071998081649;1086.4241951765578;1090.8800031996475;10606.257561970666;10767;10788.514516846839;10831.783364332668;10856.45717714119;4499.257622492318;4703.929441058387;4743.667943244009;4772.809087636525;4778.426588809296;9439.716808495756;9515.952420237854;9538.85691714611;9540.522973851419;9550.713478595653;5250.107481728115;5271.3674359076385;5289.47105289468;5301.204819277063;5310.176922577007;4370.060437006059;4386.780660967002;4532.252178390595;4764.356811830427;4832.734199618984;3920.745151565139;3950.4074388841327;4017.397390391406;4041.9191616167514;4057.634812866797;1294.372229468707;1318.2947123288993;1318.6241921052454;1323.8146659467682;1324.311358093805;933.7198840347869;934.8691183234353;949.5821838391086;952.8808898887639;985.1822986920838;5692.6015178937905;5708.1723150143;5809.419058094157;5920.171176035358;5969.134475501028;433.2526391973883;446.3149066183458;458.5689451915256;459.16661259814;465.4530926161746;3925.430812532224;3942.2706799242233;3954.5649978502342;3985.143194213258;4060.7766572838777;9659.758506037406;9898.208143348515;9972.750681233027;10030.247731420173;10056.094951454405;9845.55694993727;9973;9989.900100999042;9994.250431217688;10014.198864090855;7693.923060769321;7858.292753652198;7863.252990965849;7907.209279072162;7908.3673306136525;5528.612997090165;5651.8304450866535;5668.858278543069;5729.512991395612;5742.741576629145;9331.300152488455;9342.346035777431;9395.671151509665;9485.193758530602;9494;9073.63895415693;9360.251179905727;9424.811503770023;9445.52772361393;9495.097965693249;6708.563943343667;6895.4138898194215;7093.255208203271;7239.348458638748;7380.114386273682;7718.3053525183;7929.960350198443;7956.204379562229;7966.760997170094;7992.480488768211;7004.264552221944;7141.357277845019;7252.854942901007;7261.346478816932;7342.265773422615;6966.721331146698;7115.1106111736035;7123.358897699232;7146.67839947214;7271.091113610799;6658.5671931324305;6779.220389655253;6796.592204467748;6800.217974932946;6814.693338799667;4080.81656319664;4270.48754149504;4864.343313652753;4897.608191344612;5020.949790502194;4871.147549178951;4917.0903382874285;4947.529984651453;5078.21287700407;5135.050015747099 10:48:46 INFO - PROCESS | 1638 | |4;prototype.html;279.6685927176296;312.77011396623476;322.39068161175385;324.6347858659009;327.8852401659419;4358.5423530529315;4651.325557794118;4776.546228108324;5229.797146656267;5471;4429.6899217054815;4472.955270447303;5304.230886521452;5346.27825243592;5381.300430943972;3658.432942893842;4171.895702607444;4172.561881002496;4188.685848561355;4189.748615083089;4037.899052523681;4171.436856024428;4174.895627609319;4194.30793919003;4231.915361692764;3897.791684577776;4093.9181216375655;4099.405586190001;4112.807285887089;4140.81366338514;3455.274392377604;3630.255797561507;3891.2606604745006;4121.216968775923;4127.711060225785;3174.190581401751;3373.8023001834486;3386.779859309137;3614.4397618369194;3629.4737263096704;3787.886363409102;5143.408508021588;5204.531592156686;5242.266082748418;5272.710000949946;4672.579467847876;4685.461171965199;4707.858764237044;4708.646851486153;4722.83470078549;4767.666263361566;5362.624616276862;5540.252065971123;5610.943890561083;5667.886642267173;3274.5088236764436;3288.8355582221034;3916.15802602439;3924.7645141291614;3952.3676211805973;5566.4135721319635;5869.976961864643;5958.255218097738;5964.463198312129;5971.253593300794;3774.7168962327937;3899.888531768489;3945.349017412152;3957;3957.920841583152;3461.44616861301;3817.4464702617965;4013.6451949634975;4029.9522124247906;4099.549049604541;4665.4168228971375;4667.159911216014;4685;4707.458642256116;4742.027884283713;4823.758812059383;5028.19548872186;5347.989008243817;5840.2991641003355;5871.911921321183;1148.6439203846835;1249.575144450891;1301.889339406161;1305.477808876457;1308.3131356037966;802.3741481644327;861.3453775130946;872.9825403491894;883.7481317824389;889.9110088991049;5058.949410505921;5119.87200319995;5254.369475662945;5259.184826351921;5290.947090529123;4288.52826189119;5370.89896571202;5590.2453168821685;5595.860103497445;5611.242482264924;4324.935125973113;4550.590446859798;4853.854384368475;5121.8719532012;5136.383633963948;2691.8654067296557;2755.586662000676;2817.112609527992;2907.9709202908125;2929.194471520349;4665.4168228971375;4827.831025914076;5032.924506132411;5150.124478838607;5782.826515204551;4575.450945886515;5284.841454756286;5328.333958255218;5562.3047119110115;5678.006348889011;4623.930641040387;5043.268726034705;5241.292425522658;5320.467953204648;5673.014444944237;4575.4738205105505;5385.895891342344;5526.640768350045;5547.362053363753;5550.500454958911;4694.924824240128;5045.268436076675;5438.320209973754;5463.972680136733;5483.204935284281;5180.326557547494;5182.922256166236;5426.620136590401;5723.456271654186;5728.341240757366;3739.9065023374633;3774.6033967432227;3793.0086704479263;3793.8428779222604;3854.807259637063;5330.573554115739;5753.71231438418;5802.361740208658;5873.588848780544;5886.94113058864;4767.261074533453;5244.377811094453;5697.7151142443545;5723.796338409659;5786.392428795084;4085.8365665373053;4226.598473145046;5660.556558077664;5764.99112655292;5779.942200577941;4875.9512404875495;5639.702868340222;5672.631278966854;5683.658980461186;5687.317521897398;4750.5249475052215;5452.963936851986;5774.595778295479;5833.708314584339;5848.64908105515;5348.839534813962;5619.021918383263;5628.718564071862;5685.630434021776;5698.202251684685 10:48:46 INFO - PROCESS | 1638 | |5;yui.html;701.2706784943659;715.813888389019;717.2970488920857;751.7068343346093;768.1627026541071;14973.401063957443;15256.618584535392;15394.769078463833;15565.766513502307;15622;13972.650683732913;13993.230372329517;14005.159690418583;14005.579832605014;14164.50424235152;677.3192941094205;709.6877373955443;862.8101817600118;879.612970293069;898.6135961536537;837.3092198935872;883.2757139145903;886.2511178054533;889.2707979456848;889.4307643108383;884.7964968057319;903.1284810158196;905.1808113657117;938.6808485115059;940.7789169545151;902.6615019367737;918.2057520245007;921.801812610292;930.6417029443713;938.249400479617;678.8472593666435;686.084077756196;701.8350687588413;703.9968045535092;706.3925024478943;12878.742425151444;12979.480820767158;12993.350332483338;13012;15104.697906041927;12042;14361.71276574473;14512.118249095442;14690;14702.411903523845;11710.76578468426;11834.881651183465;11990.520379184822;12067.336296503689;12101.031917446584;3369.7641165118453;3748.7938163401004;3804.2011177652726;3863.864764733249;3911.6283953024417;92474.53762731211;97098.0290197096;97740.51129744377;98138.65821405189;98692.50653746758;9078.319126065571;10959.71149715794;11027.062699670618;11122.777544449065;11241.66275011751;21651.67522487164;21813.345599632037;21886.781132188793;22025.33923982283;22491.775082249296;6336.6831658416895;7641.69433222676;7893.881591776128;7935.563544005136;8087.069986951458;4214.136102099063;4248.5792412326755;4278;4335.523092459827;4412.779361031936;3275.082976766509;3373.308471763283;3408.284260305314;3413.60743514499;3420.572428446444;524.6642149024627;604.29901314475;607.7022259093012;620.6090163197157;622.5579838314757;515.1242887091959;549.7800879648173;561.214299980023;585.5527270381446;674.261683456624;9163.908360916439;9272.675456358995;9313.254939604816;9524.523773811281;9609.231261499064;570.8258981010831;656.7832615236961;679.3681875855403;696.6342670098138;697.4524997876642;4604.539546045368;4641.210994130938;4650.651201159926;4658.883527911761;4699.412573428322;80177.59911200407;109126;123739.3813030929;123880;124322;105400;107393.55638661706;108188;110506.89493105127;112106.43946780213;92478.61282080774;93701;94793;95505.04494954961;98856.50571747095;7915.44591878563;8103.4603425349;8323.542205178774;9091.909080909107;9117.316201285063;44685.88285292894;47141.764291178326;52827.73586132045;60086.39913600983;61033.69483152556;63198;79200;87586.24827503541;87696;89422.55288723514;10347.741306467398;10748.066199847339;10844.403557804397;10847.45762711877;11100.500477478694;12229.266244025386;12301.93849030785;12433.689157771129;12552.309622970459;12658.936705316415;11911.880881191077;12049;12073.456694448596;12117.606475255106;12524.373781310716;9711.9028809711;11981.940090299493;12013.459394327101;12112.697182570506;12307.75384492323;11829.940850296038;11880.524779008743;12102.394880255775;12214.022878169902;12214.816777748163;10373.325733827278;10423.530941107516;10502.317349372266;10538;10864;10238.948805255926;10247.795044098928;10360.015798499131;10367.32612380193;10385.169186464913 10:48:46 INFO - PROCESS | 1638 | __end_tp_report 10:48:46 INFO - PROCESS | 1638 | __start_cc_report 10:48:46 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,362 10:48:46 INFO - PROCESS | 1638 | __end_cc_report 10:48:46 INFO - PROCESS | 1638 | __startTimestamp1485197326569__endTimestamp 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | ------- Summary: start ------- 10:48:46 INFO - PROCESS | 1638 | Number of tests: 6 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5928.20 Median:6244.84 stddev:664.73 (10.6%) stddev-sans-first:641.55 10:48:46 INFO - PROCESS | 1638 | Values: 3616.3 3638.7 3644.6 3648.5 3676.9 6041.3 6092.4 6097.1 6103.4 6108.5 5444.9 5690.3 5777.2 6035.0 6151.8 4443.0 4924.0 4978.9 5346.7 5425.6 4558.3 5493.5 5501.6 5523.7 5532.9 5322.5 5366.4 5472.5 5489.9 5537.6 4793.9 4812.4 5275.8 5386.4 5474.6 5353.5 5450.1 5470.9 5478.3 5503.5 5827.8 6047.2 6070.2 6141.6 6152.4 6247.6 6263.5 6272.6 6275.3 6302.1 6425.2 6429.5 6433.0 6503.3 6510.7 6244.8 6247.2 6252.3 6265.9 6270.7 5442.9 5504.5 6477.1 6543.1 6548.2 6318.8 6321.5 6330.6 6330.7 6333.7 6268.8 6273.4 6453.0 6472.1 6511.3 6268.4 6304.3 6312.7 6383.7 6384.1 6340.7 6374.6 6382.5 6388.8 6411.6 5047.9 5209.3 5220.1 5233.2 5253.2 4605.9 4624.7 4629.0 4658.3 4753.3 5430.9 5748.7 5953.5 6223.6 6279.7 4913.6 6025.8 6436.2 6496.7 6504.8 6111.4 6155.8 6177.5 6197.0 6197.8 5710.7 5713.9 5728.3 5729.9 5779.8 5539.6 6682.3 6711.0 6715.5 6723.3 6206.2 6332.9 6339.6 6440.0 6483.0 5434.5 6541.6 6668.2 6699.4 6705.7 6371.8 6373.0 6382.2 6383.8 6388.8 6258.2 6286.8 6392.3 6396.5 6453.6 6218.7 6221.4 6257.3 6308.9 6332.2 6258.0 6290.1 6308.2 6322.3 6388.7 6138.0 6208.9 6254.4 6289.7 6311.8 6178.8 6238.0 6273.0 6275.0 6313.9 6300.7 6302.1 6305.9 6316.4 6332.7 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72388.59 Median:42197.97 stddev:158418.75 (375.4%) stddev-sans-first:158771.10 10:48:46 INFO - PROCESS | 1638 | Values: 456.6 499.9 503.9 508.2 524.8 36190.6 42364.4 42472.6 42517.6 42529.5 43454.8 44035.3 44055.0 44097.6 44119.3 9614.1 9799.8 9815.2 9815.6 9834.5 9806.0 9899.8 9904.7 9905.8 9921.1 9860.3 9875.0 9893.8 9902.8 9926.5 9840.0 9850.6 9900.5 9906.5 9939.5 9747.0 9789.1 9847.6 9862.4 9885.3 41572.4 41595.6 41800.2 41802.8 41955.8 3371.7 3511.0 3595.9 3611.4 3706.7 31220.4 31377.0 31405.7 31854.7 31933.0 3284.1 3297.0 3375.4 3384.3 3390.8 463731.0 463992.0 466030.0 468643.0 473420.0 63470.0 63588.0 63822.0 63886.0 64195.0 64806.7 65448.7 65875.7 65947.0 65980.0 14024.8 16829.2 17028.2 17097.7 17123.6 13110.7 13168.0 13198.6 13259.7 13262.9 17729.5 17832.8 18103.3 18149.1 18327.4 6432.4 6496.5 6644.8 7217.3 7384.3 665.7 907.6 953.4 1019.3 1036.1 30215.5 30438.8 30724.0 30900.5 31102.5 869.0 1015.8 1082.6 1101.9 1104.5 12893.5 15881.9 15885.8 15987.5 16050.0 678993.0 685818.0 687353.0 689399.0 690802.0 48048.8 60986.7 60992.0 61031.4 61137.7 1420.9 1431.9 1444.0 1451.9 1452.9 29527.0 30296.0 30567.7 30747.7 30872.8 51896.0 52804.2 52875.0 52886.0 52903.5 588265.0 604250.0 605215.0 605552.0 609531.0 22544.4 27341.0 27778.9 28307.9 28581.9 48507.8 49011.0 49027.0 49279.0 49625.0 39928.8 40034.4 40886.0 41633.8 42031.6 40109.4 40457.8 41481.2 41641.4 43042.1 38387.6 39020.8 39199.4 39327.2 39811.8 34398.0 35807.5 35914.9 35925.5 36369.6 26534.6 26648.3 26672.0 26681.6 27233.7 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:35299.63 Median:25899.24 stddev:101048.65 (390.2%) stddev-sans-first:101298.00 10:48:46 INFO - PROCESS | 1638 | Values: 328.3 387.1 389.3 396.5 398.9 17907.6 20261.5 20825.3 21131.9 21305.1 12002.6 12079.5 17727.6 19995.0 20703.2 5343.8 5453.1 5570.1 5571.6 5583.6 5591.3 5971.7 6025.4 6081.0 6083.3 5774.7 5944.1 5946.3 6044.2 6051.9 5977.7 6070.5 6101.3 6106.3 6110.8 5154.6 5324.6 5395.2 5414.8 5441.2 24923.8 24939.5 25875.0 25923.5 25950.6 2077.5 2184.7 2334.5 2427.5 2434.8 10163.8 10446.2 10465.2 10704.0 10846.0 1871.6 1888.8 1917.1 1961.7 2037.7 114314.0 116179.4 116728.0 122940.0 127530.0 11784.9 11858.2 11942.5 11957.5 11959.8 15167.3 15342.8 15347.5 15372.2 15386.2 8696.2 8862.3 8902.3 8908.6 8947.6 7187.1 8736.5 8748.5 8827.6 8834.9 3906.0 4627.6 4679.2 4719.4 4737.3 2004.2 2057.5 2058.4 2067.7 2078.9 769.2 871.4 872.6 876.6 915.5 16627.8 20978.6 21289.5 21997.8 22129.4 952.8 955.4 976.8 977.7 1006.4 11075.2 11491.7 11628.0 11631.4 11669.4 595952.0 600159.0 605060.0 612287.0 614115.0 82296.0 105404.0 138854.0 138857.0 141438.9 794.5 964.7 992.5 993.9 998.7 19100.4 19825.7 19875.8 19892.8 19921.9 55280.7 55557.2 57255.0 57342.9 58145.7 80048.0 81677.8 83814.6 84962.0 86993.6 6345.0 7217.8 7691.7 7736.4 8018.5 11354.8 11564.8 12272.2 13117.9 13306.5 11102.1 11337.8 11480.6 11490.1 11698.1 11105.3 11160.7 11206.1 11285.7 11624.0 11232.3 11333.8 11535.8 11560.6 11666.7 7648.4 7656.6 7697.2 7750.0 7823.0 9255.3 9709.6 11062.1 11248.8 11338.4 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5481.14 Median:5280.42 stddev:2969.96 (56.2%) stddev-sans-first:2962.46 10:48:46 INFO - PROCESS | 1638 | Values: 1401.7 1504.0 1723.0 1737.8 1908.9 7104.0 7709.0 7907.4 8558.4 8585.0 7991.0 8358.4 8370.7 8379.2 8448.0 2356.4 2383.9 2394.7 2401.9 2414.4 2014.0 2428.8 2455.9 2456.3 2456.6 2391.2 2395.8 2401.7 2411.3 2419.0 2260.7 2373.8 2400.9 2403.6 2404.9 2394.8 2402.7 2413.4 2420.2 2422.9 8282.9 8379.0 8442.7 8462.5 8487.1 5157.8 5312.9 5317.3 5327.4 5328.0 3423.4 3437.6 3469.5 3490.9 3520.7 1032.7 1040.9 1079.1 1086.4 1090.9 10606.3 10767.0 10788.5 10831.8 10856.5 4499.3 4703.9 4743.7 4772.8 4778.4 9439.7 9516.0 9538.9 9540.5 9550.7 5250.1 5271.4 5289.5 5301.2 5310.2 4370.1 4386.8 4532.3 4764.4 4832.7 3920.7 3950.4 4017.4 4041.9 4057.6 1294.4 1318.3 1318.6 1323.8 1324.3 933.7 934.9 949.6 952.9 985.2 5692.6 5708.2 5809.4 5920.2 5969.1 433.3 446.3 458.6 459.2 465.5 3925.4 3942.3 3954.6 3985.1 4060.8 9659.8 9898.2 9972.8 10030.2 10056.1 9845.6 9973.0 9989.9 9994.3 10014.2 7693.9 7858.3 7863.3 7907.2 7908.4 5528.6 5651.8 5668.9 5729.5 5742.7 9331.3 9342.3 9395.7 9485.2 9494.0 9073.6 9360.3 9424.8 9445.5 9495.1 6708.6 6895.4 7093.3 7239.3 7380.1 7718.3 7930.0 7956.2 7966.8 7992.5 7004.3 7141.4 7252.9 7261.3 7342.3 6966.7 7115.1 7123.4 7146.7 7271.1 6658.6 6779.2 6796.6 6800.2 6814.7 4080.8 4270.5 4864.3 4897.6 5020.9 4871.1 4917.1 4947.5 5078.2 5135.1 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4463.83 Median:4840.84 stddev:1361.25 (28.1%) stddev-sans-first:1328.35 10:48:46 INFO - PROCESS | 1638 | Values: 279.7 312.8 322.4 324.6 327.9 4358.5 4651.3 4776.5 5229.8 5471.0 4429.7 4473.0 5304.2 5346.3 5381.3 3658.4 4171.9 4172.6 4188.7 4189.7 4037.9 4171.4 4174.9 4194.3 4231.9 3897.8 4093.9 4099.4 4112.8 4140.8 3455.3 3630.3 3891.3 4121.2 4127.7 3174.2 3373.8 3386.8 3614.4 3629.5 3787.9 5143.4 5204.5 5242.3 5272.7 4672.6 4685.5 4707.9 4708.6 4722.8 4767.7 5362.6 5540.3 5610.9 5667.9 3274.5 3288.8 3916.2 3924.8 3952.4 5566.4 5870.0 5958.3 5964.5 5971.3 3774.7 3899.9 3945.3 3957.0 3957.9 3461.4 3817.4 4013.6 4030.0 4099.5 4665.4 4667.2 4685.0 4707.5 4742.0 4823.8 5028.2 5348.0 5840.3 5871.9 1148.6 1249.6 1301.9 1305.5 1308.3 802.4 861.3 873.0 883.7 889.9 5058.9 5119.9 5254.4 5259.2 5290.9 4288.5 5370.9 5590.2 5595.9 5611.2 4324.9 4550.6 4853.9 5121.9 5136.4 2691.9 2755.6 2817.1 2908.0 2929.2 4665.4 4827.8 5032.9 5150.1 5782.8 4575.5 5284.8 5328.3 5562.3 5678.0 4623.9 5043.3 5241.3 5320.5 5673.0 4575.5 5385.9 5526.6 5547.4 5550.5 4694.9 5045.3 5438.3 5464.0 5483.2 5180.3 5182.9 5426.6 5723.5 5728.3 3739.9 3774.6 3793.0 3793.8 3854.8 5330.6 5753.7 5802.4 5873.6 5886.9 4767.3 5244.4 5697.7 5723.8 5786.4 4085.8 4226.6 5660.6 5765.0 5779.9 4876.0 5639.7 5672.6 5683.7 5687.3 4750.5 5453.0 5774.6 5833.7 5848.6 5348.8 5619.0 5628.7 5685.6 5698.2 10:48:46 INFO - PROCESS | 1638 | 10:48:46 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21585.55 Median:4374.15 stddev:32886.10 (751.8%) stddev-sans-first:32940.96 10:48:46 INFO - PROCESS | 1638 | Values: 701.3 715.8 717.3 751.7 768.2 14973.4 15256.6 15394.8 15565.8 15622.0 13972.7 13993.2 14005.2 14005.6 14164.5 677.3 709.7 862.8 879.6 898.6 837.3 883.3 886.3 889.3 889.4 884.8 903.1 905.2 938.7 940.8 902.7 918.2 921.8 930.6 938.2 678.8 686.1 701.8 704.0 706.4 12878.7 12979.5 12993.4 13012.0 15104.7 12042.0 14361.7 14512.1 14690.0 14702.4 11710.8 11834.9 11990.5 12067.3 12101.0 3369.8 3748.8 3804.2 3863.9 3911.6 92474.5 97098.0 97740.5 98138.7 98692.5 9078.3 10959.7 11027.1 11122.8 11241.7 21651.7 21813.3 21886.8 22025.3 22491.8 6336.7 7641.7 7893.9 7935.6 8087.1 4214.1 4248.6 4278.0 4335.5 4412.8 3275.1 3373.3 3408.3 3413.6 3420.6 524.7 604.3 607.7 620.6 622.6 515.1 549.8 561.2 585.6 674.3 9163.9 9272.7 9313.3 9524.5 9609.2 570.8 656.8 679.4 696.6 697.5 4604.5 4641.2 4650.7 4658.9 4699.4 80177.6 109126.0 123739.4 123880.0 124322.0 105400.0 107393.6 108188.0 110506.9 112106.4 92478.6 93701.0 94793.0 95505.0 98856.5 7915.4 8103.5 8323.5 9091.9 9117.3 44685.9 47141.8 52827.7 60086.4 61033.7 63198.0 79200.0 87586.2 87696.0 89422.6 10347.7 10748.1 10844.4 10847.5 11100.5 12229.3 12301.9 12433.7 12552.3 12658.9 11911.9 12049.0 12073.5 12117.6 12524.4 9711.9 11981.9 12013.5 12112.7 12307.8 11829.9 11880.5 12102.4 12214.0 12214.8 10373.3 10423.5 10502.3 10538.0 10864.0 10238.9 10247.8 10360.0 10367.3 10385.2 10:48:46 INFO - PROCESS | 1638 | -------- Summary: end -------- 10:48:46 INFO - PROCESS | 1638 | 10:48:47 INFO - TEST-INFO | 1638: exit 0 10:48:47 INFO - TEST-OK | dromaeo_css | took 1114335ms 10:48:47 INFO - TEST-START | kraken 10:48:47 INFO - operating with platform_type : mac_ 10:48:47 INFO - Initialising browser for kraken test... 10:48:47 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp5lRTSq/profile http://localhost:49243/getInfo.html) 10:48:49 INFO - PROCESS | 1649 | 2017-01-23 10:48:49.899 plugin-container[1651:9857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:48:49 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:49 INFO - PROCESS | 1649 | 2017-01-23 10:48:49.900 plugin-container[1651:9857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8917, name = 'com.apple.CFPasteboardClient' 10:48:49 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:49 INFO - PROCESS | 1649 | 2017-01-23 10:48:49.900 plugin-container[1651:9857] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:48:49 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 10:48:49 INFO - PROCESS | 1649 | colorDepth:24 10:48:49 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 10:48:49 INFO - PROCESS | 1649 | __metrics 10:48:50 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 10:48:50 INFO - TEST-INFO | 1649: exit 0 10:48:50 INFO - Browser initialized. 10:48:50 INFO - Running cycle 1/1 for kraken test... 10:48:50 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp5lRTSq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:53 INFO - PROCESS | 1652 | 2017-01-23 10:48:53.557 plugin-container[1653:9979] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864b, name = 'com.apple.tsm.portname' 10:48:53 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:53 INFO - PROCESS | 1652 | 2017-01-23 10:48:53.558 plugin-container[1653:9979] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 10:48:53 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:48:53 INFO - PROCESS | 1652 | 2017-01-23 10:48:53.558 plugin-container[1653:9979] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:49:03 INFO - PROCESS | 1652 | RSS: Main: 178225152 10:49:03 INFO - PROCESS | 1652 | 10:49:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:07 INFO - PROCESS | 1652 | RSS: Main: 190382080 10:49:07 INFO - PROCESS | 1652 | 10:49:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:49:10 INFO - PROCESS | 1652 | RSS: Main: 198369280 10:49:10 INFO - PROCESS | 1652 | 10:49:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:49:14 INFO - PROCESS | 1652 | RSS: Main: 202211328 10:49:14 INFO - PROCESS | 1652 | 10:49:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:49:16 INFO - PROCESS | 1652 | RSS: Main: 203501568 10:49:16 INFO - PROCESS | 1652 | 10:49:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:19 INFO - PROCESS | 1652 | RSS: Main: 203599872 10:49:19 INFO - PROCESS | 1652 | 10:49:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:22 INFO - PROCESS | 1652 | RSS: Main: 208076800 10:49:22 INFO - PROCESS | 1652 | 10:49:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:26 INFO - PROCESS | 1652 | RSS: Main: 207446016 10:49:26 INFO - PROCESS | 1652 | 10:49:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:49:29 INFO - PROCESS | 1652 | RSS: Main: 206938112 10:49:29 INFO - PROCESS | 1652 | 10:49:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:31 INFO - PROCESS | 1652 | RSS: Main: 206381056 10:49:31 INFO - PROCESS | 1652 | 10:49:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:34 INFO - PROCESS | 1652 | RSS: Main: 206393344 10:49:34 INFO - PROCESS | 1652 | 10:49:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:37 INFO - PROCESS | 1652 | RSS: Main: 206835712 10:49:37 INFO - PROCESS | 1652 | 10:49:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:40 INFO - PROCESS | 1652 | RSS: Main: 206340096 10:49:40 INFO - PROCESS | 1652 | 10:49:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:44 INFO - PROCESS | 1652 | RSS: Main: 206770176 10:49:44 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:49:46 INFO - PROCESS | 1652 | RSS: Main: 208400384 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | __start_tp_report 10:49:46 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:49:46 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:49:46 INFO - PROCESS | 1652 | |i|pagename|runs| 10:49:46 INFO - PROCESS | 1652 | |0;ai-astar;106;125;135;117;115;117;117;115;116;118 10:49:46 INFO - PROCESS | 1652 | |1;audio-beat-detection;143;110;107;135;146;145;114;112;157;145 10:49:46 INFO - PROCESS | 1652 | |2;audio-dft;192;200;196;214;233;228;275;201;198;193 10:49:46 INFO - PROCESS | 1652 | |3;audio-fft;79;58;60;87;59;60;60;57;77;61 10:49:46 INFO - PROCESS | 1652 | |4;audio-oscillator;80;70;89;79;98;101;103;68;69;87 10:49:46 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;80;134;89;85;89;85;98;87;89;102 10:49:46 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;95;94;95;95;95;96;96;95;94 10:49:46 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;88;86;85;88;124;146;89;88;89 10:49:46 INFO - PROCESS | 1652 | |8;json-parse-financial;65;74;54;56;58;59;58;60;57;57 10:49:46 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;67;68;74;70;77;70;69;70;70;72 10:49:46 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;85;81;84;81;87;82;85;85;83;85 10:49:46 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;137;123;155;148;162;163;156;167;178;152 10:49:46 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;186;232;194;165;163;162;164;166;164;164 10:49:46 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;58;58;66;70;90;88;86;65;67;65 10:49:46 INFO - PROCESS | 1652 | __end_tp_report 10:49:46 INFO - PROCESS | 1652 | __start_cc_report 10:49:46 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,907 10:49:46 INFO - PROCESS | 1652 | __end_cc_report 10:49:46 INFO - PROCESS | 1652 | __startTimestamp1485197386367__endTimestamp 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:49:46 INFO - PROCESS | 1652 | Number of tests: 14 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:118.10 Median:117.00 stddev:7.50 (6.4%) stddev-sans-first:6.56 10:49:46 INFO - PROCESS | 1652 | Values: 106.0 125.0 135.0 117.0 115.0 117.0 117.0 115.0 116.0 118.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:144.00 stddev:18.61 (12.9%) stddev-sans-first:19.26 10:49:46 INFO - PROCESS | 1652 | Values: 143.0 110.0 107.0 135.0 146.0 145.0 114.0 112.0 157.0 145.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:213.00 Median:207.50 stddev:26.12 (12.6%) stddev-sans-first:26.57 10:49:46 INFO - PROCESS | 1652 | Values: 192.0 200.0 196.0 214.0 233.0 228.0 275.0 201.0 198.0 193.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:10.84 (17.9%) stddev-sans-first:10.39 10:49:46 INFO - PROCESS | 1652 | Values: 79.0 58.0 60.0 87.0 59.0 60.0 60.0 57.0 77.0 61.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:79.50 stddev:13.32 (16.8%) stddev-sans-first:14.03 10:49:46 INFO - PROCESS | 1652 | Values: 80.0 70.0 89.0 79.0 98.0 101.0 103.0 68.0 69.0 87.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:93.80 Median:88.00 stddev:15.50 (17.6%) stddev-sans-first:15.61 10:49:46 INFO - PROCESS | 1652 | Values: 80.0 134.0 89.0 85.0 89.0 85.0 98.0 87.0 89.0 102.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:49:46 INFO - PROCESS | 1652 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:88.00 stddev:20.78 (23.6%) stddev-sans-first:21.66 10:49:46 INFO - PROCESS | 1652 | Values: 86.0 88.0 86.0 85.0 88.0 124.0 146.0 89.0 88.0 89.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.50 stddev:5.77 (9.9%) stddev-sans-first:5.80 10:49:46 INFO - PROCESS | 1652 | Values: 65.0 74.0 54.0 56.0 58.0 59.0 58.0 60.0 57.0 57.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.00 stddev:2.95 (4.2%) stddev-sans-first:2.80 10:49:46 INFO - PROCESS | 1652 | Values: 67.0 68.0 74.0 70.0 77.0 70.0 69.0 70.0 70.0 72.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.00 stddev:1.99 (2.3%) stddev-sans-first:2.06 10:49:46 INFO - PROCESS | 1652 | Values: 85.0 81.0 84.0 81.0 87.0 82.0 85.0 85.0 83.0 85.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:159.00 stddev:15.58 (9.8%) stddev-sans-first:15.25 10:49:46 INFO - PROCESS | 1652 | Values: 137.0 123.0 155.0 148.0 162.0 163.0 156.0 167.0 178.0 152.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:165.50 stddev:22.55 (13.6%) stddev-sans-first:23.63 10:49:46 INFO - PROCESS | 1652 | Values: 186.0 232.0 194.0 165.0 163.0 162.0 164.0 166.0 164.0 164.0 10:49:46 INFO - PROCESS | 1652 | 10:49:46 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:68.50 stddev:12.14 (17.7%) stddev-sans-first:11.88 10:49:46 INFO - PROCESS | 1652 | Values: 58.0 58.0 66.0 70.0 90.0 88.0 86.0 65.0 67.0 65.0 10:49:46 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:49:46 INFO - PROCESS | 1652 | 10:49:47 INFO - TEST-INFO | 1652: exit 0 10:49:47 INFO - TEST-OK | kraken | took 60217ms 10:49:47 INFO - SUITE-END | took 1174s 10:49:47 INFO - Completed test suite (00:19:34) 10:49:47 INFO - javascript benchmark 10:49:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.146791089582, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3616.3129005488954, 3638.69071128954, 3644.6173151819075, 3648.4709717091023, 3676.8896933092014, 6041.275046994361, 6092.4212199841, 6097.054956481752, 6103.420175083365, 6108.541859360555, 5444.945550544493, 5690.260266165403, 5777.248957635512, 6035.0, 6151.784687535937, 4443.022535042293, 4924.0, 4978.87552811179, 5346.6791992480385, 5425.565954723633, 4558.339040839076, 5493.450654934494, 5501.6181229773465, 5523.696196709179, 5532.917006244909, 5322.467753224666, 5366.382865970405, 5472.50747432731, 5489.862753431156, 5537.556995440375, 4793.880152996168, 4812.350332705092, 5275.815346462894, 5386.434424385422, 5474.616776825624, 5353.544948679367, 5450.100733378988, 5470.91793623096, 5478.260434841285, 5503.477169668875, 5827.766889324422, 6047.183630209909, 6070.21087258658, 6141.631502109888, 6152.354002829683, 6247.62514249142, 6263.530235232376, 6272.6236425814595, 6275.341089185661, 6302.086197501337, 6425.22897252328, 6429.549931504796, 6432.967835160841, 6503.317151699051, 6510.674466276667, 6244.843878903063, 6247.187865577536, 6252.280987686474, 6265.906011409833, 6270.65511396873, 5442.8911421771345, 5504.53211477029, 6477.125588045647, 6543.149390579194, 6548.1814773153355, 6318.8420289492215, 6321.52588555851, 6330.620162790247, 6330.715117819709, 6333.65164915934, 6268.843278917972, 6273.404026617464, 6453.0, 6472.093906853044, 6511.3163117871945, 6268.373162683695, 6304.306526282106, 6312.684365781693, 6383.6808159592765, 6384.106225128486, 6340.651264180422, 6374.649394283359, 6382.521310901701, 6388.776392826228, 6411.647359395185, 5047.873803154877, 5209.270702101709, 5220.112580861262, 5233.188855727369, 5253.212018197301, 4605.8848528786375, 4624.745638989888, 4628.9537104628525, 4658.34783130362, 4753.287006948916, 5430.864228394322, 5748.655080695172, 5953.464188222994, 6223.626582405071, 6279.748810047547, 4913.557779799764, 6025.758969641253, 6436.195475565554, 6496.675166241669, 6504.804855854332, 6111.449969502766, 6155.753769849245, 6177.536684748662, 6196.969015154896, 6197.845053873599, 5710.714464276853, 5713.857153571111, 5728.283964504437, 5729.88540229193, 5779.797707080232, 5539.556835453154, 6682.264950855402, 6710.966445167743, 6715.496337774589, 6723.294054124247, 6206.224221972254, 6332.905006425, 6339.619622822645, 6440.0, 6483.0, 5434.456554344534, 6541.574797638329, 6668.233153187445, 6699.39705426514, 6705.698243579148, 6371.840703982438, 6373.0, 6382.20222472191, 6383.776567820104, 6388.8083357499345, 6258.186435763321, 6286.779962701284, 6392.264889537762, 6396.488280937607, 6453.645049522322, 6218.720157592828, 6221.4089661482085, 6257.342978987323, 6308.905366419599, 6332.176817013758, 6258.0, 6290.0879372491645, 6308.179936608211, 6322.304546499973, 6388.712507937061, 6138.020573254662, 6208.906866397098, 6254.437100660963, 6289.7484100635465, 6311.8106456804535, 6178.752849885954, 6238.0, 6273.027680709497, 6275.0, 6313.873722525432, 6300.7479700811455, 6302.1492098566105, 6305.873882522415, 6316.368363163647, 6332.746690132343], "value": 5889.718594836445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.55713957461273, 499.92001279795227, 503.87403149212696, 508.2274942088026, 524.8034481382449, 36190.63809361909, 42364.364534532004, 42472.57527424725, 42517.57482425179, 42529.51146709866, 43454.78272608633, 44035.3394699079, 44055.0, 44097.55902440983, 44119.33820992688, 9614.13472787449, 9799.755006124833, 9815.214782817393, 9815.607375704963, 9834.508274586278, 9806.0, 9899.802003959916, 9904.653337133203, 9905.75235619108, 9921.057499537568, 9860.30977831552, 9874.950625246864, 9893.802123957517, 9902.752431189241, 9926.45404502752, 9840.015998400175, 9850.60597576096, 9900.455474948874, 9906.504674766305, 9939.50302484873, 9746.951265243699, 9789.070038346346, 9847.60609575616, 9862.408255504693, 9885.258605604537, 41572.37641435381, 41595.58404415947, 41800.16399671989, 41802.79098604518, 41955.79022104901, 3371.724418916644, 3510.9993651809114, 3595.856165753367, 3611.404118320474, 3706.666400023984, 31220.37559248825, 31377.0, 31405.685943140506, 31854.681453185403, 31933.0, 3284.096873359821, 3297.0438572813855, 3375.4261775498226, 3384.2554637979606, 3390.847411866472, 463731.0, 463992.0, 466029.9999999966, 468643.0, 473420.0, 63470.0, 63588.0, 63822.042669359995, 63886.0, 64195.0, 64806.70386592336, 65448.672756636865, 65875.67062164658, 65947.0, 65980.0, 14024.789628155586, 16829.242684079247, 17028.233729482203, 17097.743533847002, 17123.571910702332, 13110.672233194246, 13168.012399070109, 13198.60404187876, 13259.66850828737, 13262.867371326356, 17729.46811595654, 17832.821671783116, 18103.275868965095, 18149.092545372678, 18327.35854245095, 6432.35676432353, 6496.512761542903, 6644.800655980328, 7217.314355136254, 7384.298491643285, 665.7436886798521, 907.6278725722422, 953.3564843730593, 1019.3476175247847, 1036.0623635609786, 30215.546766798514, 30438.847805761274, 30724.0, 30900.53649195264, 31102.53346199809, 868.9869651955225, 1015.8374660054355, 1082.6048492300254, 1101.9366311509432, 1104.5305745058317, 12893.484260629657, 15881.920590397205, 15885.841141588668, 15987.520374388787, 16050.0, 678993.0, 685818.0, 687353.0, 689399.0, 690802.0, 48048.759756201696, 60986.69506652527, 60992.0, 61031.38968610257, 61137.69431152816, 1420.9147451152965, 1431.9427222910967, 1443.9711205775825, 1451.9128852268898, 1452.8765054970233, 29527.0, 30296.0, 30567.694323057374, 30747.692523074482, 30872.84563577168, 51896.0, 52804.20793688021, 52875.0, 52886.0, 52903.470965291395, 588265.0, 604250.0, 605215.0, 605552.0, 609531.0, 22544.436389090402, 27341.0, 27778.861105695152, 28307.858460707565, 28581.857090714413, 48507.78730531765, 49011.0, 49027.01945961132, 49279.0, 49625.0, 39928.800355998035, 40034.39948400835, 40886.0, 41633.79183104186, 42031.57968420399, 40109.398359025225, 40457.797711011255, 41481.170376592905, 41641.37537936873, 43042.13915721731, 38387.6161238384, 39020.804895975336, 39199.41200881932, 39327.2134557313, 39811.805645830675, 34398.0, 35807.46288805722, 35914.92255232347, 35925.461118083775, 36369.636303636624, 26534.601980969914, 26648.333791655365, 26672.0, 26681.599776003764, 27233.72766272312], "value": 20413.525018193817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.32365327425504, 387.06330679754996, 389.30120433821287, 396.48457005892334, 398.8903051660795, 17907.64184716305, 20261.493462663442, 20825.27111551096, 21131.943402829853, 21305.147794088258, 12002.579909703161, 12079.4564244609, 17727.55681107973, 19995.0, 20703.171873125095, 5343.839684809443, 5453.100238460649, 5570.136628822539, 5571.554275657938, 5583.637063590853, 5591.329040515144, 5971.731272092767, 6025.427584379477, 6080.969595152018, 6083.270007599094, 5774.682392468412, 5944.078667806497, 5946.316173640043, 6044.153818465396, 6051.878962420749, 5977.671228082454, 6070.484008859252, 6101.298350689639, 6106.328303886569, 6110.755569777226, 5154.613403994678, 5324.5740340772645, 5395.244665746799, 5414.7834086636485, 5441.211024401479, 24923.750762492324, 24939.50120997588, 25875.0, 25923.48153036929, 25950.610740838903, 2077.480629842539, 2184.748753893291, 2334.509752951882, 2427.5023620157826, 2434.793042591364, 10163.796724065478, 10446.164306855433, 10465.162786977024, 10704.0, 10845.969632884864, 1871.56018335691, 1888.8394486468667, 1917.0702209428416, 1961.7057441383763, 2037.74528183977, 114314.0, 116179.4191029048, 116728.0, 122940.0, 127530.0, 11784.88215117855, 11858.169928105122, 11942.462589183508, 11957.52169913211, 11959.820602690967, 15167.317470713844, 15342.769858452131, 15347.539573812803, 15372.154531500652, 15386.153761542999, 8696.17386348296, 8862.291016718647, 8902.332325075646, 8908.55457227149, 8947.552622368856, 7187.065681461377, 8736.519491427905, 8748.47509149453, 8827.646894124164, 8834.911650883538, 3905.9804700976315, 4627.583517483443, 4679.22792739201, 4719.433667959866, 4737.336772851803, 2004.2383894120142, 2057.4753437873246, 2058.3927741316347, 2067.7208576842236, 2078.91684332625, 769.2154002917105, 871.4335681806749, 872.5515644030878, 876.5529579914289, 915.4873270968279, 16627.833721662628, 20978.580428391346, 21289.467763305733, 21997.780022199895, 22129.446763831034, 952.7903861150675, 955.4171955107379, 976.7802244494932, 977.7164622259608, 1006.4313662780505, 11075.224734268524, 11491.71270718222, 11628.0, 11631.418429078512, 11669.35818529972, 595952.0, 600159.0, 605060.0, 612287.0, 614115.0, 82296.0, 105404.0, 138854.0, 138857.0, 141438.87841682383, 794.4716763352421, 964.744342749172, 992.5136683025265, 993.9353941993892, 998.650472334677, 19100.426987190407, 19825.702614460508, 19875.80745155295, 19892.801071989095, 19921.9042952639, 55280.72359638176, 55557.166642499586, 57255.0, 57342.85314293774, 58145.70927145337, 80047.99880002813, 81677.77483337636, 83814.58092709497, 84962.0, 86993.56503217696, 6345.0, 7217.84514477681, 7691.653875575725, 7736.381089512713, 8018.518888866687, 11354.772904542027, 11564.826527601925, 12272.202306850026, 13117.93441032827, 13306.534271300457, 11102.111831053335, 11337.773244535229, 11480.598179063692, 11490.080793536665, 11698.06415486776, 11105.278156919774, 11160.720981975515, 11206.103511719206, 11285.661430157108, 11624.0, 11232.269902456314, 11333.773324533628, 11535.8269625954, 11560.595379161688, 11666.650000499998, 7648.426368022532, 7656.617169141632, 7697.230276972258, 7750.0, 7822.960885195537, 9255.305852061258, 9709.6116155353, 11062.115030797679, 11248.756939898434, 11338.376389298668], "value": 9573.286968840543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.747685416625, 1504.0299007140395, 1723.0437107405394, 1737.756714060031, 1908.8759230650007, 7103.9644801775985, 7709.036370453693, 7907.44647874649, 8558.44370115942, 8584.957075214623, 7991.0, 8358.414910956235, 8370.665173393072, 8379.162083791618, 8448.0, 2356.4344557306295, 2383.904643814254, 2394.736578976311, 2401.86789726565, 2414.4326083370393, 2013.9697904531445, 2428.8421252618523, 2455.9263222103277, 2456.336789066951, 2456.6437866509345, 2391.175044609607, 2395.796357309622, 2401.687780588521, 2411.3368823573483, 2418.9879050604723, 2260.7174103237094, 2373.750756170603, 2400.9039638414442, 2403.567357875582, 2404.89177986991, 2394.7964423024064, 2402.7356990731005, 2413.3725231439953, 2420.225527831095, 2422.903083876643, 8282.875756863652, 8379.0, 8442.704505342344, 8462.492250464991, 8487.10885357041, 5157.767900444489, 5312.92030619541, 5317.335333083364, 5327.360716713981, 5327.973360133214, 3423.3837909176336, 3437.6390478999847, 3469.4795780632853, 3490.947635785465, 3520.6655367740022, 1032.6695457453618, 1040.9323393979366, 1079.071998081649, 1086.4241951765578, 1090.8800031996475, 10606.257561970666, 10767.0, 10788.514516846839, 10831.783364332668, 10856.45717714119, 4499.257622492318, 4703.929441058387, 4743.667943244009, 4772.809087636525, 4778.426588809296, 9439.716808495756, 9515.952420237854, 9538.85691714611, 9540.522973851419, 9550.713478595653, 5250.107481728115, 5271.3674359076385, 5289.47105289468, 5301.204819277063, 5310.176922577007, 4370.060437006059, 4386.780660967002, 4532.252178390595, 4764.356811830427, 4832.734199618984, 3920.745151565139, 3950.4074388841327, 4017.397390391406, 4041.9191616167514, 4057.634812866797, 1294.372229468707, 1318.2947123288993, 1318.6241921052454, 1323.8146659467682, 1324.311358093805, 933.7198840347869, 934.8691183234353, 949.5821838391086, 952.8808898887639, 985.1822986920838, 5692.6015178937905, 5708.1723150143, 5809.419058094157, 5920.171176035358, 5969.134475501028, 433.2526391973883, 446.3149066183458, 458.5689451915256, 459.16661259814, 465.4530926161746, 3925.430812532224, 3942.2706799242233, 3954.5649978502342, 3985.143194213258, 4060.7766572838777, 9659.758506037406, 9898.208143348515, 9972.750681233027, 10030.247731420173, 10056.094951454405, 9845.55694993727, 9973.0, 9989.900100999042, 9994.250431217688, 10014.198864090855, 7693.923060769321, 7858.292753652198, 7863.252990965849, 7907.209279072162, 7908.3673306136525, 5528.612997090165, 5651.8304450866535, 5668.858278543069, 5729.512991395612, 5742.741576629145, 9331.300152488455, 9342.346035777431, 9395.671151509665, 9485.193758530602, 9494.0, 9073.63895415693, 9360.251179905727, 9424.811503770023, 9445.52772361393, 9495.097965693249, 6708.563943343667, 6895.4138898194215, 7093.255208203271, 7239.348458638748, 7380.114386273682, 7718.3053525183, 7929.960350198443, 7956.204379562229, 7966.760997170094, 7992.480488768211, 7004.264552221944, 7141.357277845019, 7252.854942901007, 7261.346478816932, 7342.265773422615, 6966.721331146698, 7115.1106111736035, 7123.358897699232, 7146.67839947214, 7271.091113610799, 6658.5671931324305, 6779.220389655253, 6796.592204467748, 6800.217974932946, 6814.693338799667, 4080.81656319664, 4270.48754149504, 4864.343313652753, 4897.608191344612, 5020.949790502194, 4871.147549178951, 4917.0903382874285, 4947.529984651453, 5078.21287700407, 5135.050015747099], "value": 4402.0635469770195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.6685927176296, 312.77011396623476, 322.39068161175385, 324.6347858659009, 327.8852401659419, 4358.5423530529315, 4651.325557794118, 4776.546228108324, 5229.797146656267, 5471.0, 4429.6899217054815, 4472.955270447303, 5304.230886521452, 5346.27825243592, 5381.300430943972, 3658.432942893842, 4171.895702607444, 4172.561881002496, 4188.685848561355, 4189.748615083089, 4037.899052523681, 4171.436856024428, 4174.895627609319, 4194.30793919003, 4231.915361692764, 3897.791684577776, 4093.9181216375655, 4099.405586190001, 4112.807285887089, 4140.81366338514, 3455.274392377604, 3630.255797561507, 3891.2606604745006, 4121.216968775923, 4127.711060225785, 3174.190581401751, 3373.8023001834486, 3386.779859309137, 3614.4397618369194, 3629.4737263096704, 3787.886363409102, 5143.408508021588, 5204.531592156686, 5242.266082748418, 5272.710000949946, 4672.579467847876, 4685.461171965199, 4707.858764237044, 4708.646851486153, 4722.83470078549, 4767.666263361566, 5362.624616276862, 5540.252065971123, 5610.943890561083, 5667.886642267173, 3274.5088236764436, 3288.8355582221034, 3916.15802602439, 3924.7645141291614, 3952.3676211805973, 5566.4135721319635, 5869.976961864643, 5958.255218097738, 5964.463198312129, 5971.253593300794, 3774.7168962327937, 3899.888531768489, 3945.349017412152, 3957.0, 3957.920841583152, 3461.44616861301, 3817.4464702617965, 4013.6451949634975, 4029.9522124247906, 4099.549049604541, 4665.4168228971375, 4667.159911216014, 4685.0, 4707.458642256116, 4742.027884283713, 4823.758812059383, 5028.19548872186, 5347.989008243817, 5840.2991641003355, 5871.911921321183, 1148.6439203846835, 1249.575144450891, 1301.889339406161, 1305.477808876457, 1308.3131356037966, 802.3741481644327, 861.3453775130946, 872.9825403491894, 883.7481317824389, 889.9110088991049, 5058.949410505921, 5119.87200319995, 5254.369475662945, 5259.184826351921, 5290.947090529123, 4288.52826189119, 5370.89896571202, 5590.2453168821685, 5595.860103497445, 5611.242482264924, 4324.935125973113, 4550.590446859798, 4853.854384368475, 5121.8719532012, 5136.383633963948, 2691.8654067296557, 2755.586662000676, 2817.112609527992, 2907.9709202908125, 2929.194471520349, 4665.4168228971375, 4827.831025914076, 5032.924506132411, 5150.124478838607, 5782.826515204551, 4575.450945886515, 5284.841454756286, 5328.333958255218, 5562.3047119110115, 5678.006348889011, 4623.930641040387, 5043.268726034705, 5241.292425522658, 5320.467953204648, 5673.014444944237, 4575.4738205105505, 5385.895891342344, 5526.640768350045, 5547.362053363753, 5550.500454958911, 4694.924824240128, 5045.268436076675, 5438.320209973754, 5463.972680136733, 5483.204935284281, 5180.326557547494, 5182.922256166236, 5426.620136590401, 5723.456271654186, 5728.341240757366, 3739.9065023374633, 3774.6033967432227, 3793.0086704479263, 3793.8428779222604, 3854.807259637063, 5330.573554115739, 5753.71231438418, 5802.361740208658, 5873.588848780544, 5886.94113058864, 4767.261074533453, 5244.377811094453, 5697.7151142443545, 5723.796338409659, 5786.392428795084, 4085.8365665373053, 4226.598473145046, 5660.556558077664, 5764.99112655292, 5779.942200577941, 4875.9512404875495, 5639.702868340222, 5672.631278966854, 5683.658980461186, 5687.317521897398, 4750.5249475052215, 5452.963936851986, 5774.595778295479, 5833.708314584339, 5848.64908105515, 5348.839534813962, 5619.021918383263, 5628.718564071862, 5685.630434021776, 5698.202251684685], "value": 4033.183913010836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.2706784943659, 715.813888389019, 717.2970488920857, 751.7068343346093, 768.1627026541071, 14973.401063957443, 15256.618584535392, 15394.769078463833, 15565.766513502307, 15622.0, 13972.650683732913, 13993.230372329517, 14005.159690418583, 14005.579832605014, 14164.50424235152, 677.3192941094205, 709.6877373955443, 862.8101817600118, 879.612970293069, 898.6135961536537, 837.3092198935872, 883.2757139145903, 886.2511178054533, 889.2707979456848, 889.4307643108383, 884.7964968057319, 903.1284810158196, 905.1808113657117, 938.6808485115059, 940.7789169545151, 902.6615019367737, 918.2057520245007, 921.801812610292, 930.6417029443713, 938.249400479617, 678.8472593666435, 686.084077756196, 701.8350687588413, 703.9968045535092, 706.3925024478943, 12878.742425151444, 12979.480820767158, 12993.350332483338, 13012.0, 15104.697906041927, 12042.0, 14361.71276574473, 14512.118249095442, 14690.0, 14702.411903523845, 11710.76578468426, 11834.881651183465, 11990.520379184822, 12067.336296503689, 12101.031917446584, 3369.7641165118453, 3748.7938163401004, 3804.2011177652726, 3863.864764733249, 3911.6283953024417, 92474.53762731211, 97098.0290197096, 97740.51129744377, 98138.65821405189, 98692.50653746758, 9078.319126065571, 10959.71149715794, 11027.062699670618, 11122.777544449065, 11241.66275011751, 21651.67522487164, 21813.345599632037, 21886.781132188793, 22025.33923982283, 22491.775082249296, 6336.6831658416895, 7641.69433222676, 7893.881591776128, 7935.563544005136, 8087.069986951458, 4214.136102099063, 4248.5792412326755, 4278.0, 4335.523092459827, 4412.779361031936, 3275.082976766509, 3373.308471763283, 3408.284260305314, 3413.60743514499, 3420.572428446444, 524.6642149024627, 604.29901314475, 607.7022259093012, 620.6090163197157, 622.5579838314757, 515.1242887091959, 549.7800879648173, 561.214299980023, 585.5527270381446, 674.261683456624, 9163.908360916439, 9272.675456358995, 9313.254939604816, 9524.523773811281, 9609.231261499064, 570.8258981010831, 656.7832615236961, 679.3681875855403, 696.6342670098138, 697.4524997876642, 4604.539546045368, 4641.210994130938, 4650.651201159926, 4658.883527911761, 4699.412573428322, 80177.59911200407, 109126.0, 123739.3813030929, 123880.0, 124322.0, 105400.0, 107393.55638661706, 108188.0, 110506.89493105127, 112106.43946780213, 92478.61282080774, 93701.0, 94793.0, 95505.04494954961, 98856.50571747095, 7915.44591878563, 8103.4603425349, 8323.542205178774, 9091.909080909107, 9117.316201285063, 44685.88285292894, 47141.764291178326, 52827.73586132045, 60086.39913600983, 61033.69483152556, 63198.0, 79200.0, 87586.24827503541, 87696.0, 89422.55288723514, 10347.741306467398, 10748.066199847339, 10844.403557804397, 10847.45762711877, 11100.500477478694, 12229.266244025386, 12301.93849030785, 12433.689157771129, 12552.309622970459, 12658.936705316415, 11911.880881191077, 12049.0, 12073.456694448596, 12117.606475255106, 12524.373781310716, 9711.9028809711, 11981.940090299493, 12013.459394327101, 12112.697182570506, 12307.75384492323, 11829.940850296038, 11880.524779008743, 12102.394880255775, 12214.022878169902, 12214.816777748163, 10373.325733827278, 10423.530941107516, 10502.317349372266, 10538.0, 10864.0, 10238.948805255926, 10247.795044098928, 10360.015798499131, 10367.32612380193, 10385.169186464913], "value": 7338.948210825081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 125.0, 135.0, 117.0, 115.0, 117.0, 117.0, 115.0, 116.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 107.0, 135.0, 146.0, 145.0, 114.0, 112.0, 157.0, 145.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 200.0, 196.0, 214.0, 233.0, 228.0, 275.0, 201.0, 198.0, 193.0], "value": 213.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 60.0, 87.0, 59.0, 60.0, 60.0, 57.0, 77.0, 61.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 70.0, 89.0, 79.0, 98.0, 101.0, 103.0, 68.0, 69.0, 87.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 134.0, 89.0, 85.0, 89.0, 85.0, 98.0, 87.0, 89.0, 102.0], "value": 93.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 86.0, 85.0, 88.0, 124.0, 146.0, 89.0, 88.0, 89.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 54.0, 56.0, 58.0, 59.0, 58.0, 60.0, 57.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 74.0, 70.0, 77.0, 70.0, 69.0, 70.0, 70.0, 72.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 84.0, 81.0, 87.0, 82.0, 85.0, 85.0, 83.0, 85.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 123.0, 155.0, 148.0, 162.0, 163.0, 156.0, 167.0, 178.0, 152.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 232.0, 194.0, 165.0, 163.0, 162.0, 164.0, 166.0, 164.0, 164.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 66.0, 70.0, 90.0, 88.0, 86.0, 65.0, 67.0, 65.0], "value": 71.3, "unit": "score"}]}]} 10:49:47 INFO - Return code: 0 10:49:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:49:47 ERROR - # TBPL SUCCESS # 10:49:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:49:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:49:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:49:47 INFO - 2017-01-23 10:49:47.716 screenresolution[1657:10361] starting screenresolution argv=screenresolution get 10:49:47 INFO - 2017-01-23 10:49:47.719 screenresolution[1657:10361] Display 0: 1600x1200x32@60 10:49:47 INFO - 2017-01-23 10:49:47.725 screenresolution[1658:10364] starting screenresolution argv=screenresolution list 10:49:47 INFO - Available Modes on Display 0 10:49:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:49:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:49:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:49:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:49:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:49:47 INFO - Intel Iris: 10:49:47 INFO - Chipset Model: Intel Iris 10:49:47 INFO - Type: GPU 10:49:47 INFO - Bus: Built-In 10:49:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:49:47 INFO - Vendor: Intel (0x8086) 10:49:47 INFO - Device ID: 0x0a2e 10:49:47 INFO - Revision ID: 0x0009 10:49:47 INFO - Displays: 10:49:47 INFO - Display: 10:49:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:49:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:49:47 INFO - Display Serial Number: 1600x1200 60 10:49:47 INFO - Main Display: Yes 10:49:47 INFO - Mirror: Off 10:49:47 INFO - Online: Yes 10:49:47 INFO - Rotation: Supported 10:49:47 INFO - Return code: 0 10:49:47 INFO - Running post-action listener: _resource_record_post_action 10:49:47 INFO - [mozharness: 2017-01-23 18:49:47.962225Z] Finished run-tests step (success) 10:49:47 INFO - Running post-run listener: _resource_record_post_run 10:49:48 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40118272; Write bytes: 497758208; Read time: 432; Write time: 1537 10:49:48 INFO - TinderboxPrint: CPU usage
54.1% 10:49:48 INFO - TinderboxPrint: I/O read bytes / time
40,118,272 / 432 10:49:48 INFO - TinderboxPrint: I/O write bytes / time
497,758,208 / 1,537 10:49:48 INFO - TinderboxPrint: CPU idle
2,194.1 (45.8%) 10:49:48 INFO - TinderboxPrint: CPU system
970.4 (20.3%) 10:49:48 INFO - TinderboxPrint: CPU user
1,621.1 (33.9%) 10:49:48 INFO - TinderboxPrint: Swap in / out
231,518,208 / 0 10:49:48 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187445760; Write bytes: 186118144; Read time: 16872; Write time: 340 10:49:48 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38107136; Write bytes: 304734208; Read time: 371; Write time: 1169 10:49:48 INFO - Running post-run listener: _upload_blobber_files 10:49:48 INFO - Blob upload gear active. 10:49:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:49:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:50 INFO - (blobuploader) - INFO - Done attempting. 10:49:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:49:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:51 INFO - (blobuploader) - INFO - Done attempting. 10:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:53 INFO - (blobuploader) - INFO - Done attempting. 10:49:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:53 INFO - Return code: 0 10:49:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81adf0e40d04051b237a4d8975db9364fd4a173767c0a45eb6fa2eb9c07769698f582ad3691ddc1d493e3e2caebdb6c144beedc2b498bfcdbf066a5c7d419028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3600647dd5f0d980f7bc3172b7a822eeaa2d58e803be7de22de3a3e3852e1d5848be5e0fd1b7f12076477e14a4bc6e06bf7321495824ab153614dda776999e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a8184973a4fb869d2539811ca137e264055268f0fc16d52abedeea226ddaaee93ca6138094c9755a9e9e455e5e4a535c990de65054d6cf92bfdb0e7bc722d3"} 10:49:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:53 INFO - Contents: 10:49:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/81adf0e40d04051b237a4d8975db9364fd4a173767c0a45eb6fa2eb9c07769698f582ad3691ddc1d493e3e2caebdb6c144beedc2b498bfcdbf066a5c7d419028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3600647dd5f0d980f7bc3172b7a822eeaa2d58e803be7de22de3a3e3852e1d5848be5e0fd1b7f12076477e14a4bc6e06bf7321495824ab153614dda776999e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a8184973a4fb869d2539811ca137e264055268f0fc16d52abedeea226ddaaee93ca6138094c9755a9e9e455e5e4a535c990de65054d6cf92bfdb0e7bc722d3"} 10:49:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:53 INFO - Copying logs to upload dir... 10:49:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.347976 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-23 10:49:53.627104) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 10:49:53.631743) ========= 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.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/81adf0e40d04051b237a4d8975db9364fd4a173767c0a45eb6fa2eb9c07769698f582ad3691ddc1d493e3e2caebdb6c144beedc2b498bfcdbf066a5c7d419028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3600647dd5f0d980f7bc3172b7a822eeaa2d58e803be7de22de3a3e3852e1d5848be5e0fd1b7f12076477e14a4bc6e06bf7321495824ab153614dda776999e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a8184973a4fb869d2539811ca137e264055268f0fc16d52abedeea226ddaaee93ca6138094c9755a9e9e455e5e4a535c990de65054d6cf92bfdb0e7bc722d3"} build_url:https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/AMsHORVZTtODu7SQ3gX8kw/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/81adf0e40d04051b237a4d8975db9364fd4a173767c0a45eb6fa2eb9c07769698f582ad3691ddc1d493e3e2caebdb6c144beedc2b498bfcdbf066a5c7d419028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3600647dd5f0d980f7bc3172b7a822eeaa2d58e803be7de22de3a3e3852e1d5848be5e0fd1b7f12076477e14a4bc6e06bf7321495824ab153614dda776999e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f4a8184973a4fb869d2539811ca137e264055268f0fc16d52abedeea226ddaaee93ca6138094c9755a9e9e455e5e4a535c990de65054d6cf92bfdb0e7bc722d3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 10:49:53.669090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:49:53.669439) ========= 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.zPDhBByVgb/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.vd16jZ5MsW/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005122 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:49:53.718410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 10:49:53.718745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 10:49:53.719085) ========= ========= Total master_lag: 0.20 =========