builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0028 starttime: 1462009891.17 results: success (0) buildid: 20160430004057 builduid: f622e2dcb37f460a93bb132619b32a7d revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:31.173888) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:31.176172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 15 secs) (at 2016-04-30 02:51:31.176556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 15 secs) (at 2016-04-30 02:51:47.043468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:47.043882) ========= 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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-30 02:51:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.7M=0s 2016-04-30 02:51:47 (26.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148499 ========= master_lag: 0.77 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:47.965526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:47.965861) ========= 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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.026302 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:48.148702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-30 02:51:48.149020) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1347c189b6da67d2142fb266c82f74272b09139b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-30 02:51:48,238 truncating revision to first 12 chars 2016-04-30 02:51:48,238 Setting DEBUG logging. 2016-04-30 02:51:48,238 attempt 1/10 2016-04-30 02:51:48,238 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1347c189b6da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 02:51:50,292 unpacking tar archive at: mozilla-aurora-1347c189b6da/testing/mozharness/ program finished with exit code 0 elapsedTime=2.451656 ========= master_lag: 2.95 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-04-30 02:51:53.548869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:53.549212) ========= script_repo_revision: 1347c189b6da67d2142fb266c82f74272b09139b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:53.552827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:53.553115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 02:51:54.191183) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-30 02:51:54.191583) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:51:54 INFO - MultiFileLogger online at 20160430 02:51:54 in /builds/slave/test 02:51:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:51:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:54 INFO - {'append_to_log': False, 02:51:54 INFO - 'base_work_dir': '/builds/slave/test', 02:51:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:51:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:54 INFO - 'branch': 'Mozilla-Aurora', 02:51:54 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:54 INFO - 'config_files': ('talos/mac_config.py',), 02:51:54 INFO - 'default_actions': ('clobber', 02:51:54 INFO - 'read-buildbot-config', 02:51:54 INFO - 'download-and-extract', 02:51:54 INFO - 'populate-webroot', 02:51:54 INFO - 'create-virtualenv', 02:51:54 INFO - 'install', 02:51:54 INFO - 'run-tests'), 02:51:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:54 INFO - 'download_minidump_stackwalk': True, 02:51:54 INFO - 'download_symbols': 'ondemand', 02:51:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:54 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:54 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:54 INFO - 'installer_path': 'installer.exe', 02:51:54 INFO - 'log_level': 'info', 02:51:54 INFO - 'log_name': 'talos', 02:51:54 INFO - 'log_to_console': True, 02:51:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:51:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:51:54 INFO - 'opt_config_files': (), 02:51:54 INFO - 'pip_index': False, 02:51:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:54 INFO - 'cmd': ('bash', 02:51:54 INFO - '-c', 02:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:54 INFO - 'enabled': True, 02:51:54 INFO - 'halt_on_failure': False, 02:51:54 INFO - 'name': 'check_screen_resolution'},), 02:51:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:54 INFO - 'cmd': ('bash', 02:51:54 INFO - '-c', 02:51:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:54 INFO - 'enabled': True, 02:51:54 INFO - 'halt_on_failure': False, 02:51:54 INFO - 'name': 'check_screen_resolution'},), 02:51:54 INFO - 'run_cmd_checks_enabled': True, 02:51:54 INFO - 'sps_profile': False, 02:51:54 INFO - 'sps_profile_interval': 0, 02:51:54 INFO - 'suite': 'dromaeojs-e10s', 02:51:54 INFO - 'system_bits': '32', 02:51:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:54 INFO - 'title': 't-yosemite-r7-0028', 02:51:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:54 INFO - 'use_talos_json': True, 02:51:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:54 INFO - 'work_dir': 'build'} 02:51:54 INFO - ##### 02:51:54 INFO - ##### Running clobber step. 02:51:54 INFO - ##### 02:51:54 INFO - Running pre-action listener: _resource_record_pre_action 02:51:54 INFO - Running main action method: clobber 02:51:54 INFO - rmtree: /builds/slave/test/build 02:51:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:56 INFO - Running post-action listener: _resource_record_post_action 02:51:56 INFO - ##### 02:51:56 INFO - ##### Running read-buildbot-config step. 02:51:56 INFO - ##### 02:51:56 INFO - Running pre-action listener: _resource_record_pre_action 02:51:56 INFO - Running main action method: read_buildbot_config 02:51:56 INFO - Using buildbot properties: 02:51:56 INFO - { 02:51:56 INFO - "project": "", 02:51:56 INFO - "product": "firefox", 02:51:56 INFO - "script_repo_revision": "production", 02:51:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:51:56 INFO - "repository": "", 02:51:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:51:56 INFO - "buildid": "20160430004057", 02:51:56 INFO - "stage_platform": "macosx64", 02:51:56 INFO - "basedir": "/builds/slave/test", 02:51:56 INFO - "nightly_build": "True", 02:51:56 INFO - "buildnumber": 277, 02:51:56 INFO - "slavename": "t-yosemite-r7-0028", 02:51:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:51:56 INFO - "platform": "yosemite_r7", 02:51:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:51:56 INFO - "branch": "mozilla-aurora", 02:51:56 INFO - "repo_path": "releases/mozilla-aurora", 02:51:56 INFO - "revision": "1347c189b6da67d2142fb266c82f74272b09139b", 02:51:56 INFO - "pgo_build": "False", 02:51:56 INFO - "builduid": "f622e2dcb37f460a93bb132619b32a7d", 02:51:56 INFO - "slavebuilddir": "test" 02:51:56 INFO - } 02:51:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 02:51:56 INFO - Running post-action listener: _resource_record_post_action 02:51:56 INFO - ##### 02:51:56 INFO - ##### Running download-and-extract step. 02:51:56 INFO - ##### 02:51:56 INFO - Running pre-action listener: _resource_record_pre_action 02:51:56 INFO - Running main action method: download_and_extract 02:51:56 INFO - mkdir: /builds/slave/test/build/tests 02:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:56 INFO - https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:51:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:51:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 02:51:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 02:51:57 INFO - Downloaded 1199 bytes. 02:51:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 02:51:57 INFO - Using the following test package requirements: 02:51:57 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:51:57 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 02:51:57 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 02:51:57 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'jsshell-mac.zip'], 02:51:57 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 02:51:57 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 02:51:57 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 02:51:57 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 02:51:57 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 02:51:57 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 02:51:57 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 02:51:57 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:57 INFO - https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:51:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:51:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:51:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:51:58 INFO - Downloaded 18110594 bytes. 02:51:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:51:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:52:01 INFO - Return code: 0 02:52:01 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:01 INFO - https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:52:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:52:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 02:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:03 INFO - Downloaded 18110594 bytes. 02:52:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:52:06 INFO - Return code: 0 02:52:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:06 INFO - https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:52:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:52:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:52:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 02:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:07 INFO - Downloaded 10840145 bytes. 02:52:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:52:08 INFO - Return code: 0 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:08 INFO - https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:52:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:52:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:52:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 02:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 02:52:11 INFO - Downloaded 114218014 bytes. 02:52:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:52:11 INFO - mkdir: /builds/slave/test/properties 02:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:11 INFO - Contents: 02:52:11 INFO - build_url:https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 02:52:12 INFO - Running post-action listener: _resource_record_post_action 02:52:12 INFO - Running post-action listener: set_extra_try_arguments 02:52:12 INFO - ##### 02:52:12 INFO - ##### Running populate-webroot step. 02:52:12 INFO - ##### 02:52:12 INFO - Running pre-action listener: _resource_record_pre_action 02:52:12 INFO - Running main action method: populate_webroot 02:52:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:12 INFO - '--tppagecycles', 02:52:12 INFO - '7'], 02:52:12 INFO - 'tests': ['tsvgm']}}, 02:52:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['damp', 'tps']}, 02:52:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'tests': ['damp', 'tps']}, 02:52:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['dromaeo_dom']}, 02:52:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['a11yr', 02:52:12 INFO - 'ts_paint', 02:52:12 INFO - 'tpaint', 02:52:12 INFO - 'sessionrestore', 02:52:12 INFO - 'sessionrestore_no_auto_restore', 02:52:12 INFO - 'tabpaint']}, 02:52:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['tsvgx', 02:52:12 INFO - 'tsvgr_opacity', 02:52:12 INFO - 'tart', 02:52:12 INFO - 'tscrollx', 02:52:12 INFO - 'cart']}, 02:52:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:12 INFO - 'tsvgr_opacity', 02:52:12 INFO - 'tart', 02:52:12 INFO - 'tscrollx', 02:52:12 INFO - 'cart']}, 02:52:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'talos_options': ['--disable-e10s'], 02:52:12 INFO - 'tests': ['tp5o']}, 02:52:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'tests': ['tp5o']}, 02:52:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'talos_options': ['--disable-e10s', 02:52:12 INFO - '--xperf_path', 02:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:12 INFO - 'tests': ['tp5n']}, 02:52:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:12 INFO - 'talos_options': ['--xperf_path', 02:52:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:12 INFO - 'tests': ['tp5n']}}, 02:52:12 INFO - 'talos.zip': {'path': '', 02:52:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:12 INFO - Running post-action listener: _resource_record_post_action 02:52:12 INFO - ##### 02:52:12 INFO - ##### Running create-virtualenv step. 02:52:12 INFO - ##### 02:52:12 INFO - Running pre-action listener: _resource_record_pre_action 02:52:12 INFO - Running main action method: create_virtualenv 02:52:12 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:12 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 02:52:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:13 INFO - Using real prefix '/tools/python27' 02:52:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:13 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:16 INFO - Installing pip.................done. 02:52:16 INFO - Return code: 0 02:52:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:16 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:16 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 02:52:16 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 02:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:16 INFO - 'HOME': '/Users/cltbld', 02:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:16 INFO - 'LOGNAME': 'cltbld', 02:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:16 INFO - 'MOZ_NO_REMOTE': '1', 02:52:16 INFO - 'NO_EM_RESTART': '1', 02:52:16 INFO - 'PAGER': '/bin/cat', 02:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:16 INFO - 'PWD': '/builds/slave/test', 02:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:16 INFO - 'SHELL': '/bin/bash', 02:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:16 INFO - 'USER': 'cltbld', 02:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:16 INFO - 'XPC_FLAGS': '0x0', 02:52:16 INFO - 'XPC_SERVICE_NAME': '0', 02:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:16 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 02:52:16 INFO - Cleaning up... 02:52:16 INFO - Return code: 0 02:52:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:52:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:16 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:16 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>=0.7.1'] in /builds/slave/test/build 02:52:16 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>=0.7.1 02:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:16 INFO - 'HOME': '/Users/cltbld', 02:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:16 INFO - 'LOGNAME': 'cltbld', 02:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:16 INFO - 'MOZ_NO_REMOTE': '1', 02:52:16 INFO - 'NO_EM_RESTART': '1', 02:52:16 INFO - 'PAGER': '/bin/cat', 02:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:16 INFO - 'PWD': '/builds/slave/test', 02:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:16 INFO - 'SHELL': '/bin/bash', 02:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:16 INFO - 'USER': 'cltbld', 02:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:16 INFO - 'XPC_FLAGS': '0x0', 02:52:16 INFO - 'XPC_SERVICE_NAME': '0', 02:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:17 INFO - Downloading/unpacking psutil>=0.7.1 02:52:17 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 02:52:17 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 02:52:17 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 02:52:17 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 02:52:17 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 02:52:17 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 02:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:20 INFO - Installing collected packages: psutil 02:52:20 INFO - Running setup.py install for psutil 02:52:20 INFO - building 'psutil._psutil_osx' extension 02:52:20 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 02:52:20 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 02:52:20 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 02:52:21 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 02:52:21 INFO - building 'psutil._psutil_posix' extension 02:52:21 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 02:52:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:52:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:52:21 INFO - ^ 02:52:21 INFO - 1 warning generated. 02:52:21 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 02:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:21 INFO - Successfully installed psutil 02:52:21 INFO - Cleaning up... 02:52:21 INFO - Return code: 0 02:52:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:52: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 mozsystemmonitor==0.0.0 02:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:21 INFO - 'HOME': '/Users/cltbld', 02:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:21 INFO - 'LOGNAME': 'cltbld', 02:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:21 INFO - 'MOZ_NO_REMOTE': '1', 02:52:21 INFO - 'NO_EM_RESTART': '1', 02:52:21 INFO - 'PAGER': '/bin/cat', 02:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:21 INFO - 'PWD': '/builds/slave/test', 02:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:21 INFO - 'SHELL': '/bin/bash', 02:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:21 INFO - 'USER': 'cltbld', 02:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:21 INFO - 'XPC_FLAGS': '0x0', 02:52:21 INFO - 'XPC_SERVICE_NAME': '0', 02:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:52:24 INFO - Installing collected packages: mozsystemmonitor 02:52:24 INFO - Running setup.py install for mozsystemmonitor 02:52:24 INFO - Successfully installed mozsystemmonitor 02:52:24 INFO - Cleaning up... 02:52:24 INFO - Return code: 0 02:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:24 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:24 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:24 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 02:52:24 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 02:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:24 INFO - 'HOME': '/Users/cltbld', 02:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:24 INFO - 'LOGNAME': 'cltbld', 02:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:24 INFO - 'MOZ_NO_REMOTE': '1', 02:52:24 INFO - 'NO_EM_RESTART': '1', 02:52:24 INFO - 'PAGER': '/bin/cat', 02:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:24 INFO - 'PWD': '/builds/slave/test', 02:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:24 INFO - 'SHELL': '/bin/bash', 02:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:24 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:24 INFO - 'USER': 'cltbld', 02:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:24 INFO - 'XPC_FLAGS': '0x0', 02:52:24 INFO - 'XPC_SERVICE_NAME': '0', 02:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:24 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 02:52:24 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 02:52:24 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 02:52:24 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 02:52:24 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 02:52:24 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 02:52:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:28 INFO - Downloading docopt-0.6.1.tar.gz 02:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:28 INFO - Running setup.py install for blobuploader 02:52:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:28 INFO - Running setup.py install for requests 02:52:28 INFO - Running setup.py install for docopt 02:52:29 INFO - Successfully installed blobuploader requests docopt 02:52:29 INFO - Cleaning up... 02:52:29 INFO - Return code: 0 02:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:29 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:29 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 02:52:29 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 02:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:29 INFO - 'HOME': '/Users/cltbld', 02:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:29 INFO - 'LOGNAME': 'cltbld', 02:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:29 INFO - 'MOZ_NO_REMOTE': '1', 02:52:29 INFO - 'NO_EM_RESTART': '1', 02:52:29 INFO - 'PAGER': '/bin/cat', 02:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:29 INFO - 'PWD': '/builds/slave/test', 02:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:29 INFO - 'SHELL': '/bin/bash', 02:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:29 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:29 INFO - 'USER': 'cltbld', 02:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:29 INFO - 'XPC_FLAGS': '0x0', 02:52:29 INFO - 'XPC_SERVICE_NAME': '0', 02:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-OZXSfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-S_5q5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rY4pXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ghY0po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-FzkpL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JU9fJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ly2bRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-2ylyUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-_pCgix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-nq94vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0FFfaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xTOYGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-bXD1Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-s_zfrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-LvmQod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ReaN2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:31 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UGzo_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:31 INFO - Running setup.py install for manifestparser 02:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:31 INFO - Running setup.py install for mozcrash 02:52:31 INFO - Running setup.py install for mozdebug 02:52:31 INFO - Running setup.py install for mozdevice 02:52:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:31 INFO - Running setup.py install for mozfile 02:52:31 INFO - Running setup.py install for mozhttpd 02:52:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Running setup.py install for mozinfo 02:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Running setup.py install for mozInstall 02:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Running setup.py install for mozleak 02:52:32 INFO - Running setup.py install for mozlog 02:52:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Running setup.py install for moznetwork 02:52:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:32 INFO - Running setup.py install for mozprocess 02:52:33 INFO - Running setup.py install for mozprofile 02:52:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:33 INFO - Running setup.py install for mozrunner 02:52:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:33 INFO - Running setup.py install for mozscreenshot 02:52:33 INFO - Running setup.py install for moztest 02:52:33 INFO - Running setup.py install for mozversion 02:52:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:33 INFO - Cleaning up... 02:52:33 INFO - Return code: 0 02:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:33 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:33 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 02:52:33 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 02:52:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:33 INFO - 'HOME': '/Users/cltbld', 02:52:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:33 INFO - 'LOGNAME': 'cltbld', 02:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:33 INFO - 'MOZ_NO_REMOTE': '1', 02:52:33 INFO - 'NO_EM_RESTART': '1', 02:52:33 INFO - 'PAGER': '/bin/cat', 02:52:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:33 INFO - 'PWD': '/builds/slave/test', 02:52:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:33 INFO - 'SHELL': '/bin/bash', 02:52:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:33 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:33 INFO - 'USER': 'cltbld', 02:52:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:33 INFO - 'XPC_FLAGS': '0x0', 02:52:33 INFO - 'XPC_SERVICE_NAME': '0', 02:52:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-RX01Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-c2UZir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UkyBMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-BiWUjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-shKYLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-NtSWOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kZafDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wtbeLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:34 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)) 02:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-P0_juT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:35 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-i87ew3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-45x0jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:35 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-aCWtAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qced0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:35 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-JuHVGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-uTFeEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:35 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)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-oH5KeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7TTY_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:35 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)) 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:52:35 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)) 02:52:35 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)) 02:52:35 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)) 02:52:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:38 INFO - Downloading blessings-1.6.tar.gz 02:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:38 INFO - Installing collected packages: blessings 02:52:38 INFO - Running setup.py install for blessings 02:52:38 INFO - Successfully installed blessings 02:52:38 INFO - Cleaning up... 02:52:38 INFO - Return code: 0 02:52:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:38 INFO - Reading from file tmpfile_stdout 02:52:38 INFO - Current package versions: 02:52:38 INFO - blessings == 1.6 02:52:38 INFO - blobuploader == 1.2.4 02:52:38 INFO - docopt == 0.6.1 02:52:38 INFO - manifestparser == 1.1 02:52:38 INFO - mozInstall == 1.12 02:52:38 INFO - mozcrash == 0.17 02:52:38 INFO - mozdebug == 0.1 02:52:38 INFO - mozdevice == 0.48 02:52:38 INFO - mozfile == 1.2 02:52:38 INFO - mozhttpd == 0.7 02:52:38 INFO - mozinfo == 0.9 02:52:38 INFO - mozleak == 0.1 02:52:38 INFO - mozlog == 3.1 02:52:38 INFO - moznetwork == 0.27 02:52:38 INFO - mozprocess == 0.22 02:52:38 INFO - mozprofile == 0.28 02:52:38 INFO - mozrunner == 6.11 02:52:38 INFO - mozscreenshot == 0.1 02:52:38 INFO - mozsystemmonitor == 0.0 02:52:38 INFO - moztest == 0.7 02:52:38 INFO - mozversion == 1.4 02:52:38 INFO - psutil == 3.1.1 02:52:38 INFO - requests == 1.2.3 02:52:38 INFO - wsgiref == 0.1.2 02:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:38 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:38 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 02:52:38 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 02:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:38 INFO - 'HOME': '/Users/cltbld', 02:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:38 INFO - 'LOGNAME': 'cltbld', 02:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:38 INFO - 'MOZ_NO_REMOTE': '1', 02:52:38 INFO - 'NO_EM_RESTART': '1', 02:52:38 INFO - 'PAGER': '/bin/cat', 02:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:38 INFO - 'PWD': '/builds/slave/test', 02:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:38 INFO - 'SHELL': '/bin/bash', 02:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:38 INFO - 'USER': 'cltbld', 02:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:38 INFO - 'XPC_FLAGS': '0x0', 02:52:38 INFO - 'XPC_SERVICE_NAME': '0', 02:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 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)) 02:52:39 INFO - Cleaning up... 02:52:39 INFO - Return code: 0 02:52:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:39 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 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:39 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 02:52:39 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 02:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:39 INFO - 'HOME': '/Users/cltbld', 02:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:39 INFO - 'LOGNAME': 'cltbld', 02:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:39 INFO - 'MOZ_NO_REMOTE': '1', 02:52:39 INFO - 'NO_EM_RESTART': '1', 02:52:39 INFO - 'PAGER': '/bin/cat', 02:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:39 INFO - 'PWD': '/builds/slave/test', 02:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:39 INFO - 'SHELL': '/bin/bash', 02:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:39 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:39 INFO - 'USER': 'cltbld', 02:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:39 INFO - 'XPC_FLAGS': '0x0', 02:52:39 INFO - 'XPC_SERVICE_NAME': '0', 02:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:39 INFO - Downloading/unpacking jsonschema 02:52:39 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 02:52:39 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 02:52:39 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 02:52:39 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 02:52:39 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 02:52:39 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 02:52:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:41 INFO - Downloading/unpacking functools32 (from jsonschema) 02:52:41 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 02:52:41 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 02:52:41 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 02:52:41 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 02:52:41 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 02:52:41 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 02:52:42 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:42 INFO - warning: no files found matching '*.txt' 02:52:42 INFO - no previously-included directories found matching 'build' 02:52:42 INFO - no previously-included directories found matching 'dist' 02:52:42 INFO - no previously-included directories found matching '.git*' 02:52:42 INFO - Installing collected packages: jsonschema, functools32 02:52:42 INFO - Running setup.py install for functools32 02:52:42 INFO - warning: no files found matching '*.txt' 02:52:42 INFO - no previously-included directories found matching 'build' 02:52:42 INFO - no previously-included directories found matching 'dist' 02:52:42 INFO - no previously-included directories found matching '.git*' 02:52:42 INFO - Successfully installed jsonschema functools32 02:52:42 INFO - Cleaning up... 02:52:42 INFO - Return code: 0 02:52:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:42 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1f8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e208420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8794a8380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, '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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 02:52:42 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', 'flake8'] in /builds/slave/test/build 02:52:42 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 flake8 02:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:42 INFO - 'HOME': '/Users/cltbld', 02:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:42 INFO - 'LOGNAME': 'cltbld', 02:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:42 INFO - 'MOZ_NO_REMOTE': '1', 02:52:42 INFO - 'NO_EM_RESTART': '1', 02:52:42 INFO - 'PAGER': '/bin/cat', 02:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:42 INFO - 'PWD': '/builds/slave/test', 02:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:42 INFO - 'SHELL': '/bin/bash', 02:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:52:42 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:42 INFO - 'USER': 'cltbld', 02:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:42 INFO - 'XPC_FLAGS': '0x0', 02:52:42 INFO - 'XPC_SERVICE_NAME': '0', 02:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:42 INFO - Downloading/unpacking flake8 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:42 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 02:52:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:52:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:52:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52: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 02:52:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:52:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:46 INFO - no previously-included directories found matching 'docs/_build' 02:52:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:52:46 INFO - Running setup.py install for pep8 02:52:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:52:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:52:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:52:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:52:46 INFO - no previously-included directories found matching 'docs/_build' 02:52:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:52:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:52:46 INFO - Cleaning up... 02:52:46 INFO - Return code: 0 02:52:46 INFO - Running post-action listener: _resource_record_post_action 02:52:46 INFO - Running post-action listener: _start_resource_monitoring 02:52:46 INFO - Starting resource monitoring. 02:52:46 INFO - ##### 02:52:46 INFO - ##### Running install step. 02:52:46 INFO - ##### 02:52:46 INFO - Running pre-action listener: _resource_record_pre_action 02:52:46 INFO - Running main action method: install 02:52:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:47 INFO - Reading from file tmpfile_stdout 02:52:47 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:47 INFO - Reading from file tmpfile_stdout 02:52:47 INFO - Output received: 02:52:47 INFO - Usage: mozinstall [options] installer 02:52:47 INFO - Options: 02:52:47 INFO - -h, --help show this help message and exit 02:52:47 INFO - -d DEST, --destination=DEST 02:52:47 INFO - Directory to install application into. [default: 02:52:47 INFO - "/builds/slave/test"] 02:52:47 INFO - --app=APP Application being installed. [default: firefox] 02:52:47 INFO - mkdir: /builds/slave/test/build/application 02:52:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:18 INFO - Reading from file tmpfile_stdout 02:53:18 INFO - Output received: 02:53:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:53:18 INFO - Running post-action listener: _resource_record_post_action 02:53:18 INFO - ##### 02:53:18 INFO - ##### Running run-tests step. 02:53:18 INFO - ##### 02:53:18 INFO - Running pre-action listener: _resource_record_pre_action 02:53:18 INFO - Running main action method: run_tests 02:53:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:18 INFO - 2016-04-30 02:53:18.905 screenresolution[1645:9272] starting screenresolution argv=screenresolution get 02:53:18 INFO - 2016-04-30 02:53:18.908 screenresolution[1645:9272] Display 0: 1600x1200x32@60 02:53:18 INFO - 2016-04-30 02:53:18.914 screenresolution[1646:9275] starting screenresolution argv=screenresolution list 02:53:18 INFO - Available Modes on Display 0 02:53:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:19 INFO - Intel Iris: 02:53:19 INFO - Chipset Model: Intel Iris 02:53:19 INFO - Type: GPU 02:53:19 INFO - Bus: Built-In 02:53:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:19 INFO - Vendor: Intel (0x8086) 02:53:19 INFO - Device ID: 0x0a2e 02:53:19 INFO - Revision ID: 0x0009 02:53:19 INFO - Displays: 02:53:19 INFO - Display: 02:53:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:19 INFO - Display Serial Number: 1600x1200 60 02:53:19 INFO - Main Display: Yes 02:53:19 INFO - Mirror: Off 02:53:19 INFO - Online: Yes 02:53:19 INFO - Rotation: Supported 02:53:19 INFO - Return code: 0 02:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:19 INFO - Python 2.7.3 02:53:19 INFO - Return code: 0 02:53:19 INFO - grabbing minidump binary from tooltool 02:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:19 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e097e00>, '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 0x10df00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e092b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:19 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 02:53:19 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 02:53:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:19 INFO - Return code: 0 02:53:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:53:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:53:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:53:20 INFO - Return code: 0 02:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 02:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --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 02:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qX1MdCsoHz/Render', 02:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:20 INFO - 'HOME': '/Users/cltbld', 02:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:20 INFO - 'LOGNAME': 'cltbld', 02:53:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:20 INFO - 'MOZ_NO_REMOTE': '1', 02:53:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:20 INFO - 'NO_EM_RESTART': '1', 02:53:20 INFO - 'PAGER': '/bin/cat', 02:53:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:20 INFO - 'PWD': '/builds/slave/test', 02:53:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:20 INFO - 'SHELL': '/bin/bash', 02:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Js8XpRlKl5/Listeners', 02:53:20 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 02:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:20 INFO - 'USER': 'cltbld', 02:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:20 INFO - 'XPC_FLAGS': '0x0', 02:53:20 INFO - 'XPC_SERVICE_NAME': '0', 02:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--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 02:53:20 INFO - mozversion application_buildid: 20160430004057 02:53:20 INFO - mozversion application_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 02:53:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:53:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:20 INFO - mozversion application_name: Firefox 02:53:20 INFO - mozversion application_remotingname: firefox-dev 02:53:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:20 INFO - mozversion application_vendor: Mozilla 02:53:20 INFO - mozversion application_version: 48.0a2 02:53:20 INFO - mozversion platform_buildid: 20160430004057 02:53:20 INFO - mozversion platform_changeset: 1347c189b6da67d2142fb266c82f74272b09139b 02:53:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:20 INFO - mozversion platform_version: 48.0a2 02:53:20 INFO - using testdate: 1462010000 02:53:20 INFO - actual date: 1462010000 02:53:20 INFO - starting webserver on 'localhost:49273' 02:53:20 INFO - SUITE-START | Running 2 tests 02:53:20 INFO - TEST-START | dromaeo_css 02:53:20 INFO - operating with platform_type : mac_ 02:53:20 INFO - Initialising browser for dromaeo_css test... 02:53:20 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4fpIxs/profile http://localhost:49273/getInfo.html) 02:53:23 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 02:53:23 INFO - PROCESS | 1664 | colorDepth:24 02:53:23 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 02:53:23 INFO - PROCESS | 1664 | __metrics 02:53:23 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:53:24 INFO - TEST-INFO | 1664: exit 0 02:53:24 INFO - Browser initialized. 02:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:24 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4fpIxs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:36 INFO - PROCESS | 1669 | RSS: Main: 221483008 02:53:36 INFO - PROCESS | 1669 | 02:54:25 INFO - PROCESS | 1669 | 1462010065948 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:56:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 02:56:38 INFO - PROCESS | 1669 | RSS: Main: 235315200 02:56:38 INFO - PROCESS | 1669 | 02:59:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 02:59:40 INFO - PROCESS | 1669 | RSS: Main: 247201792 02:59:40 INFO - PROCESS | 1669 | 03:02:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:02:43 INFO - PROCESS | 1669 | RSS: Main: 248414208 03:02:43 INFO - PROCESS | 1669 | 03:05:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:05:45 INFO - PROCESS | 1669 | RSS: Main: 250142720 03:05:45 INFO - PROCESS | 1669 | 03:08:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 03:08:48 INFO - PROCESS | 1669 | RSS: Main: 252985344 03:08:48 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 03:11:51 INFO - PROCESS | 1669 | RSS: Main: 254218240 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | __start_tp_report 03:11:51 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 03:11:51 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 03:11:51 INFO - PROCESS | 1669 | |i|pagename|runs| 03:11:51 INFO - PROCESS | 1669 | |0;dojo.html;3444.6210916799146;3469.705075068619;3486.877959271426;3505.983264853193;3538.9292214155716;5811.360750317473;5825.708714564265;5839.124131380289;5857.6778277194735;5876.294844618641;5768.884622307562;5789.797357092502;5799.449052340032;5814.592978491507;5822.3886491918265;5189.636725429222;5206.349206349207;5276.15581506959;5280.577553795687;5289.68261904285;4509.25597276449;4568.977155114237;5144.25408315794;5279.049771041211;5400.675959442427;4007.9799601001955;4425.734455932655;5235.450277720842;5246.580273578104;5255.921161182585;5235.869103272411;5265.763040663161;5276.287701160332;5301.072312345363;5306.257124002643;4643.419572553431;4956.801727930879;5109.233614957749;5210.192420174879;5270.367555893279;5537.778488860441;5615.46653067962;5650.3219613646215;5731.910936922013;5890.617109887844;6133.264008318985;6140.263168419819;6155.599886007395;6169.259688837324;6240.251169859601;6156.015037594008;6175.536834737368;6176.4132407421675;6177.752889884399;6179.38206179383;5707.771689132472;5762.1068734346245;5764.74058667361;5886.0863872383015;5895.64626122434;6259.655718935503;6303.401176888188;6310.116583678288;6314.810555683337;6328.303886572473;6152.3540028297275;6160.784372546939;6171.352008039181;6180.351063138306;6186.505079593621;6106.877862442726;6120.9957324329725;6182.350853160354;6195.938040619626;6207.348228435949;6132.7546898124465;6187.133801267826;6211.534134939898;6220.315765265817;6242.094896240111;6194.101855230966;6205.410486003822;6214.40963108504;6227.377262273827;6239.407256310643;4727.078219747185;4937.975310123426;4982.950170498321;4996.150654388763;5028.346314979102;4330.28550289205;4367.301231802896;4378;4396.164728701537;4399.23013472641;5637.746301416446;5667.291588551431;5669.291338582677;5684.573656975661;5694.829155125353;6115.449898208542;6166.229221347332;6167.506599472032;6175.536834737412;6217.036359364215;5804.970975145182;5813.5349172066135;5818.4763371296785;5833.88332233353;5863.882722345529;5271.499207575274;5391.541718953933;5400.648957817729;5425.321834770653;5439.918401223985;5714.457126572969;6382.20222472191;6468.2561505427475;6477.902831457532;6491.058796474579;6183.0107182850525;6208.441240288395;6209.627422354673;6209.782657607143;6221.564490485623;6243.937560624336;6303.086052522451;6339.96830015847;6392.488600911823;6461.547691661539;6126.24286675468;6176.969115154396;6201.6899155041165;6213.689315534296;6226.750929962751;6191.9690401547705;6193.969030154821;6211.937880621136;6222.533310001678;6235.3452887446165;6036.336003039574;6126.540509461719;6153.3538978408415;6216.72024758896;6234.844128896814;6162.630242185483;6176.227971503562;6193.287771906108;6194.783182588588;6214.1921550198185;4147.79261036953;5985.50083725469;6043.033114701627;6052.788152414644;6093.238345206849;5903.380145084704;5964.850878728066;5974.641521508724;6092.969535152296;6146.877062458636;5953.6725480097275;6078.088286757022;6087.756489740361;6117.663528505975;6120.660465672209 03:11:51 INFO - PROCESS | 1669 | |1;ext.html;517.8817025584968;522.3340241192479;574.414097620427;593.1932571702481;613.7023543581364;36829.263414731686;38063.619363806356;38106.85679429618;38107.618923810754;38154.23691526168;39480;39586;39807.60192398075;40406.59593404065;40512.392314115314;9566.665166719165;9774.218062554979;9816.656417025406;9827.754306142333;9860.90139098607;9628.95185524075;9743.658971935984;9753.561089750943;9779.657711980082;9788.461634610094;9708.90291097087;9799.853002204936;9804.70585882421;9808.558614862348;9812.950935245313;8616.439931404439;9350;9390.497520396772;9710.951445242765;9813.509324533816;9552.856707149398;9648.421094734269;9666.75833104171;9698.030196980317;9709.36889102206;29323.120306390843;38884.61115388866;39536.01159970995;39587.60412395868;41569.58430415687;3112.439760843047;3273.672632736731;3308.768386212966;3353.446681297583;3810.161764411825;28313;28810.855945720137;29078.854605727047;29108.126756197347;29805.40389192226;1965.6068786242809;2758.613794068832;2778.097118436516;2780.638516992798;2824.9152525424065;499380;503183;505801;507765;511521;27867.30331741682;33425.66574334226;58923;59127.11309330363;59301.703491482265;28198.85900570525;35143.824280878434;35273;35444;35495.82252088723;15386.307616157075;15590.14254216029;15594.29825657848;15632.609184770472;15633;13094.14888032275;13147.408366623526;13235.867641323655;13241.73516529664;13400.530981415604;7102.14774227096;7833.2166783322355;8042.919570804217;8166.9591652042545;8254.54599997006;3408.3864904316965;3455.2571197192224;3457.5159477673146;3461.3077384522694;3489.197484578561;887.6493784954906;998.1665309466676;1010.3281317923498;1021.5862575656871;1048.130052056791;29923.803047878275;30092;30112.397752044835;30119.849400752857;30167.245818854266;1103.3435106111851;1127.3686735428187;1135.7558125003163;1168.5851522709486;1189.0903458853984;12238.653748087703;14219.64450888736;14280.357383917748;15009.624759380884;15769.369225230863;603687;615692;681300;683409;686924;60196;60486.39513604896;60866.08700869491;61089.69455152785;61401.69299153565;1499.587613406322;1508.7284288827898;1511.1386509689592;1512.7730840374031;1518.7342215112533;25664.973401063748;29240;30221.546676800306;30346.69653303527;30715.539266911463;51155;51892.48107518876;51979.74010130076;52080;52173;598012.0099399475;608558;609374;613742;614868;25962.610560841982;26194.476110478066;26242.868785655948;26302.473950521264;26390.86804565965;36478.635213647525;42467.15065698607;43874.561254388325;44768.55231447774;44884.77557612191;33022;35277;37044.81477592703;37310.06724831901;38125.428118577685;36460.45309320309;36565.634343656224;36739.89780306595;37013.62986370102;37072.258554828215;35984.64015359813;36207;36471.81764091269;36680.26639467249;37267.254654907294;32333.51499727553;32464.67535324711;32691;32702;32941;24450.388740281636;24583.385415364042;24683.62974555419;24918.626220606344;24935.625965610892 03:11:51 INFO - PROCESS | 1669 | |2;jquery.html;354.2578298464716;398.1519363755203;401.7950845069014;402.92545879012374;414.99792501037507;16107;20424.080916358762;20849.37451876446;20877.47806304843;21761.455963600918;20364;20422.795772042275;20702.896485517587;22140.66788998162;22202.88985550724;5716.885207384551;6112.144299798032;6147.0164773636225;6148.415900489446;6154.692265386735;5698.1452782082815;6025.728842202111;6051.3041000284875;6098.329183789801;6116.296625888035;5945.316288626798;6012.8496787580225;6058.545609079337;6064.878702425949;6069.393060693939;5781.392953739839;6066.545009124334;6109.725062372204;6114.724837382284;6129.877402451971;5732.484076433141;5830.795922142747;5910.734016969247;5949.970250148722;5978.760849566012;10312.587496500131;10983.011528962432;13673;13762.724745505035;13779.862201377959;1976.0811222781476;2077.1483691686485;2123.150739704115;2137.4801901743294;2158.201465457775;9055.59249833759;9706.272029597809;10076.294659373847;10229.386236825814;10246.436445995467;1682.4363838114245;1702.0978881192987;1707.4024091567976;1722.6726921884801;1723.5260303416535;123732;125510.37244813809;129418.99999999905;129934.70065299321;132322.676773232;11731.413429328499;11762.411879405996;11809.996150327146;11829.408529573488;11894.286342819285;15288.541343759705;15389.923050384676;15399.769003464957;15418.922905385401;15450.922745386426;9044.954775226082;9051.054023384871;9054.275657947348;9056.456612603264;9171.266298696088;8965;9067.591958361889;9121.543922803834;9129.726108216764;9164.816703665889;3886.825092870771;4083.8156934488666;4696.5303469653445;4711.599514041345;4748.715077095385;1548.1485183149448;1670.607407259293;1742.5208067781462;1783.7591925089946;1928.1708865187823;817.2236375443234;838.0781140745254;1000.1798525209404;1042.5673345561506;1049.9265051446478;19120.426387208405;19635.803641963397;20028.799712002692;21471.78528214729;21482.24812131599;976.4585974594149;979.221518892468;987.9950600247097;1031.041131747467;1074.5433190893839;10746.408947507962;10923.071538919281;11262.493187806405;11281;11285.887141128647;573622;574179;576470;576503;603069;132853;139625;141071;141977;145556.27221863822;447.2821122098984;472.62190247801624;473.3633263260909;484.25183092122757;486.23418116466706;10467.685969420929;10808.729781755519;11208.215424920178;11392.601258955896;11415.429228538706;48768.756156218995;49206;49778.75110624568;49820.50179498159;52109.7394513025;76730.23269767454;76762.23237767775;76821.61589192018;77099.61450192938;79641.4071718574;8247.257746802816;8262.42163048581;8309.961254843145;8322.667093316442;8631.180037896389;10689.198310126616;11525.82711259315;12725.490980360682;12835.486580536674;12886.613401597968;6608.768693095719;8444.788880278042;11059.336439813636;11206.551737930391;11248.26886252391;11220.326780392876;11278.718032049264;11333.773324533298;11454.198206125491;11633.6509904703;11504.079673625922;11791.35147566892;11874.287542747463;11911.642650720492;11964.282143071443;8444.071152173134;8489.193526614961;8614.82770344602;8632.093630168993;8750.431221970552;9481.573329200064;10186.949065254626;11197.160212984221;11492.655220343404;11494.94252528732 03:11:51 INFO - PROCESS | 1669 | |3;mootools.html;1599.6480774229672;1633.4609578838977;1634.207409406438;1709.2479309104;1954.110879549805;8145.91854081459;8701.52006678097;8775.517346545937;9157.40476869003;9194.172524472797;8781.736547903558;8855.822883542325;8933.508657023862;8947.373683842134;8962.283017358612;2483.2053742802264;2517.2825744662773;2521.00420333968;2533;2535.987320063397;2477.7893879020303;2521.2940376694555;2530.101813856082;2530.772230499255;2539.923802285925;2325.9651105233434;2329.8252631052737;2339;2341.2976107167865;2343.250159948817;2058.7735349111585;2132.2963422070757;2458.385403649088;2486.0925762096886;2504.4114633061217;2445.1075357494565;2469.703635563744;2475.504899020203;2480.987595062013;2481.0819996601194;9078.727638170865;9123.863142052875;9159.084091590854;9174.954125229398;9192;5333.35999680037;5551.528120109796;5560.916586251209;5563.276774019392;5565.276514053147;3566.465030245458;3569.250457403922;3580.427131658922;3638.8180590970346;3677.8528858845616;877.5173654490069;1000.8899021107673;1053.394298278493;1055.3667799320424;1089.591403223791;12014.63956081319;12164.14850960433;12206.877931220663;12225.388730563525;12247.081468889779;4892.902141957141;4904.558589726942;4949.158643030693;4956.578690811321;4976.154053810788;10265.846012309821;10299.897001030044;10322.690319290434;10336.018078282701;10375.429351385746;5409.97210529998;5487.98472282629;5504.834854954358;5506;5527.834164975057;4459.44256967879;4838.129136755418;4939.036887806915;4961.231009193581;4977.203647416396;4098.672106231495;4126.0041988101375;4141.7722025288895;4159;4191.203671302443;1200.1838749650146;1239.8822111899535;1248.3259040118417;1345.616499297715;1358.877701006914;836.3267569606404;851.3104385447807;863.7883718489011;934.6868798952427;947.7062110745691;5712.314867114212;5855.121731740188;5860.208871802337;6081.422264884829;6094.603850749687;927.0497739816742;985.935914165577;992.3995982430525;1010.934289271195;1032.7056788815153;4020.557738648805;4088.7546747195265;4092.7544347339253;4105.91788164235;4124.8143833527565;10544.578216871392;11083.667489975314;11106.722331941766;11126.221164518405;11221.775564488828;10986.780264394827;11041.503132359063;11088.778224435466;11106.278091924161;11125.944370278097;7916.762497125095;8344.62449189788;8352.8329433411;8429.114942930904;8491.91508084936;5957.434043765836;6015.849603759941;6097.390260973867;6171.783987560593;6214.316425193316;9649.758756031155;9855;10129.442880641636;10169.44068076263;10280.640177593748;10280.537375817956;10390.22073344487;10490.423026733602;10516.316439431412;10599.682009539727;7064.929350706633;7518.36093932;7692.7692169235015;7752.4573279869865;7880.014998125234;8445.831083378174;8500.022497412876;8539.786505337417;8541.01778295504;8552.144785521397;7362.7423040193335;7523.473356864967;7548.358389536951;7599.316061554487;7629.46593738433;7294.598797066213;7410.518316309638;7415.3326200642205;7460.888086678813;7521.247875212435;7161.176464706626;7220.133583969957;7234.5659260444545;7278.417726581966;7284.9635751823025;4297.333913243452;4968.006398720343;4979.960519231827;5106.438291787826;5143.768530416215;5059.822906198266;5073.8731531712;5113.51421614946;5208.9739551302;5339.866503337447 03:11:51 INFO - PROCESS | 1669 | |4;prototype.html;318.46656849776633;319.71066185102484;329.58801498127343;329.63410614218213;329.77410473825415;5252.343457067866;5358.571314294847;5360.463953604638;5507.063799154143;5548.03044919054;5426.375966763823;5429.592780541465;5437.954745342611;5438.646487978279;5439.619226654136;3788.920157755047;3909.2767837949928;4172.645325147366;4175.478065241845;4190.182914331706;3696.796676182809;3871.477350557681;4182.393552934823;4187.371894215861;4198.349255865346;4079.9192411870013;4093.6725061995116;4116.34138537834;4126.814293356806;4134.712903241915;3296.2583418730833;3422.9046705054393;4107.938380924274;4108.979455102721;4143.233501802176;3338.6995170434534;3388.373150967079;3574.1422058705725;3583.802890841003;3607.026102952188;4483.3723278741;4505.797239124247;4776.952230477686;5037.949620503785;5315.229291752674;4717.985633088902;4730.976345118287;4762.452317983407;4774.7135171889795;4776.331313616097;5782.161586569966;5782.739776710058;5788.305403351625;5793.536517078665;5799.623024503436;3794.2411517696296;3938.4879965604573;3953.150072734376;3967.1867267210155;3976.9005774855573;5359.892802143974;5372.355317361902;5652.34997975234;6047.701873288166;6146.262448506208;3710.350688629479;3997.9000524986527;4005.118873847749;4006.1386801837743;4018.3771515415156;3721.3115573618966;3923.2938071146896;3963.4344433948427;4042.130941847517;4045.1707399982934;4679.672422930362;4706.694064885772;4712.835050773207;4724.551167639138;4728.1087564973595;4631.768411579407;5821.602815324376;5828.708564571839;5839.299284085937;5854.2389489366105;1431.1842249917656;1476.3799204334205;1477.231839443505;1477.697072100217;1479.0534058202759;870.7083127152475;944.0182210501139;947.7726344384039;974.9122578967927;978.2516374973151;5324;5668.348139963874;5693.089105743061;5721.940101563434;5827.504662103769;5134.48655134491;5645.774169033275;6485.221773387129;6498.252700939358;6521.315261897433;5576.804811831566;5733.8566535836935;5791.073428251544;5791.189233507313;5800.24596802413;3372.173817414749;3406.8416738308597;3407.6421975692692;3408.556887604645;3431.4681224410256;5888.381719919346;6372.299047104815;6747.426468750113;6755.527113102134;6785.9660701696175;6193.225846769154;6218.284897236876;6240.7503699852405;6247.845182953376;6280.246370435577;5312.7343632818975;5336.17289320156;5826.621269617462;6254.405831446005;6307.905381419374;4618.51505591908;4876.073546026244;5511.448855114457;5678.602497825278;5970.313413957277;5426.860359324586;5567;5940;5967.49276311501;6043.667598282137;4762.3570817939135;5246.606504512253;5701.372848986525;6113.755449782137;6228.5951413158;3599.6141485528783;3956.723029387915;3976.423418604228;3991.980040099781;4036.616521430459;5234.345706786652;5728.684922329312;5756.611006432284;5799.130130480462;6098.603590766586;5614.9612321720615;5663.235463212413;5840.591158618856;5862.7654893805475;5889.348603865631;5839.649621022752;5853.473187413153;5883.411658834082;5883.558733094949;5922.822315330547;4958.231474121517;5091.363579552556;5216.452272511332;5572.609917305912;5702.857428564319;5836.212111364912;5840.269966254218;5848.883022339614;5867.911981320198;5883.29400471929;4471.8434854779925;4834.6374021947795;5667.688277144796;5699.772009119589;5728.388647139093 03:11:51 INFO - PROCESS | 1669 | |5;yui.html;656.4518626946499;674.4435840431644;745.2286883076017;749.194615788028;768.1243382543897;14769;14859.925700371496;14892.553223403302;15073.472428465006;15189.164595947219;13721.519746808839;13800.723985520284;13910.652233694163;13925.09486883352;13937.303134843269;735.2133217457323;908.8000639859254;918.9586468608912;942.5381563034133;946.9195118414943;901.4366021236694;919.4115765909823;931.7065124485765;939.1453777062874;941.3833938770082;943.6791490893095;948.2271948362097;989.6684610655439;990.1336330710628;995.0348162282575;961.903809619036;966.4732720667218;978.9510524473748;984.655370620288;984.8473486609587;701.7614011236153;725.8983742276085;729.9744508942161;735.4337160386526;737.181728281607;14821.184834834079;14852.331645075998;14923.850761492355;14926.029808062442;14941.402343906231;12507.624771256786;12684.42920068599;12691.74616507674;12790.424430900632;12929.676758081123;8440.746777596682;9942.304038717293;9974.601015959426;10011.549480273332;10126.746831329203;3486.808225547594;3531.2760884018717;3570.982145089284;3588.9592018314656;3609.7653652512504;57134.428655713746;71440.6427967862;77822.61088694577;78257.21742782614;78503.21496785016;7941.682332706627;9296.023917488701;9428.292878034037;9485.288603354638;9573.521323933775;16790.580235493966;20383.490412739502;20774.688379674317;20783.584328313653;21369.931503424767;7421.591812450367;7489.700411983568;7493.3256006958545;7608.80977975544;7694.846103078019;3295.2585668224456;3787.8636409077167;3886.455896174538;3935.5474120475938;3963.286608410456;3632.4551317302617;3696.353138200804;3714.9969508232625;3736.3461394255896;3739.607341229186;548.8638518267228;627.1188979483833;647.543481845298;653.996115961996;654.1365397675023;528.2577977940999;585.5813093637984;589.8201048680108;591.2550186764621;623.1400667079402;8129.227723366389;8155.062167850654;8242.505449673039;8243.216894395024;8391.244787969112;565.5503874419846;578.9636550574509;587.2102022779355;595.6098755315276;634.7651368993502;3814.732968692165;3871.2064026874423;3917.1578110705764;3950.2692001979726;4111.48606424197;99510;101203;103057;103484;106165.46917265364;65642.68714625681;83904;83995;84357;85910.14089859021;72901.6354918222;74867.1283217913;75034.24965750273;75419;75511;7339.302766237199;7422.480426370103;7746.109197442366;8004.279614834692;8283.792905177419;38475.615243847205;41908.16183676248;42678.14643707171;44245.778771105935;46163.76918115388;60426;60917.78164436775;62969.68515157395;63217.419564511256;63540.682296588224;10683.94658026705;11123.777524449304;11212.719682008015;11241.988221059817;11624.767504650028;11918.582849600223;11959.940200298943;11981.820272696092;12142.635720928387;12215.26708397499;10967.616133435291;11049.558017679203;11102.555897764321;11223.10215182767;12188.634340969786;9576.760580985252;10905.945470272598;11397.202195846543;11456.140789440658;11524.423778810858;10782.353058816496;10870.945645271722;11119.610813621484;11144.60993865211;11304.83042754343;9145.222656074307;9396.718098457057;9400.623975040922;9708.514574271117;9729.961209622494;8878.955605221932;9245.214156796748;9614.663486777928;9645.276604254568;9729.22166226686 03:11:51 INFO - PROCESS | 1669 | __end_tp_report 03:11:51 INFO - PROCESS | 1669 | __start_cc_report 03:11:51 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,416 03:11:51 INFO - PROCESS | 1669 | __end_cc_report 03:11:51 INFO - PROCESS | 1669 | __startTimestamp1462011111463__endTimestamp 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | ------- Summary: start ------- 03:11:51 INFO - PROCESS | 1669 | Number of tests: 6 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5730.47 Median:6036.34 stddev:672.78 (11.1%) stddev-sans-first:650.51 03:11:51 INFO - PROCESS | 1669 | Values: 3444.6 3469.7 3486.9 3506.0 3538.9 5811.4 5825.7 5839.1 5857.7 5876.3 5768.9 5789.8 5799.4 5814.6 5822.4 5189.6 5206.3 5276.2 5280.6 5289.7 4509.3 4569.0 5144.3 5279.0 5400.7 4008.0 4425.7 5235.5 5246.6 5255.9 5235.9 5265.8 5276.3 5301.1 5306.3 4643.4 4956.8 5109.2 5210.2 5270.4 5537.8 5615.5 5650.3 5731.9 5890.6 6133.3 6140.3 6155.6 6169.3 6240.3 6156.0 6175.5 6176.4 6177.8 6179.4 5707.8 5762.1 5764.7 5886.1 5895.6 6259.7 6303.4 6310.1 6314.8 6328.3 6152.4 6160.8 6171.4 6180.4 6186.5 6106.9 6121.0 6182.4 6195.9 6207.3 6132.8 6187.1 6211.5 6220.3 6242.1 6194.1 6205.4 6214.4 6227.4 6239.4 4727.1 4938.0 4983.0 4996.2 5028.3 4330.3 4367.3 4378.0 4396.2 4399.2 5637.7 5667.3 5669.3 5684.6 5694.8 6115.4 6166.2 6167.5 6175.5 6217.0 5805.0 5813.5 5818.5 5833.9 5863.9 5271.5 5391.5 5400.6 5425.3 5439.9 5714.5 6382.2 6468.3 6477.9 6491.1 6183.0 6208.4 6209.6 6209.8 6221.6 6243.9 6303.1 6340.0 6392.5 6461.5 6126.2 6177.0 6201.7 6213.7 6226.8 6192.0 6194.0 6211.9 6222.5 6235.3 6036.3 6126.5 6153.4 6216.7 6234.8 6162.6 6176.2 6193.3 6194.8 6214.2 4147.8 5985.5 6043.0 6052.8 6093.2 5903.4 5964.9 5974.6 6093.0 6146.9 5953.7 6078.1 6087.8 6117.7 6120.7 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:69870.73 Median:36921.45 stddev:159119.57 (431.0%) stddev-sans-first:159480.74 03:11:51 INFO - PROCESS | 1669 | Values: 517.9 522.3 574.4 593.2 613.7 36829.3 38063.6 38106.9 38107.6 38154.2 39480.0 39586.0 39807.6 40406.6 40512.4 9566.7 9774.2 9816.7 9827.8 9860.9 9629.0 9743.7 9753.6 9779.7 9788.5 9708.9 9799.9 9804.7 9808.6 9813.0 8616.4 9350.0 9390.5 9711.0 9813.5 9552.9 9648.4 9666.8 9698.0 9709.4 29323.1 38884.6 39536.0 39587.6 41569.6 3112.4 3273.7 3308.8 3353.4 3810.2 28313.0 28810.9 29078.9 29108.1 29805.4 1965.6 2758.6 2778.1 2780.6 2824.9 499380.0 503183.0 505801.0 507765.0 511521.0 27867.3 33425.7 58923.0 59127.1 59301.7 28198.9 35143.8 35273.0 35444.0 35495.8 15386.3 15590.1 15594.3 15632.6 15633.0 13094.1 13147.4 13235.9 13241.7 13400.5 7102.1 7833.2 8042.9 8167.0 8254.5 3408.4 3455.3 3457.5 3461.3 3489.2 887.6 998.2 1010.3 1021.6 1048.1 29923.8 30092.0 30112.4 30119.8 30167.2 1103.3 1127.4 1135.8 1168.6 1189.1 12238.7 14219.6 14280.4 15009.6 15769.4 603687.0 615692.0 681300.0 683409.0 686924.0 60196.0 60486.4 60866.1 61089.7 61401.7 1499.6 1508.7 1511.1 1512.8 1518.7 25665.0 29240.0 30221.5 30346.7 30715.5 51155.0 51892.5 51979.7 52080.0 52173.0 598012.0 608558.0 609374.0 613742.0 614868.0 25962.6 26194.5 26242.9 26302.5 26390.9 36478.6 42467.2 43874.6 44768.6 44884.8 33022.0 35277.0 37044.8 37310.1 38125.4 36460.5 36565.6 36739.9 37013.6 37072.3 35984.6 36207.0 36471.8 36680.3 37267.3 32333.5 32464.7 32691.0 32702.0 32941.0 24450.4 24583.4 24683.6 24918.6 24935.6 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34540.65 Median:11820.22 stddev:97793.24 (827.3%) stddev-sans-first:98033.89 03:11:51 INFO - PROCESS | 1669 | Values: 354.3 398.2 401.8 402.9 415.0 16107.0 20424.1 20849.4 20877.5 21761.5 20364.0 20422.8 20702.9 22140.7 22202.9 5716.9 6112.1 6147.0 6148.4 6154.7 5698.1 6025.7 6051.3 6098.3 6116.3 5945.3 6012.8 6058.5 6064.9 6069.4 5781.4 6066.5 6109.7 6114.7 6129.9 5732.5 5830.8 5910.7 5950.0 5978.8 10312.6 10983.0 13673.0 13762.7 13779.9 1976.1 2077.1 2123.2 2137.5 2158.2 9055.6 9706.3 10076.3 10229.4 10246.4 1682.4 1702.1 1707.4 1722.7 1723.5 123732.0 125510.4 129419.0 129934.7 132322.7 11731.4 11762.4 11810.0 11829.4 11894.3 15288.5 15389.9 15399.8 15418.9 15450.9 9045.0 9051.1 9054.3 9056.5 9171.3 8965.0 9067.6 9121.5 9129.7 9164.8 3886.8 4083.8 4696.5 4711.6 4748.7 1548.1 1670.6 1742.5 1783.8 1928.2 817.2 838.1 1000.2 1042.6 1049.9 19120.4 19635.8 20028.8 21471.8 21482.2 976.5 979.2 988.0 1031.0 1074.5 10746.4 10923.1 11262.5 11281.0 11285.9 573622.0 574179.0 576470.0 576503.0 603069.0 132853.0 139625.0 141071.0 141977.0 145556.3 447.3 472.6 473.4 484.3 486.2 10467.7 10808.7 11208.2 11392.6 11415.4 48768.8 49206.0 49778.8 49820.5 52109.7 76730.2 76762.2 76821.6 77099.6 79641.4 8247.3 8262.4 8310.0 8322.7 8631.2 10689.2 11525.8 12725.5 12835.5 12886.6 6608.8 8444.8 11059.3 11206.6 11248.3 11220.3 11278.7 11333.8 11454.2 11633.7 11504.1 11791.4 11874.3 11911.6 11964.3 8444.1 8489.2 8614.8 8632.1 8750.4 9481.6 10186.9 11197.2 11492.7 11494.9 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5866.93 Median:4952.87 stddev:3292.00 (66.5%) stddev-sans-first:3285.62 03:11:51 INFO - PROCESS | 1669 | Values: 1599.6 1633.5 1634.2 1709.2 1954.1 8145.9 8701.5 8775.5 9157.4 9194.2 8781.7 8855.8 8933.5 8947.4 8962.3 2483.2 2517.3 2521.0 2533.0 2536.0 2477.8 2521.3 2530.1 2530.8 2539.9 2326.0 2329.8 2339.0 2341.3 2343.3 2058.8 2132.3 2458.4 2486.1 2504.4 2445.1 2469.7 2475.5 2481.0 2481.1 9078.7 9123.9 9159.1 9175.0 9192.0 5333.4 5551.5 5560.9 5563.3 5565.3 3566.5 3569.3 3580.4 3638.8 3677.9 877.5 1000.9 1053.4 1055.4 1089.6 12014.6 12164.1 12206.9 12225.4 12247.1 4892.9 4904.6 4949.2 4956.6 4976.2 10265.8 10299.9 10322.7 10336.0 10375.4 5410.0 5488.0 5504.8 5506.0 5527.8 4459.4 4838.1 4939.0 4961.2 4977.2 4098.7 4126.0 4141.8 4159.0 4191.2 1200.2 1239.9 1248.3 1345.6 1358.9 836.3 851.3 863.8 934.7 947.7 5712.3 5855.1 5860.2 6081.4 6094.6 927.0 985.9 992.4 1010.9 1032.7 4020.6 4088.8 4092.8 4105.9 4124.8 10544.6 11083.7 11106.7 11126.2 11221.8 10986.8 11041.5 11088.8 11106.3 11125.9 7916.8 8344.6 8352.8 8429.1 8491.9 5957.4 6015.8 6097.4 6171.8 6214.3 9649.8 9855.0 10129.4 10169.4 10280.6 10280.5 10390.2 10490.4 10516.3 10599.7 7064.9 7518.4 7692.8 7752.5 7880.0 8445.8 8500.0 8539.8 8541.0 8552.1 7362.7 7523.5 7548.4 7599.3 7629.5 7294.6 7410.5 7415.3 7460.9 7521.2 7161.2 7220.1 7234.6 7278.4 7285.0 4297.3 4968.0 4980.0 5106.4 5143.8 5059.8 5073.9 5113.5 5209.0 5339.9 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4726.05 Median:5347.37 stddev:1461.05 (27.3%) stddev-sans-first:1427.20 03:11:51 INFO - PROCESS | 1669 | Values: 318.5 319.7 329.6 329.6 329.8 5252.3 5358.6 5360.5 5507.1 5548.0 5426.4 5429.6 5438.0 5438.6 5439.6 3788.9 3909.3 4172.6 4175.5 4190.2 3696.8 3871.5 4182.4 4187.4 4198.3 4079.9 4093.7 4116.3 4126.8 4134.7 3296.3 3422.9 4107.9 4109.0 4143.2 3338.7 3388.4 3574.1 3583.8 3607.0 4483.4 4505.8 4777.0 5037.9 5315.2 4718.0 4731.0 4762.5 4774.7 4776.3 5782.2 5782.7 5788.3 5793.5 5799.6 3794.2 3938.5 3953.2 3967.2 3976.9 5359.9 5372.4 5652.3 6047.7 6146.3 3710.4 3997.9 4005.1 4006.1 4018.4 3721.3 3923.3 3963.4 4042.1 4045.2 4679.7 4706.7 4712.8 4724.6 4728.1 4631.8 5821.6 5828.7 5839.3 5854.2 1431.2 1476.4 1477.2 1477.7 1479.1 870.7 944.0 947.8 974.9 978.3 5324.0 5668.3 5693.1 5721.9 5827.5 5134.5 5645.8 6485.2 6498.3 6521.3 5576.8 5733.9 5791.1 5791.2 5800.2 3372.2 3406.8 3407.6 3408.6 3431.5 5888.4 6372.3 6747.4 6755.5 6786.0 6193.2 6218.3 6240.8 6247.8 6280.2 5312.7 5336.2 5826.6 6254.4 6307.9 4618.5 4876.1 5511.4 5678.6 5970.3 5426.9 5567.0 5940.0 5967.5 6043.7 4762.4 5246.6 5701.4 6113.8 6228.6 3599.6 3956.7 3976.4 3992.0 4036.6 5234.3 5728.7 5756.6 5799.1 6098.6 5615.0 5663.2 5840.6 5862.8 5889.3 5839.6 5853.5 5883.4 5883.6 5922.8 4958.2 5091.4 5216.5 5572.6 5702.9 5836.2 5840.3 5848.9 5867.9 5883.3 4471.8 4834.6 5667.7 5699.8 5728.4 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18110.66 Median:60671.89 stddev:26107.46 (43.0%) stddev-sans-first:26147.81 03:11:51 INFO - PROCESS | 1669 | Values: 656.5 674.4 745.2 749.2 768.1 14769.0 14859.9 14892.6 15073.5 15189.2 13721.5 13800.7 13910.7 13925.1 13937.3 735.2 908.8 919.0 942.5 946.9 901.4 919.4 931.7 939.1 941.4 943.7 948.2 989.7 990.1 995.0 961.9 966.5 979.0 984.7 984.8 701.8 725.9 730.0 735.4 737.2 14821.2 14852.3 14923.9 14926.0 14941.4 12507.6 12684.4 12691.7 12790.4 12929.7 8440.7 9942.3 9974.6 10011.5 10126.7 3486.8 3531.3 3571.0 3589.0 3609.8 57134.4 71440.6 77822.6 78257.2 78503.2 7941.7 9296.0 9428.3 9485.3 9573.5 16790.6 20383.5 20774.7 20783.6 21369.9 7421.6 7489.7 7493.3 7608.8 7694.8 3295.3 3787.9 3886.5 3935.5 3963.3 3632.5 3696.4 3715.0 3736.3 3739.6 548.9 627.1 647.5 654.0 654.1 528.3 585.6 589.8 591.3 623.1 8129.2 8155.1 8242.5 8243.2 8391.2 565.6 579.0 587.2 595.6 634.8 3814.7 3871.2 3917.2 3950.3 4111.5 99510.0 101203.0 103057.0 103484.0 106165.5 65642.7 83904.0 83995.0 84357.0 85910.1 72901.6 74867.1 75034.2 75419.0 75511.0 7339.3 7422.5 7746.1 8004.3 8283.8 38475.6 41908.2 42678.1 44245.8 46163.8 60426.0 60917.8 62969.7 63217.4 63540.7 10683.9 11123.8 11212.7 11242.0 11624.8 11918.6 11959.9 11981.8 12142.6 12215.3 10967.6 11049.6 11102.6 11223.1 12188.6 9576.8 10905.9 11397.2 11456.1 11524.4 10782.4 10870.9 11119.6 11144.6 11304.8 9145.2 9396.7 9400.6 9708.5 9730.0 8879.0 9245.2 9614.7 9645.3 9729.2 03:11:51 INFO - PROCESS | 1669 | -------- Summary: end -------- 03:11:51 INFO - PROCESS | 1669 | 03:11:51 INFO - TEST-INFO | 1669: exit 0 03:11:52 INFO - TEST-OK | dromaeo_css | took 1111453ms 03:11:52 INFO - TEST-START | kraken 03:11:52 INFO - operating with platform_type : mac_ 03:11:52 INFO - Initialising browser for kraken test... 03:11:52 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4qPYKB/profile http://localhost:49273/getInfo.html) 03:11:54 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 03:11:54 INFO - PROCESS | 1676 | colorDepth:24 03:11:54 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 03:11:54 INFO - PROCESS | 1676 | __metrics 03:11:54 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:11:55 INFO - TEST-INFO | 1676: exit 0 03:11:55 INFO - Browser initialized. 03:11:55 INFO - Running cycle 1/1 for kraken test... 03:11:55 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4qPYKB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:07 INFO - PROCESS | 1680 | RSS: Main: 221605888 03:12:07 INFO - PROCESS | 1680 | 03:12:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:11 INFO - PROCESS | 1680 | RSS: Main: 233705472 03:12:11 INFO - PROCESS | 1680 | 03:12:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 03:12:14 INFO - PROCESS | 1680 | RSS: Main: 243187712 03:12:14 INFO - PROCESS | 1680 | 03:12:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 03:12:18 INFO - PROCESS | 1680 | RSS: Main: 246595584 03:12:18 INFO - PROCESS | 1680 | 03:12:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 03:12:21 INFO - PROCESS | 1680 | RSS: Main: 247070720 03:12:21 INFO - PROCESS | 1680 | 03:12:23 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:23 INFO - PROCESS | 1680 | RSS: Main: 248569856 03:12:23 INFO - PROCESS | 1680 | 03:12:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:27 INFO - PROCESS | 1680 | RSS: Main: 248528896 03:12:27 INFO - PROCESS | 1680 | 03:12:30 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:30 INFO - PROCESS | 1680 | RSS: Main: 248619008 03:12:30 INFO - PROCESS | 1680 | 03:12:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 03:12:34 INFO - PROCESS | 1680 | RSS: Main: 248745984 03:12:34 INFO - PROCESS | 1680 | 03:12:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:36 INFO - PROCESS | 1680 | RSS: Main: 247988224 03:12:36 INFO - PROCESS | 1680 | 03:12:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:39 INFO - PROCESS | 1680 | RSS: Main: 248107008 03:12:39 INFO - PROCESS | 1680 | 03:12:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:42 INFO - PROCESS | 1680 | RSS: Main: 248270848 03:12:42 INFO - PROCESS | 1680 | 03:12:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:45 INFO - PROCESS | 1680 | RSS: Main: 248344576 03:12:45 INFO - PROCESS | 1680 | 03:12:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:49 INFO - PROCESS | 1680 | RSS: Main: 248258560 03:12:49 INFO - PROCESS | 1680 | 03:12:50 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 03:12:51 INFO - PROCESS | 1680 | RSS: Main: 249925632 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | __start_tp_report 03:12:51 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 03:12:51 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 03:12:51 INFO - PROCESS | 1680 | |i|pagename|runs| 03:12:51 INFO - PROCESS | 1680 | |0;ai-astar;117;113;117;119;117;130;114;116;116;110 03:12:51 INFO - PROCESS | 1680 | |1;audio-beat-detection;157;104;191;217;158;139;149;154;180;151 03:12:51 INFO - PROCESS | 1680 | |2;audio-dft;201;196;196;202;198;196;199;196;204;197 03:12:51 INFO - PROCESS | 1680 | |3;audio-fft;64;84;74;148;56;56;60;65;149;89 03:12:51 INFO - PROCESS | 1680 | |4;audio-oscillator;80;81;129;76;78;88;118;79;78;121 03:12:51 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;86;88;87;90;101;134;111;89;85 03:12:51 INFO - PROCESS | 1680 | |6;imaging-darkroom;150;118;95;95;94;95;96;94;94;94 03:12:51 INFO - PROCESS | 1680 | |7;imaging-desaturate;106;88;90;86;90;89;123;95;150;150 03:12:51 INFO - PROCESS | 1680 | |8;json-parse-financial;49;64;90;99;94;65;66;78;64;58 03:12:51 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;59;66;59;90;59;66;66;76;84;90 03:12:51 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;85;79;84;83;82;85;81;83;84;85 03:12:51 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;139;136;139;149;138;137;134;137;229;137 03:12:51 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;169;175;170;165;173;166;171;189;223;213 03:12:51 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;63;96;99;72;68;69;67;69;70;70 03:12:51 INFO - PROCESS | 1680 | __end_tp_report 03:12:51 INFO - PROCESS | 1680 | __start_cc_report 03:12:51 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1101 03:12:51 INFO - PROCESS | 1680 | __end_cc_report 03:12:51 INFO - PROCESS | 1680 | __startTimestamp1462011171190__endTimestamp 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | ------- Summary: start ------- 03:12:51 INFO - PROCESS | 1680 | Number of tests: 14 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:5.26 (4.5%) stddev-sans-first:5.58 03:12:51 INFO - PROCESS | 1680 | Values: 117.0 113.0 117.0 119.0 117.0 130.0 114.0 116.0 116.0 110.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:160.00 Median:157.50 stddev:30.62 (19.4%) stddev-sans-first:32.46 03:12:51 INFO - PROCESS | 1680 | Values: 157.0 104.0 191.0 217.0 158.0 139.0 149.0 154.0 180.0 151.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:198.50 Median:198.50 stddev:2.92 (1.5%) stddev-sans-first:2.95 03:12:51 INFO - PROCESS | 1680 | Values: 201.0 196.0 196.0 202.0 198.0 196.0 199.0 196.0 204.0 197.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:84.50 Median:64.50 stddev:35.51 (55.1%) stddev-sans-first:36.88 03:12:51 INFO - PROCESS | 1680 | Values: 64.0 84.0 74.0 148.0 56.0 56.0 60.0 65.0 149.0 89.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:78.50 stddev:21.02 (26.8%) stddev-sans-first:21.78 03:12:51 INFO - PROCESS | 1680 | Values: 80.0 81.0 129.0 76.0 78.0 88.0 118.0 79.0 78.0 121.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:87.50 stddev:15.67 (17.9%) stddev-sans-first:16.35 03:12:51 INFO - PROCESS | 1680 | Values: 88.0 86.0 88.0 87.0 90.0 101.0 134.0 111.0 89.0 85.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:94.50 stddev:18.25 (19.3%) stddev-sans-first:7.82 03:12:51 INFO - PROCESS | 1680 | Values: 150.0 118.0 95.0 95.0 94.0 95.0 96.0 94.0 94.0 94.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:106.70 Median:88.50 stddev:25.39 (28.7%) stddev-sans-first:26.93 03:12:51 INFO - PROCESS | 1680 | Values: 106.0 88.0 90.0 86.0 90.0 89.0 123.0 95.0 150.0 150.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.00 stddev:16.69 (23.2%) stddev-sans-first:15.34 03:12:51 INFO - PROCESS | 1680 | Values: 49.0 64.0 90.0 99.0 94.0 65.0 66.0 78.0 64.0 58.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:12.56 (17.7%) stddev-sans-first:12.48 03:12:51 INFO - PROCESS | 1680 | Values: 59.0 66.0 59.0 90.0 59.0 66.0 66.0 76.0 84.0 90.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:1.97 (2.3%) stddev-sans-first:1.96 03:12:51 INFO - PROCESS | 1680 | Values: 85.0 79.0 84.0 83.0 82.0 85.0 81.0 83.0 84.0 85.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:138.50 stddev:28.91 (20.9%) stddev-sans-first:30.50 03:12:51 INFO - PROCESS | 1680 | Values: 139.0 136.0 139.0 149.0 138.0 137.0 134.0 137.0 229.0 137.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:174.00 stddev:20.54 (11.8%) stddev-sans-first:21.29 03:12:51 INFO - PROCESS | 1680 | Values: 169.0 175.0 170.0 165.0 173.0 166.0 171.0 189.0 223.0 213.0 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:70.00 stddev:12.47 (17.8%) stddev-sans-first:12.54 03:12:51 INFO - PROCESS | 1680 | Values: 63.0 96.0 99.0 72.0 68.0 69.0 67.0 69.0 70.0 70.0 03:12:51 INFO - PROCESS | 1680 | -------- Summary: end -------- 03:12:51 INFO - PROCESS | 1680 | 03:12:51 INFO - TEST-INFO | 1680: exit 0 03:12:51 INFO - TEST-OK | kraken | took 59936ms 03:12:51 INFO - SUITE-END | took 1171s 03:12:52 INFO - Completed test suite (00:19:31) 03:12:52 INFO - javascript benchmark 03:12:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3444.6210916799146, 3469.705075068619, 3486.877959271426, 3505.983264853193, 3538.9292214155716, 5811.360750317473, 5825.708714564265, 5839.124131380289, 5857.6778277194735, 5876.294844618641, 5768.884622307562, 5789.797357092502, 5799.449052340032, 5814.592978491507, 5822.3886491918265, 5189.636725429222, 5206.349206349207, 5276.15581506959, 5280.577553795687, 5289.68261904285, 4509.25597276449, 4568.977155114237, 5144.25408315794, 5279.049771041211, 5400.675959442427, 4007.9799601001955, 4425.734455932655, 5235.450277720842, 5246.580273578104, 5255.921161182585, 5235.869103272411, 5265.763040663161, 5276.287701160332, 5301.072312345363, 5306.257124002643, 4643.419572553431, 4956.801727930879, 5109.233614957749, 5210.192420174879, 5270.367555893279, 5537.778488860441, 5615.46653067962, 5650.3219613646215, 5731.910936922013, 5890.617109887844, 6133.264008318985, 6140.263168419819, 6155.599886007395, 6169.259688837324, 6240.251169859601, 6156.015037594008, 6175.536834737368, 6176.4132407421675, 6177.752889884399, 6179.38206179383, 5707.771689132472, 5762.1068734346245, 5764.74058667361, 5886.0863872383015, 5895.64626122434, 6259.655718935503, 6303.401176888188, 6310.116583678288, 6314.810555683337, 6328.303886572473, 6152.3540028297275, 6160.784372546939, 6171.352008039181, 6180.351063138306, 6186.505079593621, 6106.877862442726, 6120.9957324329725, 6182.350853160354, 6195.938040619626, 6207.348228435949, 6132.7546898124465, 6187.133801267826, 6211.534134939898, 6220.315765265817, 6242.094896240111, 6194.101855230966, 6205.410486003822, 6214.40963108504, 6227.377262273827, 6239.407256310643, 4727.078219747185, 4937.975310123426, 4982.950170498321, 4996.150654388763, 5028.346314979102, 4330.28550289205, 4367.301231802896, 4378.0, 4396.164728701537, 4399.23013472641, 5637.746301416446, 5667.291588551431, 5669.291338582677, 5684.573656975661, 5694.829155125353, 6115.449898208542, 6166.229221347332, 6167.506599472032, 6175.536834737412, 6217.036359364215, 5804.970975145182, 5813.5349172066135, 5818.4763371296785, 5833.88332233353, 5863.882722345529, 5271.499207575274, 5391.541718953933, 5400.648957817729, 5425.321834770653, 5439.918401223985, 5714.457126572969, 6382.20222472191, 6468.2561505427475, 6477.902831457532, 6491.058796474579, 6183.0107182850525, 6208.441240288395, 6209.627422354673, 6209.782657607143, 6221.564490485623, 6243.937560624336, 6303.086052522451, 6339.96830015847, 6392.488600911823, 6461.547691661539, 6126.24286675468, 6176.969115154396, 6201.6899155041165, 6213.689315534296, 6226.750929962751, 6191.9690401547705, 6193.969030154821, 6211.937880621136, 6222.533310001678, 6235.3452887446165, 6036.336003039574, 6126.540509461719, 6153.3538978408415, 6216.72024758896, 6234.844128896814, 6162.630242185483, 6176.227971503562, 6193.287771906108, 6194.783182588588, 6214.1921550198185, 4147.79261036953, 5985.50083725469, 6043.033114701627, 6052.788152414644, 6093.238345206849, 5903.380145084704, 5964.850878728066, 5974.641521508724, 6092.969535152296, 6146.877062458636, 5953.6725480097275, 6078.088286757022, 6087.756489740361, 6117.663528505975, 6120.660465672209], "value": 5688.413861470502, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.8817025584968, 522.3340241192479, 574.414097620427, 593.1932571702481, 613.7023543581364, 36829.263414731686, 38063.619363806356, 38106.85679429618, 38107.618923810754, 38154.23691526168, 39480.0, 39586.0, 39807.60192398075, 40406.59593404065, 40512.392314115314, 9566.665166719165, 9774.218062554979, 9816.656417025406, 9827.754306142333, 9860.90139098607, 9628.95185524075, 9743.658971935984, 9753.561089750943, 9779.657711980082, 9788.461634610094, 9708.90291097087, 9799.853002204936, 9804.70585882421, 9808.558614862348, 9812.950935245313, 8616.439931404439, 9350.0, 9390.497520396772, 9710.951445242765, 9813.509324533816, 9552.856707149398, 9648.421094734269, 9666.75833104171, 9698.030196980317, 9709.36889102206, 29323.120306390843, 38884.61115388866, 39536.01159970995, 39587.60412395868, 41569.58430415687, 3112.439760843047, 3273.672632736731, 3308.768386212966, 3353.446681297583, 3810.161764411825, 28313.0, 28810.855945720137, 29078.854605727047, 29108.126756197347, 29805.40389192226, 1965.6068786242809, 2758.613794068832, 2778.097118436516, 2780.638516992798, 2824.9152525424065, 499380.0, 503183.0, 505801.0, 507765.0, 511521.0, 27867.30331741682, 33425.66574334226, 58923.0, 59127.11309330363, 59301.703491482265, 28198.85900570525, 35143.824280878434, 35273.0, 35444.0, 35495.82252088723, 15386.307616157075, 15590.14254216029, 15594.29825657848, 15632.609184770472, 15633.0, 13094.14888032275, 13147.408366623526, 13235.867641323655, 13241.73516529664, 13400.530981415604, 7102.14774227096, 7833.2166783322355, 8042.919570804217, 8166.9591652042545, 8254.54599997006, 3408.3864904316965, 3455.2571197192224, 3457.5159477673146, 3461.3077384522694, 3489.197484578561, 887.6493784954906, 998.1665309466676, 1010.3281317923498, 1021.5862575656871, 1048.130052056791, 29923.803047878275, 30092.0, 30112.397752044835, 30119.849400752857, 30167.245818854266, 1103.3435106111851, 1127.3686735428187, 1135.7558125003163, 1168.5851522709486, 1189.0903458853984, 12238.653748087703, 14219.64450888736, 14280.357383917748, 15009.624759380884, 15769.369225230863, 603687.0, 615692.0, 681300.0, 683409.0, 686924.0, 60196.0, 60486.39513604896, 60866.08700869491, 61089.69455152785, 61401.69299153565, 1499.587613406322, 1508.7284288827898, 1511.1386509689592, 1512.7730840374031, 1518.7342215112533, 25664.973401063748, 29240.0, 30221.546676800306, 30346.69653303527, 30715.539266911463, 51155.0, 51892.48107518876, 51979.74010130076, 52080.0, 52173.0, 598012.0099399475, 608558.0, 609374.0, 613742.0, 614868.0, 25962.610560841982, 26194.476110478066, 26242.868785655948, 26302.473950521264, 26390.86804565965, 36478.635213647525, 42467.15065698607, 43874.561254388325, 44768.55231447774, 44884.77557612191, 33022.0, 35277.0, 37044.81477592703, 37310.06724831901, 38125.428118577685, 36460.45309320309, 36565.634343656224, 36739.89780306595, 37013.62986370102, 37072.258554828215, 35984.64015359813, 36207.0, 36471.81764091269, 36680.26639467249, 37267.254654907294, 32333.51499727553, 32464.67535324711, 32691.0, 32702.0, 32941.0, 24450.388740281636, 24583.385415364042, 24683.62974555419, 24918.626220606344, 24935.625965610892], "value": 18454.912282137164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2578298464716, 398.1519363755203, 401.7950845069014, 402.92545879012374, 414.99792501037507, 16107.0, 20424.080916358762, 20849.37451876446, 20877.47806304843, 21761.455963600918, 20364.0, 20422.795772042275, 20702.896485517587, 22140.66788998162, 22202.88985550724, 5716.885207384551, 6112.144299798032, 6147.0164773636225, 6148.415900489446, 6154.692265386735, 5698.1452782082815, 6025.728842202111, 6051.3041000284875, 6098.329183789801, 6116.296625888035, 5945.316288626798, 6012.8496787580225, 6058.545609079337, 6064.878702425949, 6069.393060693939, 5781.392953739839, 6066.545009124334, 6109.725062372204, 6114.724837382284, 6129.877402451971, 5732.484076433141, 5830.795922142747, 5910.734016969247, 5949.970250148722, 5978.760849566012, 10312.587496500131, 10983.011528962432, 13673.0, 13762.724745505035, 13779.862201377959, 1976.0811222781476, 2077.1483691686485, 2123.150739704115, 2137.4801901743294, 2158.201465457775, 9055.59249833759, 9706.272029597809, 10076.294659373847, 10229.386236825814, 10246.436445995467, 1682.4363838114245, 1702.0978881192987, 1707.4024091567976, 1722.6726921884801, 1723.5260303416535, 123732.0, 125510.37244813809, 129418.99999999905, 129934.70065299321, 132322.676773232, 11731.413429328499, 11762.411879405996, 11809.996150327146, 11829.408529573488, 11894.286342819285, 15288.541343759705, 15389.923050384676, 15399.769003464957, 15418.922905385401, 15450.922745386426, 9044.954775226082, 9051.054023384871, 9054.275657947348, 9056.456612603264, 9171.266298696088, 8965.0, 9067.591958361889, 9121.543922803834, 9129.726108216764, 9164.816703665889, 3886.825092870771, 4083.8156934488666, 4696.5303469653445, 4711.599514041345, 4748.715077095385, 1548.1485183149448, 1670.607407259293, 1742.5208067781462, 1783.7591925089946, 1928.1708865187823, 817.2236375443234, 838.0781140745254, 1000.1798525209404, 1042.5673345561506, 1049.9265051446478, 19120.426387208405, 19635.803641963397, 20028.799712002692, 21471.78528214729, 21482.24812131599, 976.4585974594149, 979.221518892468, 987.9950600247097, 1031.041131747467, 1074.5433190893839, 10746.408947507962, 10923.071538919281, 11262.493187806405, 11281.0, 11285.887141128647, 573622.0, 574179.0, 576470.0, 576503.0, 603069.0, 132853.0, 139625.0, 141071.0, 141977.0, 145556.27221863822, 447.2821122098984, 472.62190247801624, 473.3633263260909, 484.25183092122757, 486.23418116466706, 10467.685969420929, 10808.729781755519, 11208.215424920178, 11392.601258955896, 11415.429228538706, 48768.756156218995, 49206.0, 49778.75110624568, 49820.50179498159, 52109.7394513025, 76730.23269767454, 76762.23237767775, 76821.61589192018, 77099.61450192938, 79641.4071718574, 8247.257746802816, 8262.42163048581, 8309.961254843145, 8322.667093316442, 8631.180037896389, 10689.198310126616, 11525.82711259315, 12725.490980360682, 12835.486580536674, 12886.613401597968, 6608.768693095719, 8444.788880278042, 11059.336439813636, 11206.551737930391, 11248.26886252391, 11220.326780392876, 11278.718032049264, 11333.773324533298, 11454.198206125491, 11633.6509904703, 11504.079673625922, 11791.35147566892, 11874.287542747463, 11911.642650720492, 11964.282143071443, 8444.071152173134, 8489.193526614961, 8614.82770344602, 8632.093630168993, 8750.431221970552, 9481.573329200064, 10186.949065254626, 11197.160212984221, 11492.655220343404, 11494.94252528732], "value": 9125.814005439739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.6480774229672, 1633.4609578838977, 1634.207409406438, 1709.2479309104, 1954.110879549805, 8145.91854081459, 8701.52006678097, 8775.517346545937, 9157.40476869003, 9194.172524472797, 8781.736547903558, 8855.822883542325, 8933.508657023862, 8947.373683842134, 8962.283017358612, 2483.2053742802264, 2517.2825744662773, 2521.00420333968, 2533.0, 2535.987320063397, 2477.7893879020303, 2521.2940376694555, 2530.101813856082, 2530.772230499255, 2539.923802285925, 2325.9651105233434, 2329.8252631052737, 2339.0, 2341.2976107167865, 2343.250159948817, 2058.7735349111585, 2132.2963422070757, 2458.385403649088, 2486.0925762096886, 2504.4114633061217, 2445.1075357494565, 2469.703635563744, 2475.504899020203, 2480.987595062013, 2481.0819996601194, 9078.727638170865, 9123.863142052875, 9159.084091590854, 9174.954125229398, 9192.0, 5333.35999680037, 5551.528120109796, 5560.916586251209, 5563.276774019392, 5565.276514053147, 3566.465030245458, 3569.250457403922, 3580.427131658922, 3638.8180590970346, 3677.8528858845616, 877.5173654490069, 1000.8899021107673, 1053.394298278493, 1055.3667799320424, 1089.591403223791, 12014.63956081319, 12164.14850960433, 12206.877931220663, 12225.388730563525, 12247.081468889779, 4892.902141957141, 4904.558589726942, 4949.158643030693, 4956.578690811321, 4976.154053810788, 10265.846012309821, 10299.897001030044, 10322.690319290434, 10336.018078282701, 10375.429351385746, 5409.97210529998, 5487.98472282629, 5504.834854954358, 5506.0, 5527.834164975057, 4459.44256967879, 4838.129136755418, 4939.036887806915, 4961.231009193581, 4977.203647416396, 4098.672106231495, 4126.0041988101375, 4141.7722025288895, 4159.0, 4191.203671302443, 1200.1838749650146, 1239.8822111899535, 1248.3259040118417, 1345.616499297715, 1358.877701006914, 836.3267569606404, 851.3104385447807, 863.7883718489011, 934.6868798952427, 947.7062110745691, 5712.314867114212, 5855.121731740188, 5860.208871802337, 6081.422264884829, 6094.603850749687, 927.0497739816742, 985.935914165577, 992.3995982430525, 1010.934289271195, 1032.7056788815153, 4020.557738648805, 4088.7546747195265, 4092.7544347339253, 4105.91788164235, 4124.8143833527565, 10544.578216871392, 11083.667489975314, 11106.722331941766, 11126.221164518405, 11221.775564488828, 10986.780264394827, 11041.503132359063, 11088.778224435466, 11106.278091924161, 11125.944370278097, 7916.762497125095, 8344.62449189788, 8352.8329433411, 8429.114942930904, 8491.91508084936, 5957.434043765836, 6015.849603759941, 6097.390260973867, 6171.783987560593, 6214.316425193316, 9649.758756031155, 9855.0, 10129.442880641636, 10169.44068076263, 10280.640177593748, 10280.537375817956, 10390.22073344487, 10490.423026733602, 10516.316439431412, 10599.682009539727, 7064.929350706633, 7518.36093932, 7692.7692169235015, 7752.4573279869865, 7880.014998125234, 8445.831083378174, 8500.022497412876, 8539.786505337417, 8541.01778295504, 8552.144785521397, 7362.7423040193335, 7523.473356864967, 7548.358389536951, 7599.316061554487, 7629.46593738433, 7294.598797066213, 7410.518316309638, 7415.3326200642205, 7460.888086678813, 7521.247875212435, 7161.176464706626, 7220.133583969957, 7234.5659260444545, 7278.417726581966, 7284.9635751823025, 4297.333913243452, 4968.006398720343, 4979.960519231827, 5106.438291787826, 5143.768530416215, 5059.822906198266, 5073.8731531712, 5113.51421614946, 5208.9739551302, 5339.866503337447], "value": 4707.701955381924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.46656849776633, 319.71066185102484, 329.58801498127343, 329.63410614218213, 329.77410473825415, 5252.343457067866, 5358.571314294847, 5360.463953604638, 5507.063799154143, 5548.03044919054, 5426.375966763823, 5429.592780541465, 5437.954745342611, 5438.646487978279, 5439.619226654136, 3788.920157755047, 3909.2767837949928, 4172.645325147366, 4175.478065241845, 4190.182914331706, 3696.796676182809, 3871.477350557681, 4182.393552934823, 4187.371894215861, 4198.349255865346, 4079.9192411870013, 4093.6725061995116, 4116.34138537834, 4126.814293356806, 4134.712903241915, 3296.2583418730833, 3422.9046705054393, 4107.938380924274, 4108.979455102721, 4143.233501802176, 3338.6995170434534, 3388.373150967079, 3574.1422058705725, 3583.802890841003, 3607.026102952188, 4483.3723278741, 4505.797239124247, 4776.952230477686, 5037.949620503785, 5315.229291752674, 4717.985633088902, 4730.976345118287, 4762.452317983407, 4774.7135171889795, 4776.331313616097, 5782.161586569966, 5782.739776710058, 5788.305403351625, 5793.536517078665, 5799.623024503436, 3794.2411517696296, 3938.4879965604573, 3953.150072734376, 3967.1867267210155, 3976.9005774855573, 5359.892802143974, 5372.355317361902, 5652.34997975234, 6047.701873288166, 6146.262448506208, 3710.350688629479, 3997.9000524986527, 4005.118873847749, 4006.1386801837743, 4018.3771515415156, 3721.3115573618966, 3923.2938071146896, 3963.4344433948427, 4042.130941847517, 4045.1707399982934, 4679.672422930362, 4706.694064885772, 4712.835050773207, 4724.551167639138, 4728.1087564973595, 4631.768411579407, 5821.602815324376, 5828.708564571839, 5839.299284085937, 5854.2389489366105, 1431.1842249917656, 1476.3799204334205, 1477.231839443505, 1477.697072100217, 1479.0534058202759, 870.7083127152475, 944.0182210501139, 947.7726344384039, 974.9122578967927, 978.2516374973151, 5324.0, 5668.348139963874, 5693.089105743061, 5721.940101563434, 5827.504662103769, 5134.48655134491, 5645.774169033275, 6485.221773387129, 6498.252700939358, 6521.315261897433, 5576.804811831566, 5733.8566535836935, 5791.073428251544, 5791.189233507313, 5800.24596802413, 3372.173817414749, 3406.8416738308597, 3407.6421975692692, 3408.556887604645, 3431.4681224410256, 5888.381719919346, 6372.299047104815, 6747.426468750113, 6755.527113102134, 6785.9660701696175, 6193.225846769154, 6218.284897236876, 6240.7503699852405, 6247.845182953376, 6280.246370435577, 5312.7343632818975, 5336.17289320156, 5826.621269617462, 6254.405831446005, 6307.905381419374, 4618.51505591908, 4876.073546026244, 5511.448855114457, 5678.602497825278, 5970.313413957277, 5426.860359324586, 5567.0, 5940.0, 5967.49276311501, 6043.667598282137, 4762.3570817939135, 5246.606504512253, 5701.372848986525, 6113.755449782137, 6228.5951413158, 3599.6141485528783, 3956.723029387915, 3976.423418604228, 3991.980040099781, 4036.616521430459, 5234.345706786652, 5728.684922329312, 5756.611006432284, 5799.130130480462, 6098.603590766586, 5614.9612321720615, 5663.235463212413, 5840.591158618856, 5862.7654893805475, 5889.348603865631, 5839.649621022752, 5853.473187413153, 5883.411658834082, 5883.558733094949, 5922.822315330547, 4958.231474121517, 5091.363579552556, 5216.452272511332, 5572.609917305912, 5702.857428564319, 5836.212111364912, 5840.269966254218, 5848.883022339614, 5867.911981320198, 5883.29400471929, 4471.8434854779925, 4834.6374021947795, 5667.688277144796, 5699.772009119589, 5728.388647139093], "value": 4269.360608499029, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.4518626946499, 674.4435840431644, 745.2286883076017, 749.194615788028, 768.1243382543897, 14769.0, 14859.925700371496, 14892.553223403302, 15073.472428465006, 15189.164595947219, 13721.519746808839, 13800.723985520284, 13910.652233694163, 13925.09486883352, 13937.303134843269, 735.2133217457323, 908.8000639859254, 918.9586468608912, 942.5381563034133, 946.9195118414943, 901.4366021236694, 919.4115765909823, 931.7065124485765, 939.1453777062874, 941.3833938770082, 943.6791490893095, 948.2271948362097, 989.6684610655439, 990.1336330710628, 995.0348162282575, 961.903809619036, 966.4732720667218, 978.9510524473748, 984.655370620288, 984.8473486609587, 701.7614011236153, 725.8983742276085, 729.9744508942161, 735.4337160386526, 737.181728281607, 14821.184834834079, 14852.331645075998, 14923.850761492355, 14926.029808062442, 14941.402343906231, 12507.624771256786, 12684.42920068599, 12691.74616507674, 12790.424430900632, 12929.676758081123, 8440.746777596682, 9942.304038717293, 9974.601015959426, 10011.549480273332, 10126.746831329203, 3486.808225547594, 3531.2760884018717, 3570.982145089284, 3588.9592018314656, 3609.7653652512504, 57134.428655713746, 71440.6427967862, 77822.61088694577, 78257.21742782614, 78503.21496785016, 7941.682332706627, 9296.023917488701, 9428.292878034037, 9485.288603354638, 9573.521323933775, 16790.580235493966, 20383.490412739502, 20774.688379674317, 20783.584328313653, 21369.931503424767, 7421.591812450367, 7489.700411983568, 7493.3256006958545, 7608.80977975544, 7694.846103078019, 3295.2585668224456, 3787.8636409077167, 3886.455896174538, 3935.5474120475938, 3963.286608410456, 3632.4551317302617, 3696.353138200804, 3714.9969508232625, 3736.3461394255896, 3739.607341229186, 548.8638518267228, 627.1188979483833, 647.543481845298, 653.996115961996, 654.1365397675023, 528.2577977940999, 585.5813093637984, 589.8201048680108, 591.2550186764621, 623.1400667079402, 8129.227723366389, 8155.062167850654, 8242.505449673039, 8243.216894395024, 8391.244787969112, 565.5503874419846, 578.9636550574509, 587.2102022779355, 595.6098755315276, 634.7651368993502, 3814.732968692165, 3871.2064026874423, 3917.1578110705764, 3950.2692001979726, 4111.48606424197, 99510.0, 101203.0, 103057.0, 103484.0, 106165.46917265364, 65642.68714625681, 83904.0, 83995.0, 84357.0, 85910.14089859021, 72901.6354918222, 74867.1283217913, 75034.24965750273, 75419.0, 75511.0, 7339.302766237199, 7422.480426370103, 7746.109197442366, 8004.279614834692, 8283.792905177419, 38475.615243847205, 41908.16183676248, 42678.14643707171, 44245.778771105935, 46163.76918115388, 60426.0, 60917.78164436775, 62969.68515157395, 63217.419564511256, 63540.682296588224, 10683.94658026705, 11123.777524449304, 11212.719682008015, 11241.988221059817, 11624.767504650028, 11918.582849600223, 11959.940200298943, 11981.820272696092, 12142.635720928387, 12215.26708397499, 10967.616133435291, 11049.558017679203, 11102.555897764321, 11223.10215182767, 12188.634340969786, 9576.760580985252, 10905.945470272598, 11397.202195846543, 11456.140789440658, 11524.423778810858, 10782.353058816496, 10870.945645271722, 11119.610813621484, 11144.60993865211, 11304.83042754343, 9145.222656074307, 9396.718098457057, 9400.623975040922, 9708.514574271117, 9729.961209622494, 8878.955605221932, 9245.214156796748, 9614.663486777928, 9645.276604254568, 9729.22166226686], "value": 6840.45715761821, "unit": "score"}], "name": "dromaeo_css", "value": 7133.103976136849, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 117.0, 119.0, 117.0, 130.0, 114.0, 116.0, 116.0, 110.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 104.0, 191.0, 217.0, 158.0, 139.0, 149.0, 154.0, 180.0, 151.0], "value": 160.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 196.0, 196.0, 202.0, 198.0, 196.0, 199.0, 196.0, 204.0, 197.0], "value": 198.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 84.0, 74.0, 148.0, 56.0, 56.0, 60.0, 65.0, 149.0, 89.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 129.0, 76.0, 78.0, 88.0, 118.0, 79.0, 78.0, 121.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 87.0, 90.0, 101.0, 134.0, 111.0, 89.0, 85.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0, 94.0, 94.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 88.0, 90.0, 86.0, 90.0, 89.0, 123.0, 95.0, 150.0, 150.0], "value": 106.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 64.0, 90.0, 99.0, 94.0, 65.0, 66.0, 78.0, 64.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 59.0, 90.0, 59.0, 66.0, 66.0, 76.0, 84.0, 90.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 84.0, 83.0, 82.0, 85.0, 81.0, 83.0, 84.0, 85.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 139.0, 149.0, 138.0, 137.0, 134.0, 137.0, 229.0, 137.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 170.0, 165.0, 173.0, 166.0, 171.0, 189.0, 223.0, 213.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 96.0, 99.0, 72.0, 68.0, 69.0, 67.0, 69.0, 70.0, 70.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1588.3, "alertThreshold": 2.0}]} 03:12:52 INFO - Return code: 0 03:12:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:12:52 ERROR - # TBPL SUCCESS # 03:12:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:12:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:12:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:12:52 INFO - 2016-04-30 03:12:52.499 screenresolution[1685:12053] starting screenresolution argv=screenresolution get 03:12:52 INFO - 2016-04-30 03:12:52.501 screenresolution[1685:12053] Display 0: 1600x1200x32@60 03:12:52 INFO - 2016-04-30 03:12:52.507 screenresolution[1686:12056] starting screenresolution argv=screenresolution list 03:12:52 INFO - Available Modes on Display 0 03:12:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:12:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:12:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:12:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:12:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:12:52 INFO - Intel Iris: 03:12:52 INFO - Chipset Model: Intel Iris 03:12:52 INFO - Type: GPU 03:12:52 INFO - Bus: Built-In 03:12:52 INFO - VRAM (Dynamic, Max): 1536 MB 03:12:52 INFO - Vendor: Intel (0x8086) 03:12:52 INFO - Device ID: 0x0a2e 03:12:52 INFO - Revision ID: 0x0009 03:12:52 INFO - Displays: 03:12:52 INFO - Display: 03:12:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:12:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:12:52 INFO - Display Serial Number: 1600x1200 60 03:12:52 INFO - Main Display: Yes 03:12:52 INFO - Mirror: Off 03:12:52 INFO - Online: Yes 03:12:52 INFO - Rotation: Supported 03:12:52 INFO - Return code: 0 03:12:52 INFO - Running post-action listener: _resource_record_post_action 03:12:52 INFO - Running post-run listener: _resource_record_post_run 03:12:53 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 32742912; Write bytes: 655454208; Read time: 343; Write time: 1928 03:12:53 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 340527616; Write bytes: 336357376; Read time: 26495; Write time: 611 03:12:53 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 31796736; Write bytes: 298715136; Read time: 327; Write time: 1262 03:12:53 INFO - Running post-run listener: _upload_blobber_files 03:12:53 INFO - Blob upload gear active. 03:12:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:53 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 03:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:55 INFO - (blobuploader) - INFO - Done attempting. 03:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:56 INFO - (blobuploader) - INFO - Done attempting. 03:12:56 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:56 INFO - Return code: 0 03:12:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4978a3db2ffdb07d1d3dd28cfd1d1eaf0b696cb40628dc917ed7eb198fb7e37a111eddef11d7982ff79e5b1741574260438ce98e59f917a00127c2b2a3dea35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c361a331bb21a5e3177ab9990b243b0e19cf4aedf5c5bca7a90f12b601c65815f39673dde8e1b007419892bb17819fcd6d42cf72da7830d7e53fe34e1d72ba7"} 03:12:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:56 INFO - Contents: 03:12:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4978a3db2ffdb07d1d3dd28cfd1d1eaf0b696cb40628dc917ed7eb198fb7e37a111eddef11d7982ff79e5b1741574260438ce98e59f917a00127c2b2a3dea35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c361a331bb21a5e3177ab9990b243b0e19cf4aedf5c5bca7a90f12b601c65815f39673dde8e1b007419892bb17819fcd6d42cf72da7830d7e53fe34e1d72ba7"} 03:12:56 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:56 INFO - Copying logs to upload dir... 03:12:56 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.079995 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-30 03:12:56.354037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 03:12:56.361532) ========= 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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4978a3db2ffdb07d1d3dd28cfd1d1eaf0b696cb40628dc917ed7eb198fb7e37a111eddef11d7982ff79e5b1741574260438ce98e59f917a00127c2b2a3dea35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c361a331bb21a5e3177ab9990b243b0e19cf4aedf5c5bca7a90f12b601c65815f39673dde8e1b007419892bb17819fcd6d42cf72da7830d7e53fe34e1d72ba7"} build_url:https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/KJjzIzYvR7WOHQri9N0S3A/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c4978a3db2ffdb07d1d3dd28cfd1d1eaf0b696cb40628dc917ed7eb198fb7e37a111eddef11d7982ff79e5b1741574260438ce98e59f917a00127c2b2a3dea35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1c361a331bb21a5e3177ab9990b243b0e19cf4aedf5c5bca7a90f12b601c65815f39673dde8e1b007419892bb17819fcd6d42cf72da7830d7e53fe34e1d72ba7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 03:12:56.388845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:12:56.392170) ========= 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.qX1MdCsoHz/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.Js8XpRlKl5/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.005169 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 03:12:56.440544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 03:12:56.440843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 03:12:56.444193) ========= ========= Total master_lag: 4.02 =========