builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1479382168.24 results: success (0) buildid: 20161117004016 builduid: bf7f5794d2c24b5fa40e4a339be5456a revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.239700) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.240177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.240450) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.254918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.255214) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 03:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2016-11-17 03:29:28 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131587 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.400258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.400577) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.450325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:28.450721) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d86e4e3d92b082d1e86160ac182f8c73cd80597a --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 d86e4e3d92b082d1e86160ac182f8c73cd80597a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 03:29:29,110 truncating revision to first 12 chars 2016-11-17 03:29:29,110 Setting DEBUG logging. 2016-11-17 03:29:29,110 attempt 1/10 2016-11-17 03:29:29,110 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d86e4e3d92b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 03:29:29,422 unpacking tar archive at: mozilla-aurora-d86e4e3d92b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:29.089177) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:29.089495) ========= script_repo_revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:29.089883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:29.090146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 03:29:29.098777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-17 03:29:29.099040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_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/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:29 INFO - MultiFileLogger online at 20161117 03:29:29 in /builds/slave/test 03:29:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:29:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:29 INFO - {'append_to_log': False, 03:29:29 INFO - 'base_work_dir': '/builds/slave/test', 03:29:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:29 INFO - 'branch': 'Mozilla-Aurora', 03:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:29 INFO - 'config_files': ('talos/linux_config.py',), 03:29:29 INFO - 'default_actions': ('clobber', 03:29:29 INFO - 'read-buildbot-config', 03:29:29 INFO - 'download-and-extract', 03:29:29 INFO - 'populate-webroot', 03:29:29 INFO - 'create-virtualenv', 03:29:29 INFO - 'install', 03:29:29 INFO - 'run-tests'), 03:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:29 INFO - 'download_minidump_stackwalk': True, 03:29:29 INFO - 'download_symbols': 'ondemand', 03:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:29 INFO - 'installer_path': 'installer.exe', 03:29:29 INFO - 'log_level': 'info', 03:29:29 INFO - 'log_name': 'talos', 03:29:29 INFO - 'log_to_console': True, 03:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:29 INFO - 'opt_config_files': (), 03:29:29 INFO - 'pip_index': False, 03:29:29 INFO - 'sps_profile': False, 03:29:29 INFO - 'sps_profile_interval': 0, 03:29:29 INFO - 'suite': 'dromaeojs-e10s', 03:29:29 INFO - 'system_bits': '32', 03:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:29 INFO - 'title': 'talos-linux64-ix-014', 03:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:29 INFO - 'use_talos_json': True, 03:29:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:29 INFO - 'work_dir': 'build'} 03:29:29 INFO - [mozharness: 2016-11-17 11:29:29.857466Z] Running clobber step. 03:29:29 INFO - Running pre-action listener: _resource_record_pre_action 03:29:29 INFO - Running main action method: clobber 03:29:29 INFO - rmtree: /builds/slave/test/build 03:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:30 INFO - Running post-action listener: _resource_record_post_action 03:29:30 INFO - [mozharness: 2016-11-17 11:29:30.319641Z] Finished clobber step (success) 03:29:30 INFO - [mozharness: 2016-11-17 11:29:30.319739Z] Running read-buildbot-config step. 03:29:30 INFO - Running pre-action listener: _resource_record_pre_action 03:29:30 INFO - Running main action method: read_buildbot_config 03:29:30 INFO - Using buildbot properties: 03:29:30 INFO - { 03:29:30 INFO - "project": "", 03:29:30 INFO - "product": "firefox", 03:29:30 INFO - "script_repo_revision": "production", 03:29:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:29:30 INFO - "repository": "", 03:29:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:29:30 INFO - "buildid": "20161117004016", 03:29:30 INFO - "stage_platform": "linux64-pgo", 03:29:30 INFO - "basedir": "/builds/slave/test", 03:29:30 INFO - "nightly_build": "True", 03:29:30 INFO - "buildnumber": 716, 03:29:30 INFO - "slavename": "talos-linux64-ix-014", 03:29:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:29:30 INFO - "platform": "ubuntu64_hw", 03:29:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:29:30 INFO - "branch": "mozilla-aurora", 03:29:30 INFO - "repo_path": "releases/mozilla-aurora", 03:29:30 INFO - "revision": "d86e4e3d92b082d1e86160ac182f8c73cd80597a", 03:29:30 INFO - "pgo_build": "True", 03:29:30 INFO - "builduid": "bf7f5794d2c24b5fa40e4a339be5456a", 03:29:30 INFO - "slavebuilddir": "test" 03:29:30 INFO - } 03:29:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:29:30 INFO - Running post-action listener: _resource_record_post_action 03:29:30 INFO - [mozharness: 2016-11-17 11:29:30.322267Z] Finished read-buildbot-config step (success) 03:29:30 INFO - [mozharness: 2016-11-17 11:29:30.322354Z] Running download-and-extract step. 03:29:30 INFO - Running pre-action listener: _resource_record_pre_action 03:29:30 INFO - Running main action method: download_and_extract 03:29:30 INFO - mkdir: /builds/slave/test/build/tests 03:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:30 INFO - trying https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:29:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:29:30 INFO - Downloaded 1361 bytes. 03:29:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:29:30 INFO - Using the following test package requirements: 03:29:30 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:30 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:29:30 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:29:30 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'jsshell-linux-x86_64.zip'], 03:29:30 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:29:30 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:29:30 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:29:30 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:29:30 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:29:30 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:29:30 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:29:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:29:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:29:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:29:31 INFO - Http code: 200 03:29:31 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 03:29:31 INFO - x-amz-cf-id: -DTZPdjCdzzrqiIXpHLOLuuF-e5e_QvxbaOgAEz7zefW6RmmxFADug== 03:29:31 INFO - x-amz-version-id: TX9Au3UhIXM2kgd96J6hZ5r3oYbyPhld 03:29:31 INFO - Expected file size: 21999690 03:29:31 INFO - Obtained file size: 21999690 03:29:35 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:29:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:29:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:29:35 INFO - Fetch https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:29:36 INFO - Http code: 200 03:29:36 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 03:29:36 INFO - x-amz-cf-id: CmLmUQhU0RrI6ic7N9PQLai0L8mseIS3pcb5G95FtvKx5bJ687uFfg== 03:29:36 INFO - x-amz-version-id: TX9Au3UhIXM2kgd96J6hZ5r3oYbyPhld 03:29:36 INFO - Expected file size: 21999690 03:29:36 INFO - Obtained file size: 21999690 03:29:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:29:41 INFO - Fetch https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:29:41 INFO - Http code: 200 03:29:41 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 03:29:41 INFO - x-amz-cf-id: c6QUEXLrOVH-ET63I6FqN5MUvc7XGl-yhYL_CUGo6PidMnAC2fN7kg== 03:29:41 INFO - x-amz-version-id: Mpf5lTmaVVCKGMj9eAD8DKCmhXVNn4p_ 03:29:41 INFO - Expected file size: 14409038 03:29:41 INFO - Obtained file size: 14409038 03:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:42 INFO - trying https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:29:42 INFO - Downloading https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:29:43 INFO - Downloaded 63923661 bytes. 03:29:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:29:43 INFO - mkdir: /builds/slave/test/properties 03:29:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:43 INFO - Contents: 03:29:43 INFO - build_url:https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - Running post-action listener: set_extra_try_arguments 03:29:43 INFO - [mozharness: 2016-11-17 11:29:43.940719Z] Finished download-and-extract step (success) 03:29:43 INFO - [mozharness: 2016-11-17 11:29:43.940943Z] Running populate-webroot step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running main action method: populate_webroot 03:29:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:43 INFO - '--tppagecycles', 03:29:43 INFO - '7'], 03:29:43 INFO - 'tests': ['tsvgm']}}, 03:29:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['damp', 'tps']}, 03:29:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'tests': ['damp', 'tps']}, 03:29:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['dromaeo_dom']}, 03:29:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['basic_compositor_video']}, 03:29:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:29:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['a11yr', 03:29:43 INFO - 'ts_paint', 03:29:43 INFO - 'tpaint', 03:29:43 INFO - 'sessionrestore', 03:29:43 INFO - 'sessionrestore_no_auto_restore', 03:29:43 INFO - 'tabpaint']}, 03:29:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['tsvgx', 03:29:43 INFO - 'tsvgr_opacity', 03:29:43 INFO - 'tart', 03:29:43 INFO - 'tscrollx', 03:29:43 INFO - 'cart']}, 03:29:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:43 INFO - 'tsvgr_opacity', 03:29:43 INFO - 'tart', 03:29:43 INFO - 'tscrollx', 03:29:43 INFO - 'cart']}, 03:29:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-e10s'], 03:29:43 INFO - 'tests': ['tp5o']}, 03:29:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'tests': ['tp5o']}, 03:29:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'talos_options': ['--disable-e10s', 03:29:43 INFO - '--xperf_path', 03:29:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:43 INFO - 'tests': ['tp5n']}, 03:29:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:43 INFO - 'talos_options': ['--xperf_path', 03:29:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:43 INFO - 'tests': ['tp5n']}}, 03:29:43 INFO - 'talos.zip': {'path': '', 03:29:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:43 INFO - Running post-action listener: _resource_record_post_action 03:29:43 INFO - [mozharness: 2016-11-17 11:29:43.961864Z] Finished populate-webroot step (success) 03:29:43 INFO - [mozharness: 2016-11-17 11:29:43.961951Z] Running create-virtualenv step. 03:29:43 INFO - Running pre-action listener: _resource_record_pre_action 03:29:43 INFO - Running main action method: create_virtualenv 03:29:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:43 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 03:29:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:44 INFO - Using real prefix '/usr' 03:29:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:46 INFO - Installing pip.................done. 03:29:46 INFO - Return code: 0 03:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:46 INFO - Reading from file tmpfile_stdout 03:29:46 INFO - Output received: 03:29:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:29:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:46 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 03:29:46 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 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:46 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 03:29:46 INFO - Cleaning up... 03:29:46 INFO - Return code: 0 03:29:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:47 INFO - Downloading/unpacking psutil>=3.1.1 03:29:47 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 03:29:47 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 03:29:47 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 03:29:47 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 03:29:47 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 03:29:47 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 03:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:49 INFO - Installing collected packages: psutil 03:29:49 INFO - Running setup.py install for psutil 03:29:49 INFO - building 'psutil._psutil_linux' extension 03:29:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:49 INFO - building 'psutil._psutil_posix' extension 03:29:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:49 INFO - Successfully installed psutil 03:29:49 INFO - Cleaning up... 03:29:49 INFO - Return code: 0 03:29:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:29:49 INFO - Using env: {'DISPLAY': ':0', 03:29:49 INFO - 'HOME': '/home/cltbld', 03:29:49 INFO - 'LANG': 'en_US.UTF-8', 03:29:49 INFO - 'LANGUAGE': 'en_US:en', 03:29:49 INFO - 'LOGNAME': 'cltbld', 03:29:49 INFO - 'MAIL': '/var/mail/cltbld', 03:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:49 INFO - 'MOZ_NO_REMOTE': '1', 03:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:49 INFO - 'NO_EM_RESTART': '1', 03:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:49 INFO - 'PWD': '/builds/slave/test', 03:29:49 INFO - 'SHELL': '/bin/bash', 03:29:49 INFO - 'SHLVL': '1', 03:29:49 INFO - 'TERM': 'linux', 03:29:49 INFO - 'TMOUT': '86400', 03:29:49 INFO - 'USER': 'cltbld', 03:29:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:49 INFO - '_': '/tools/buildbot/bin/python'} 03:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:50 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 03:29:50 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 03:29:50 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 03:29:50 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 03:29:50 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 03:29:50 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 03:29:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:52 INFO - Installing collected packages: mozsystemmonitor 03:29:52 INFO - Running setup.py install for mozsystemmonitor 03:29:52 INFO - Successfully installed mozsystemmonitor 03:29:52 INFO - Cleaning up... 03:29:52 INFO - Return code: 0 03:29:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:29:52 INFO - Using env: {'DISPLAY': ':0', 03:29:52 INFO - 'HOME': '/home/cltbld', 03:29:52 INFO - 'LANG': 'en_US.UTF-8', 03:29:52 INFO - 'LANGUAGE': 'en_US:en', 03:29:52 INFO - 'LOGNAME': 'cltbld', 03:29:52 INFO - 'MAIL': '/var/mail/cltbld', 03:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:52 INFO - 'MOZ_NO_REMOTE': '1', 03:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:52 INFO - 'NO_EM_RESTART': '1', 03:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:52 INFO - 'PWD': '/builds/slave/test', 03:29:52 INFO - 'SHELL': '/bin/bash', 03:29:52 INFO - 'SHLVL': '1', 03:29:52 INFO - 'TERM': 'linux', 03:29:52 INFO - 'TMOUT': '86400', 03:29:52 INFO - 'USER': 'cltbld', 03:29:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:52 INFO - '_': '/tools/buildbot/bin/python'} 03:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 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 03:29:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:54 INFO - warning: no files found matching '*.txt' 03:29:54 INFO - no previously-included directories found matching 'build' 03:29:54 INFO - no previously-included directories found matching 'dist' 03:29:54 INFO - no previously-included directories found matching '.git*' 03:29:54 INFO - Installing collected packages: jsonschema, functools32 03:29:54 INFO - Running setup.py install for functools32 03:29:54 INFO - warning: no files found matching '*.txt' 03:29:54 INFO - no previously-included directories found matching 'build' 03:29:54 INFO - no previously-included directories found matching 'dist' 03:29:54 INFO - no previously-included directories found matching '.git*' 03:29:54 INFO - Successfully installed jsonschema functools32 03:29:54 INFO - Cleaning up... 03:29:54 INFO - Return code: 0 03:29:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:29:54 INFO - Using env: {'DISPLAY': ':0', 03:29:54 INFO - 'HOME': '/home/cltbld', 03:29:54 INFO - 'LANG': 'en_US.UTF-8', 03:29:54 INFO - 'LANGUAGE': 'en_US:en', 03:29:54 INFO - 'LOGNAME': 'cltbld', 03:29:54 INFO - 'MAIL': '/var/mail/cltbld', 03:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:54 INFO - 'MOZ_NO_REMOTE': '1', 03:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:54 INFO - 'NO_EM_RESTART': '1', 03:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:54 INFO - 'PWD': '/builds/slave/test', 03:29:54 INFO - 'SHELL': '/bin/bash', 03:29:54 INFO - 'SHLVL': '1', 03:29:54 INFO - 'TERM': 'linux', 03:29:54 INFO - 'TMOUT': '86400', 03:29:54 INFO - 'USER': 'cltbld', 03:29:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:54 INFO - '_': '/tools/buildbot/bin/python'} 03:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:54 INFO - Cleaning up... 03:29:55 INFO - Return code: 0 03:29:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:55 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:55 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 03:29:55 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 03:29:55 INFO - Using env: {'DISPLAY': ':0', 03:29:55 INFO - 'HOME': '/home/cltbld', 03:29:55 INFO - 'LANG': 'en_US.UTF-8', 03:29:55 INFO - 'LANGUAGE': 'en_US:en', 03:29:55 INFO - 'LOGNAME': 'cltbld', 03:29:55 INFO - 'MAIL': '/var/mail/cltbld', 03:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:55 INFO - 'MOZ_NO_REMOTE': '1', 03:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:55 INFO - 'NO_EM_RESTART': '1', 03:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:55 INFO - 'PWD': '/builds/slave/test', 03:29:55 INFO - 'SHELL': '/bin/bash', 03:29:55 INFO - 'SHLVL': '1', 03:29:55 INFO - 'TERM': 'linux', 03:29:55 INFO - 'TMOUT': '86400', 03:29:55 INFO - 'USER': 'cltbld', 03:29:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:55 INFO - '_': '/tools/buildbot/bin/python'} 03:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:55 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 03:29:55 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 03:29:55 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 03:29:55 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 03:29:55 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 03:29:55 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 03:29:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:57 INFO - Downloading docopt-0.6.1.tar.gz 03:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:57 INFO - Running setup.py install for blobuploader 03:29:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:58 INFO - Running setup.py install for requests 03:29:58 INFO - Running setup.py install for docopt 03:29:58 INFO - Successfully installed blobuploader requests docopt 03:29:58 INFO - Cleaning up... 03:29:58 INFO - Return code: 0 03:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:58 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:58 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 03:29:58 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 03:29:58 INFO - Using env: {'DISPLAY': ':0', 03:29:58 INFO - 'HOME': '/home/cltbld', 03:29:58 INFO - 'LANG': 'en_US.UTF-8', 03:29:58 INFO - 'LANGUAGE': 'en_US:en', 03:29:58 INFO - 'LOGNAME': 'cltbld', 03:29:58 INFO - 'MAIL': '/var/mail/cltbld', 03:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:58 INFO - 'MOZ_NO_REMOTE': '1', 03:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:58 INFO - 'NO_EM_RESTART': '1', 03:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:58 INFO - 'PWD': '/builds/slave/test', 03:29:58 INFO - 'SHELL': '/bin/bash', 03:29:58 INFO - 'SHLVL': '1', 03:29:58 INFO - 'TERM': 'linux', 03:29:58 INFO - 'TMOUT': '86400', 03:29:58 INFO - 'USER': 'cltbld', 03:29:58 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:58 INFO - '_': '/tools/buildbot/bin/python'} 03:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 INFO - Running setup.py (path:/tmp/pip-0hXwC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 INFO - Running setup.py (path:/tmp/pip-Cv42Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 INFO - Running setup.py (path:/tmp/pip-PzmRP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:58 INFO - Running setup.py (path:/tmp/pip-JjnsCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:59 INFO - Running setup.py (path:/tmp/pip-pcNCln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:59 INFO - Running setup.py (path:/tmp/pip-egIDZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:59 INFO - Running setup.py (path:/tmp/pip-B7dqVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:59 INFO - Running setup.py (path:/tmp/pip-3yLmm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:59 INFO - Running setup.py (path:/tmp/pip-cYd9X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:59 INFO - Running setup.py (path:/tmp/pip-P5efZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:59 INFO - Running setup.py (path:/tmp/pip-0tZYTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:59 INFO - Running setup.py (path:/tmp/pip-4l2N9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 INFO - Running setup.py (path:/tmp/pip-DMuW3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 INFO - Running setup.py (path:/tmp/pip-T3POi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 INFO - Running setup.py (path:/tmp/pip-4QX6vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:59 INFO - Running setup.py (path:/tmp/pip-0S0Gym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:59 INFO - Running setup.py (path:/tmp/pip-QaCzaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:00 INFO - Running setup.py install for manifestparser 03:30:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Running setup.py install for mozcrash 03:30:00 INFO - Running setup.py install for mozdebug 03:30:00 INFO - Running setup.py install for mozdevice 03:30:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Running setup.py install for mozfile 03:30:00 INFO - Running setup.py install for mozhttpd 03:30:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Running setup.py install for mozinfo 03:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Running setup.py install for mozInstall 03:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:00 INFO - Running setup.py install for mozleak 03:30:00 INFO - Running setup.py install for mozlog 03:30:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Running setup.py install for moznetwork 03:30:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Running setup.py install for mozprocess 03:30:01 INFO - Running setup.py install for mozprofile 03:30:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Running setup.py install for mozrunner 03:30:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Running setup.py install for mozscreenshot 03:30:01 INFO - Running setup.py install for moztest 03:30:01 INFO - Running setup.py install for mozversion 03:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:01 INFO - Cleaning up... 03:30:01 INFO - Return code: 0 03:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:01 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:01 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 03:30:01 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 03:30:01 INFO - Using env: {'DISPLAY': ':0', 03:30:01 INFO - 'HOME': '/home/cltbld', 03:30:01 INFO - 'LANG': 'en_US.UTF-8', 03:30:01 INFO - 'LANGUAGE': 'en_US:en', 03:30:01 INFO - 'LOGNAME': 'cltbld', 03:30:01 INFO - 'MAIL': '/var/mail/cltbld', 03:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:01 INFO - 'MOZ_NO_REMOTE': '1', 03:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:01 INFO - 'NO_EM_RESTART': '1', 03:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:01 INFO - 'PWD': '/builds/slave/test', 03:30:01 INFO - 'SHELL': '/bin/bash', 03:30:01 INFO - 'SHLVL': '1', 03:30:01 INFO - 'TERM': 'linux', 03:30:01 INFO - 'TMOUT': '86400', 03:30:01 INFO - 'USER': 'cltbld', 03:30:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:01 INFO - '_': '/tools/buildbot/bin/python'} 03:30:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:02 INFO - Running setup.py (path:/tmp/pip-HDhBab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:02 INFO - Running setup.py (path:/tmp/pip-lO0YIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:02 INFO - Running setup.py (path:/tmp/pip-ZsiM4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:02 INFO - Running setup.py (path:/tmp/pip-ADuJPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:02 INFO - Running setup.py (path:/tmp/pip-Irt9YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:02 INFO - Running setup.py (path:/tmp/pip-P5oxap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:02 INFO - Running setup.py (path:/tmp/pip-WFbeY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:02 INFO - Running setup.py (path:/tmp/pip-tOFzQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:02 INFO - Running setup.py (path:/tmp/pip-15WIMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:02 INFO - Running setup.py (path:/tmp/pip-zU7KAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:02 INFO - Running setup.py (path:/tmp/pip-IFlun9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:02 INFO - Running setup.py (path:/tmp/pip-5BW9I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:02 INFO - Running setup.py (path:/tmp/pip-mp2mk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:02 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)) 03:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:02 INFO - Running setup.py (path:/tmp/pip-tGQLTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:03 INFO - Running setup.py (path:/tmp/pip-lfQ_Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:03 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)) 03:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:03 INFO - Running setup.py (path:/tmp/pip-ON6coh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:03 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)) 03:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:03 INFO - Running setup.py (path:/tmp/pip-PoQTV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:03 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)) 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:30:03 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)) 03:30:03 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)) 03:30:03 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)) 03:30:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:05 INFO - Downloading blessings-1.6.tar.gz 03:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:05 INFO - Installing collected packages: blessings 03:30:05 INFO - Running setup.py install for blessings 03:30:05 INFO - Successfully installed blessings 03:30:05 INFO - Cleaning up... 03:30:05 INFO - Return code: 0 03:30:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:05 INFO - Reading from file tmpfile_stdout 03:30:05 INFO - Current package versions: 03:30:05 INFO - argparse == 1.2.1 03:30:05 INFO - blessings == 1.6 03:30:05 INFO - blobuploader == 1.2.4 03:30:05 INFO - docopt == 0.6.1 03:30:05 INFO - functools32 == 3.2.3-2 03:30:05 INFO - jsonschema == 2.5.1 03:30:05 INFO - manifestparser == 1.1 03:30:05 INFO - mozInstall == 1.12 03:30:05 INFO - mozcrash == 1.0 03:30:05 INFO - mozdebug == 0.1 03:30:05 INFO - mozdevice == 0.48 03:30:05 INFO - mozfile == 1.2 03:30:05 INFO - mozhttpd == 0.7 03:30:05 INFO - mozinfo == 0.9 03:30:05 INFO - mozleak == 0.1 03:30:05 INFO - mozlog == 3.4 03:30:05 INFO - moznetwork == 0.27 03:30:05 INFO - mozprocess == 0.23 03:30:05 INFO - mozprofile == 0.28 03:30:05 INFO - mozrunner == 6.13 03:30:05 INFO - mozscreenshot == 0.1 03:30:05 INFO - mozsystemmonitor == 0.3 03:30:05 INFO - moztest == 0.7 03:30:05 INFO - mozversion == 1.4 03:30:05 INFO - psutil == 3.1.1 03:30:05 INFO - requests == 1.2.3 03:30:05 INFO - wsgiref == 0.1.2 03:30:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:05 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:05 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 03:30:05 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 03:30:05 INFO - Using env: {'DISPLAY': ':0', 03:30:05 INFO - 'HOME': '/home/cltbld', 03:30:05 INFO - 'LANG': 'en_US.UTF-8', 03:30:05 INFO - 'LANGUAGE': 'en_US:en', 03:30:05 INFO - 'LOGNAME': 'cltbld', 03:30:05 INFO - 'MAIL': '/var/mail/cltbld', 03:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:05 INFO - 'MOZ_NO_REMOTE': '1', 03:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:05 INFO - 'NO_EM_RESTART': '1', 03:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:05 INFO - 'PWD': '/builds/slave/test', 03:30:05 INFO - 'SHELL': '/bin/bash', 03:30:05 INFO - 'SHLVL': '1', 03:30:05 INFO - 'TERM': 'linux', 03:30:05 INFO - 'TMOUT': '86400', 03:30:05 INFO - 'USER': 'cltbld', 03:30:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:05 INFO - '_': '/tools/buildbot/bin/python'} 03:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 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)) 03:30:05 INFO - Cleaning up... 03:30:05 INFO - Return code: 0 03:30:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:06 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 0x7f7a74e14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f73ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:30:06 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 03:30:06 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 03:30:06 INFO - Using env: {'DISPLAY': ':0', 03:30:06 INFO - 'HOME': '/home/cltbld', 03:30:06 INFO - 'LANG': 'en_US.UTF-8', 03:30:06 INFO - 'LANGUAGE': 'en_US:en', 03:30:06 INFO - 'LOGNAME': 'cltbld', 03:30:06 INFO - 'MAIL': '/var/mail/cltbld', 03:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:06 INFO - 'MOZ_NO_REMOTE': '1', 03:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:06 INFO - 'NO_EM_RESTART': '1', 03:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:06 INFO - 'PWD': '/builds/slave/test', 03:30:06 INFO - 'SHELL': '/bin/bash', 03:30:06 INFO - 'SHLVL': '1', 03:30:06 INFO - 'TERM': 'linux', 03:30:06 INFO - 'TMOUT': '86400', 03:30:06 INFO - 'USER': 'cltbld', 03:30:06 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:06 INFO - '_': '/tools/buildbot/bin/python'} 03:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:06 INFO - Cleaning up... 03:30:06 INFO - Return code: 0 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - Running post-action listener: _start_resource_monitoring 03:30:06 INFO - Starting resource monitoring. 03:30:06 INFO - [mozharness: 2016-11-17 11:30:06.251506Z] Finished create-virtualenv step (success) 03:30:06 INFO - [mozharness: 2016-11-17 11:30:06.251965Z] Running install step. 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: install 03:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:06 INFO - Reading from file tmpfile_stdout 03:30:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:06 INFO - Reading from file tmpfile_stdout 03:30:06 INFO - Output received: 03:30:06 INFO - Usage: mozinstall [options] installer 03:30:06 INFO - Options: 03:30:06 INFO - -h, --help show this help message and exit 03:30:06 INFO - -d DEST, --destination=DEST 03:30:06 INFO - Directory to install application into. [default: 03:30:06 INFO - "/builds/slave/test"] 03:30:06 INFO - --app=APP Application being installed. [default: firefox] 03:30:06 INFO - mkdir: /builds/slave/test/build/application 03:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:30:22 INFO - Reading from file tmpfile_stdout 03:30:22 INFO - Output received: 03:30:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:22 INFO - Running post-action listener: _resource_record_post_action 03:30:22 INFO - [mozharness: 2016-11-17 11:30:22.528130Z] Finished install step (success) 03:30:22 INFO - [mozharness: 2016-11-17 11:30:22.528369Z] Running run-tests step. 03:30:22 INFO - Running pre-action listener: _resource_record_pre_action 03:30:22 INFO - Running main action method: run_tests 03:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:22 INFO - Python 2.7.3 03:30:22 INFO - Return code: 0 03:30:22 INFO - grabbing minidump binary from tooltool 03:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:22 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f70f60>, '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 0x1f71d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f721d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:22 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:30:22 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/linux64/releng.manifest -o -c /builds/tooltool_cache 03:30:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:30:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:22 INFO - Return code: 0 03:30:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:22 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:30:22 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/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 03:30:22 INFO - Using env: {'DISPLAY': ':0', 03:30:22 INFO - 'HOME': '/home/cltbld', 03:30:22 INFO - 'LANG': 'en_US.UTF-8', 03:30:22 INFO - 'LANGUAGE': 'en_US:en', 03:30:22 INFO - 'LOGNAME': 'cltbld', 03:30:22 INFO - 'MAIL': '/var/mail/cltbld', 03:30:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:22 INFO - 'MOZ_NO_REMOTE': '1', 03:30:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:22 INFO - 'NO_EM_RESTART': '1', 03:30:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:22 INFO - 'PWD': '/builds/slave/test', 03:30:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:22 INFO - 'SHELL': '/bin/bash', 03:30:22 INFO - 'SHLVL': '1', 03:30:22 INFO - 'TERM': 'linux', 03:30:22 INFO - 'TMOUT': '86400', 03:30:22 INFO - 'USER': 'cltbld', 03:30:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631', 03:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:22 INFO - '_': '/tools/buildbot/bin/python'} 03:30:22 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 03:30:22 INFO - mozversion application_buildid: 20161117004016 03:30:22 INFO - mozversion application_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 03:30:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:30:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:22 INFO - mozversion application_name: Firefox 03:30:22 INFO - mozversion application_remotingname: firefox-dev 03:30:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:22 INFO - mozversion application_vendor: Mozilla 03:30:22 INFO - mozversion application_version: 52.0a2 03:30:22 INFO - mozversion platform_buildid: 20161117004016 03:30:22 INFO - mozversion platform_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 03:30:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:30:22 INFO - mozversion platform_version: 52.0a2 03:30:22 INFO - using testdate: 1479382222 03:30:22 INFO - actual date: 1479382222 03:30:22 INFO - starting webserver on 'localhost:42170' 03:30:22 INFO - SUITE-START | Running 2 tests 03:30:22 INFO - TEST-START | dromaeo_css 03:30:22 INFO - operating with platform_type : linux_ 03:30:22 INFO - Initialising browser for dromaeo_css test... 03:30:22 INFO - TEST-INFO | started process 5660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfflCY/profile http://localhost:42170/getInfo.html) 03:30:25 ERROR - PROCESS | 5660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:30:27 INFO - PROCESS | 5660 | __metrics Screen width/height:1600/1200 03:30:27 INFO - PROCESS | 5660 | colorDepth:24 03:30:27 INFO - PROCESS | 5660 | Browser inner width/height: 1024/697 03:30:27 INFO - PROCESS | 5660 | __metrics 03:30:27 ERROR - PROCESS | 5660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 03:30:28 INFO - TEST-INFO | 5660: exit 0 03:30:28 INFO - Browser initialized. 03:30:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:28 INFO - TEST-INFO | started process 5794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfflCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:40 INFO - PROCESS | 5794 | RSS: Main: 151662592 03:30:40 INFO - PROCESS | 5794 | 03:31:29 INFO - PROCESS | 5794 | 1479382289832 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] 03:33:40 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42170/tests/dromaeo/cssquery-ext.html) 03:33:41 INFO - PROCESS | 5794 | RSS: Main: 156393472 03:33:41 INFO - PROCESS | 5794 | 03:36:44 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-ext.html (next: http://localhost:42170/tests/dromaeo/cssquery-jquery.html) 03:36:44 INFO - PROCESS | 5794 | RSS: Main: 153055232 03:36:44 INFO - PROCESS | 5794 | 03:39:46 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42170/tests/dromaeo/cssquery-mootools.html) 03:39:47 INFO - PROCESS | 5794 | RSS: Main: 153247744 03:39:47 INFO - PROCESS | 5794 | 03:42:49 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42170/tests/dromaeo/cssquery-prototype.html) 03:42:49 INFO - PROCESS | 5794 | RSS: Main: 152211456 03:42:49 INFO - PROCESS | 5794 | 03:45:52 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42170/tests/dromaeo/cssquery-yui.html) 03:45:52 INFO - PROCESS | 5794 | RSS: Main: 154017792 03:45:52 INFO - PROCESS | 5794 | 03:48:54 INFO - PROCESS | 5794 | Cycle 1(1): loaded http://localhost:42170/tests/dromaeo/cssquery-yui.html (next: http://localhost:42170/tests/dromaeo/cssquery-dojo.html) 03:48:55 INFO - PROCESS | 5794 | RSS: Main: 155496448 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | __start_tp_report 03:48:55 INFO - PROCESS | 5794 | _x_x_mozilla_page_load 03:48:55 INFO - PROCESS | 5794 | _x_x_mozilla_page_load_details 03:48:55 INFO - PROCESS | 5794 | |i|pagename|runs| 03:48:55 INFO - PROCESS | 5794 | |0;dojo.html;3313.884014059508;3340.4488259437207;3343.4984752287155;3345.096823857557;3360.075979105744;5734.569907256957;5734.913976290359;5749.626274292168;5802.071668533035;5827.7377518011735;5708.971455142729;5726.19833223348;5751.079827227644;5754.482096611304;5759.049756790125;5173.068847607438;5201.713905735183;5231.816886408977;5237.607179461536;5267.52592266696;5248.580113590903;5259.105951988171;5273.762680679379;5284.2602035714835;5309.65487243328;5108.48915108488;5124.256982737501;5269.3676758789;5274.498922602346;5284.894302113956;5150.922736158942;5205.453427390107;5232.686038837682;5234.764435600369;5266.499682530153;5232.816851410221;5233.005728911495;5234.057869583474;5243.947560524422;5320.866978325535;5740.512056475163;5785.537157027427;5824.941750582482;5866.6480011199465;5910.852228694317;6060.3333633300745;6086.7565297388055;6106.175666285039;6133.527226366809;6172.938270617281;6172.07418887166;6182.814515564541;6216.564840461169;6232.844178895519;6248.281447633535;5642.351129620064;5662.065759149694;5791.420857914217;5794.246747922743;5804.129380592903;6129.325774164839;6142.007694998198;6179.969100154561;6182.227221597301;6252.437280644764;5999.010163323002;6009.729562169713;6012.008018676869;6032.577719559677;6076.848078798065;5987.341392446828;6079.483243924227;6095.939040609537;6111.54163437735;6131.63210207389;5947.910781338283;6008.399160083956;6011.879762404727;6026.849328766728;6145.8156255312415;6129.2032035835055;6135.555754697269;6147.784827531015;6168.568200225941;6184.5980011299125;4729.834455794031;4739.834105806281;4740.1230772307235;4740.834070807574;4770.045990801854;4118.19695159441;4134.462519872397;4143.08852052548;4158.293090174678;4179.456670632799;5864.38423965486;5874.441928016831;5891.793787217427;5905.4685078343155;5909.438603332763;6101.054336577838;6185.969070154621;6187.381261873777;6201.596896201732;6259.374062593795;5815.04051831443;5858;5883.382244864228;5895.20414744004;5987.970060149672;5297.390800057966;5330.040592693353;5332.200169974535;5342.599305052059;5357.517823395913;6457.870842583122;6495.870082598227;6506.056621789814;6537.5750576212395;6542.084108224757;6077.513798896166;6114.206128133634;6132.539076726543;6138.723757430837;6175.814725558241;6429.164208652845;6446.774362897276;6466.191726034246;6471.870562588816;6473.449756770728;6040.09398590215;6095.573309868267;6117.510599152146;6121.112438696453;6131.570790044654;5973.283206015306;6037.547183961133;6058.545609079425;6112.358202388685;6267.9373206267355;5932.317783454958;5964.224650795369;5964.970175149097;5965.880682386415;5986.042233242661;5812.099124635688;5824.271966004249;5841.2406387171095;5852.326982397079;5874.618149820248;5754.827355179351;5815;5848.122781582797;5898.292204935264;5927.4665280125;6045;6052.576319657582;6061.454469097803;6074.635521868702;6092.421219984094;5847.44449277318;5855.648661080349;5901.675407852437;5933.050711886078;5957.821265361873 03:48:55 INFO - PROCESS | 5794 | |1;ext.html;610.3103493052851;649.0880313160011;671.9361660642237;680.819582810555;705.4603228530173;41050.794746026266;44110.55889441105;44432.3335149973;44505.332420013685;44545;44092.77953610235;44941.1011779765;44961;45081.77459112708;45117.77441112798;8735.95632021839;8767.947846258427;8813.294936405073;8834.514101724402;8887.333449991243;8831.249343805785;8848.380613357067;8853.203211710945;8877.73366798997;8896.911030889705;8819.073997230294;8833.911660883374;8885.822283554326;8902.198802107809;8929.598168082419;8754.47473151613;8795.384323097385;8890.555472226362;8894.955525222365;8898.73303800887;8765.868511972325;8818;8856.51289179095;8866.601002954818;8887.289016878698;41806;42184.1563168738;42247.788761056;42296.365554516706;42421.57578424207;3597.6402359764074;3810.580836108026;3842.634949679776;3997.420374045747;4292.1630282095;33470.497942530885;33556.32887342264;33599.832000840084;33838.1540461488;34184;4582.266837306015;4626.83806066786;4631.143238500888;4639.489656137822;4646.930296045562;346992.2650386757;349044;350378;350609;351989;63849.36150638527;63888;63997.680011600576;64275.678621606596;64278.67860660667;68559.3144068563;68998.65500672464;69031.30968690349;69063;69201.65399172972;17193.312267509158;17341.7398739019;17439;17470.650586988188;17576.736348954775;11857.525698971944;11866.644000679993;11902.464389102512;11924.88075119255;11981.400929953468;20397.18411263533;20655.380338589566;20683.689744653842;20796.792032079484;20833.06251218699;7376.7418140364825;7419.29516695913;7622.618869056525;7631;7640.274173953466;999.7950420163849;1012.5190534496055;1055.672741450153;1089.1831126655009;1128.514738662383;32915.83542082274;33051.83474082662;33225;33226.66773332284;33259.501107483404;1145.8109411947103;1153.342594721001;1156.9942150289194;1174.8237764335247;1197.2038594334845;16509.752353714703;17634.82365176332;17754.733678994824;17780.644387112185;17789.911050444924;484600;532111;549509;550818;814006;62648.68675656593;63278.683606581675;63290.36709632937;63375.36624633695;63379.683101584196;1347.919124852512;1372.1904076594658;1422.6087825847974;1432.6776475292975;1467.3103641288578;32515.349693005533;33316.16709582183;34189;35463.645363546035;35884.28231435305;59287.407125929916;60079.699601501714;60115.69942150436;60142.69928650329;60325.095123572304;461147;463833;464709;465969;468230;30897.69102309038;31212.843935780176;31320.843395782875;31560.84219578979;31752.841235793672;49701;50109.74945125251;50252;50555.74722126366;51808.74095629648;41844.79077604593;43647.12705745804;43901.56098438975;44284.557154429334;44988.55011449975;41583;41961.370579441944;42913.57086429096;43741;44338.556614433444;41498.585014149474;41567.58432415758;42028.15943681171;42535.3619695711;42899.5710042908;37369.81315093516;38139.03380582275;39129.608703913735;39325.213495730495;39522.80238598789;28891.42217155687;29399.412011760072;29536.261593459476;29567.408651827274;31559.368812624078 03:48:55 INFO - PROCESS | 5794 | |2;jquery.html;405.4708605270121;405.5964315506072;416.11367786614505;419.7670292987391;432.0775145065285;18563.907180464095;19634.90182549085;19880;20120;20172.69740953887;12147.939260303687;12522.812157817618;13039.804402933964;13085;13410.865891341084;4711.387519622444;5312.787488500456;5521.668699878;5559.277293951801;5565.860853478655;5872.089826076944;6114.296855861566;6130.785422510213;6130.877382452349;6132.540059495534;6058.1518587397795;6113.510919126459;6117.938820611804;6579.638119903403;6619.867602647944;6610.239822420411;6612.107365505643;6615.702293396808;6627.801165965029;6683.7660681875905;5203.947960520384;5518.779248830042;5544.528715059225;5604.299462567179;5614.101743720985;14534.127952322895;14866.108033517916;19852.20591176351;22988.885055574614;23146.65280020801;2370.454795397051;2396.1373905394044;2445.303088619735;2645.933851653724;2851.957220641692;10667.14662826972;10741.677749667522;10851.457427128613;11152.832707509393;11278.887211127865;1774.902380369079;1784.6787578236042;1813.4197056941784;1866.2348437140706;1904.828565429118;80129.19870801276;81696.18303816945;83853.58073209655;89656.99999999935;90821.09178908193;11535.76928461426;11988.460519276654;12010.759784804255;12065.155439119177;12065.155439119177;17140.828591714173;17198.74201886973;17292.740608890876;17327.480175594752;17372.47882563525;8437.114103019218;8477.406581539357;8519.57402129891;8553.059163492011;8557.957210214034;8080.515169089874;8087.110417854032;8301.6679332826;8305.46014509055;8359;5094.617903657167;5110.872228194325;5235.712035837989;5278.498542638443;5413.404525502192;2051.661475856497;2054.367401509586;2068.1520576563535;2069.1826728442484;2122.7664956854733;906.419891269588;995.3182070281736;1005.6631028605353;1024.4109636958779;1041.7239431550645;19225.230990760494;19571.706424403645;19812.30033933019;19827.30604428867;19988;1004.9849252261222;1015.3704703084135;1032.6747074671455;1041.6250149946165;1084.6529110684662;10188.184945204366;10774.730631734112;10900.727481812859;11025.6141035065;11127.610533631285;459777;462150;464981;471064;511173;103476.48261758643;104031.4798426003;104595;104776.47611762045;105178;1001.9549120289604;1006.9798604028025;1010.2726037253166;1025.8307379282485;1047.6490375724218;16174.595635109217;17589.472315830546;17722.46832595024;17763.822361776216;17769.46691599254;44240;44265.11469770522;45429.54570454253;45843.541564583924;46839.531604683514;60729;61130.388696112466;61678.38321616726;62954.685226575406;63533;9033.367664263438;9212.170904618617;9225.169734723908;9279.257659387367;9339.673111441067;10070.69787906364;12939.805902911276;13276.203427794364;14040.578782636538;14141.434342626591;10553.63062292816;10761.30051546647;11264.718382040186;11423.200375973602;11424.143189260672;11301.886981130083;11763.764724705628;11968.46141923633;12026.639200823989;12039.578614748441;11017;11165.274257173258;11204.215704900578;11258.21192516516;11518.157890808885;8953.149450802164;8975.237104846161;8983.550822458721;9075.591598378222;9337.439753614804;8719;11382.260153090023;11420.31478111316;11568.24806387582;11627.53489860396 03:48:55 INFO - PROCESS | 5794 | |3;mootools.html;1500.9474668386608;1555.4322672224637;1676.103284742663;1728.2741248675554;1793.4798908316598;8148.796280093001;8415.242628163463;8740.43187192832;9394.34239603228;9432.952835235823;8730.126987301266;8992.32557558184;8995.055519170492;9167.037461066575;9299;2455.7544245575477;2477.665515155458;2485.2668462803517;2489.253224032792;2497.900083996647;2413.9034438622434;2469.271564888353;2478.5252774599176;2485.1177831869695;2496.8501889886575;2372.323887692008;2374.9762502375015;2412.07135252928;2413.2036427978815;2414.2153800015067;2402.291324059398;2412.7345991940874;2413.8310318277727;2424.1151979527435;2437.9512409751883;2355.51711899062;2376.65538496917;2380.214529205358;2380.6071998120287;2387.3673476528734;9154.633814647406;9204.861927071099;9216.631334746602;9271.629134834599;9290.721278361592;5440.319960004999;5541.473560011793;5575.665460072368;5600.803971861006;5616.943830561683;3504.440523966836;3630.528031355907;3632.4551317302353;3639.7452178347526;3732.458793474958;1101.24014430043;1106.1261603333357;1140.5722853929776;1142.1833389126814;1143.9542418303258;12788.808167877489;12923.09538332317;13003.869961300361;13005.21968681882;13027.544035958696;4907.337509436252;4972.776225069808;5084.2627818966785;5115.641905066684;5216.061109000417;10787.190960677981;10837.45812709377;10894.891051089546;10922.508487118099;10936.671899843017;5535.169724541351;5541.806036788774;5548.639338442988;5557.472040156179;5579.916301255404;5035.093683136997;5062.316587260746;5154.201098829687;5210.583153347723;5253.212018197301;4044.838206471767;4073.0835561998315;4133.731307465006;4158.854440094582;4159.085001299709;1305.2168698780656;1309.1425116548676;1311.6261865368515;1314.8553659097493;1315.2634524666219;1007.5516395204211;1028.922830787679;1041.7812259425605;1059.613241166984;1073.640330489295;6183.396527639212;6202.937970620236;6257.843553911189;6409.903851442232;6441.903371449432;498.98752531186284;1051.4795176387738;1118.9160812939062;1126.3917484558247;1153.8269259611125;4372.256716358227;4481.955180448153;4511.954880451153;4528.977355113269;4568.977155114203;11342.829857551978;11587.304761714324;11626.825597616042;11644;11672.88327116735;11296.55193035086;11372;11549.36478493674;11589.24669896454;11598.826017609743;8645.697400591074;8761.080086590944;8780.253678437277;8790.560471976376;8852.822943541094;6186.690665466619;6225.408586184305;6285.43431091204;6320.968395157995;6343.619382837044;10547.261691681508;10717.249792514449;10745.032947034804;10753.623623173151;10814.45927703596;9938.30431869791;10497.580096796042;10508.42203678805;10784.406857622593;10851.294665846695;7371.115466143882;7568.621568921642;7929.088154862034;8122.715704950535;8292.212239837207;8581.699640512552;8873.245774109273;8970.41692289999;8980.371374003757;9024.639014439348;7459.962700186465;7671.117821450604;7818.140004599603;7941.086775020946;7984.20157984197;7615.276548727862;7615.923840761743;7641.732539361095;7696.615169241403;7750.6899724012665;6836.316368363124;7021.68402421882;7248.637568121468;7314.524555903849;7328.560286382834;5570.220169176399;5638.351589567088;5658.122990936411;5658.886822263449;5663;5405.648632838853;5429.131338985743;5488.615796894179;5491;5612.354579223442 03:48:55 INFO - PROCESS | 5794 | |4;prototype.html;351.2220431743687;358.71123745384966;366.5619584596405;367.2214904402665;368.055936522819;5631.63394379366;5731.770729170838;5801.970990145049;5855.79504717335;5882.970585147079;5596;5701.34434540028;5701.372848986608;5713.8285851424525;5723.25440740574;4427.800748966296;4475.75383353917;4499.572540608637;4511.6165125964335;4513.593776560109;4269.295566231568;4426.933595996063;4442.533533978934;4461.933071003938;4506.8873278167985;4380.452443444569;4402.559744025604;4410.933835992462;4413.558644135593;4453.75294917422;4394.4287242658565;4397.802098905541;4423.712458690175;4437.4009508716235;4452.799624016895;3797.316483033053;3885.6891448684037;3950.1112249743865;3950.1902110067367;3952.9011774705573;5451.64564303323;5467.17992301158;5491.544740643732;5495.945040549584;5536.695481748502;5036.370453693288;5059.443461219263;5070.594352451832;5078.21287700407;5080.900650603129;5685.260916080924;5809.738561764731;5879.412058794129;5880.26496687914;5935.762569497215;4262;4277.379779931924;4280.486341638992;4280.935785963213;4294.720843145217;6109.266887973427;6116.847078823021;6130.693465326761;6139.50883929289;6139.815805525842;4296.570342965679;4363.170997510463;4398.3842262083335;4414.785933868212;4437.33439984005;4404.383386325917;4411.382406463098;4452.732836029849;4471;4472.932906006413;5092.490750924952;5114.232865070269;5123.410807757081;5132.5124113209185;5146.794128234828;5806.535477161817;5835.416458354215;5933.554983376178;5965.612235204698;5996.4603185713495;1472.690734945652;1499.8725108365693;1502.9098254104788;1508.6982603479348;1512.9924350378178;1013.878583557835;1036.4403222259896;1044.9185093428266;1045.0698877998586;1056.8744287334118;5646.887062258732;5647.915281270784;5651.717414129277;5671.6597004179885;5694.60137790359;5923.200367950358;5933.703314834327;5937.554683398763;5971.4327138921735;5987.880242395127;5467.398586155519;5569.805056822992;5587.189857470644;5597.8600534986135;5635.14040366678;3146.166265939528;3146.8426578670974;3169.2869104451775;3189.188919241484;3199.600049993751;5893.968555502855;6016.458518733335;6152.107944348134;6155.169052177988;6194.256689197235;6015.218021657244;6016.578839481194;6023.728932198062;6083.80982846175;6125.754969801247;6217.906731399033;6223.719932602953;6249.968750156311;6256.906146407808;6277.5605707600025;5674.574406919415;5802.390748971466;5826.184334193132;5831.825045248649;5901.0821483017335;5766.942330576809;5770.192173095686;5779;5833.212516310414;5857.384974577608;6003.87992240144;6059.666718330358;6084.939150608614;6151.354107818794;6167.532986805314;4200;4200.201961627281;4225.66194704429;4226.5773422657485;4304.978475107604;5903.911441328298;5982.9145226557075;5984.713286643392;5999;6095.481884039729;5849.947009538154;5923.644581325134;5933.703314834154;5934.139549765347;5965.164876917322;5877.2947246329;5892.204552385373;5893.6425429826695;5901.350851406256;5903.881922361615;5797.623154494944;5826.980278451169;5839.299284085937;5914.7338369774325;5931.9110213345975;5995.890760209375;6006.969965150146;6010.7295171716505;6024.578279520391;6033.18551995475;5661.433856614471;5827.825165245049;5872.442117998783;5901.557383196363;5909.438603332676 03:48:55 INFO - PROCESS | 5794 | |5;yui.html;784.4587234807979;789.5065584009993;833.8624127019042;838.5094719589041;846.3018010141635;14862.108273503583;15308.923455382708;15541.222938853069;15542.300596473158;15730.921345393272;14389.78415323771;14404.567862964102;14494.927525362385;14604.050736702107;14609.561713148596;850.2772643253247;861.0313397427893;862.7196161247588;866.1295398124907;867.5185272173941;852.1478521478522;854.0647990450478;858.8497013022727;859.1623167411786;862.995685021574;888.2228050455851;888.5779254853925;889.5374405309235;890.9664788844941;893.4058850864168;886.0696268917611;894.369469523984;894.8389289927778;895.9014508404103;898.3890954151175;649.8342922554718;650.5413683353224;651.4365074210774;655.4003087175229;655.9639219842907;13221.140625859289;13333.733325333536;13334.266615336153;13346;13355.465781368734;12674.556390526379;13024.153430027018;13187.34063296841;13246;13292.069555131146;11176.441177941071;11226.607068752555;11325.207235493519;11389.406243015736;11452.94273528627;3791.4881490998637;3802.524684414448;3841.9757023689713;3885.592012838668;3889.747166434173;62189.378106219265;63489.68255158695;64294.999999999534;64472.677636611515;64910.67544662247;9807.803843923082;9890.65382711616;9916.454594997344;9942.900570994341;9983.251256155818;18937.526561835788;18972.051397430074;19017.714734278998;19097.522561935784;19139.904300478407;7683;7989.440739148204;8191.590420479071;8207.876881846778;8282.088970213272;4586.3579098926175;4638.79125439356;4645.187092258909;4836.927446088312;4892.535209155125;3607.7654952428006;3641.198936234024;3667.431548110047;3669.046048027532;3692.6861216796874;619.4517851701277;636.1952130554852;641.5252712992445;656.1994366872503;665.215046245435;707.7381368893542;715.6886754261913;723.9457040721861;731.4879584291018;746.4811955690851;9453.385529940531;9740.512974351253;9912.15746661542;10144.797104058025;10490.737731556772;718.3175982816241;726.5822152262471;727.2978808555657;755.1693137548763;759.9354054905284;4539.137563862855;4645.163870503275;4682.859514214579;4688.348368392935;4803.543663351976;76720.23279767131;86940.5652971731;91320;91516.54241728749;93124.53437732768;46041.30938035932;47964;71812;74527.62736186392;74601.62699186469;60394.39605603975;69271;69835.65082174557;70633;72197.63901180566;9535.189508891544;9976.401415915068;10199.592016319264;10327.173826093744;10342.948285258526;47527;48521;48568;48988.265176021676;49629.25556116589;59680.70159649174;64907.02639460318;66373.33626663865;67499.66250168718;68146.65926670335;12467.189632673848;13021.869781302066;13059.412326445143;13224.338783060615;13313.600591982256;14264.42942282297;14466.638334041732;14525.128492290496;14650.70698586001;14712.55862324132;13357.933210333886;13726.176429414267;13802.37889294964;14012.43950241979;14470.493532726305;13596.388162532907;13611.52359667407;13627.454901803816;13665.658358541115;13683.589492315246;12730.299833509245;12866.485340586647;13558;13594;13613;11250.493727782434;11514.769704605693;11557.537698491966;11837.230580012272;12099.153059285765;11693.941530292293;11740.765184696429;11874.406279686154;12004.09969252327;12036.578719745117 03:48:55 INFO - PROCESS | 5794 | __end_tp_report 03:48:55 INFO - PROCESS | 5794 | __start_cc_report 03:48:55 INFO - PROCESS | 5794 | _x_x_mozilla_cycle_collect,301 03:48:55 INFO - PROCESS | 5794 | __end_cc_report 03:48:55 INFO - PROCESS | 5794 | __startTimestamp1479383335236__endTimestamp 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | ------- Summary: start ------- 03:48:55 INFO - PROCESS | 5794 | Number of tests: 6 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#0] dojo.html Cycles:165 Average:5711.26 Median:5901.68 stddev:646.86 (11.0%) stddev-sans-first:620.90 03:48:55 INFO - PROCESS | 5794 | Values: 3313.9 3340.4 3343.5 3345.1 3360.1 5734.6 5734.9 5749.6 5802.1 5827.7 5709.0 5726.2 5751.1 5754.5 5759.0 5173.1 5201.7 5231.8 5237.6 5267.5 5248.6 5259.1 5273.8 5284.3 5309.7 5108.5 5124.3 5269.4 5274.5 5284.9 5150.9 5205.5 5232.7 5234.8 5266.5 5232.8 5233.0 5234.1 5243.9 5320.9 5740.5 5785.5 5824.9 5866.6 5910.9 6060.3 6086.8 6106.2 6133.5 6172.9 6172.1 6182.8 6216.6 6232.8 6248.3 5642.4 5662.1 5791.4 5794.2 5804.1 6129.3 6142.0 6180.0 6182.2 6252.4 5999.0 6009.7 6012.0 6032.6 6076.8 5987.3 6079.5 6095.9 6111.5 6131.6 5947.9 6008.4 6011.9 6026.8 6145.8 6129.2 6135.6 6147.8 6168.6 6184.6 4729.8 4739.8 4740.1 4740.8 4770.0 4118.2 4134.5 4143.1 4158.3 4179.5 5864.4 5874.4 5891.8 5905.5 5909.4 6101.1 6186.0 6187.4 6201.6 6259.4 5815.0 5858.0 5883.4 5895.2 5988.0 5297.4 5330.0 5332.2 5342.6 5357.5 6457.9 6495.9 6506.1 6537.6 6542.1 6077.5 6114.2 6132.5 6138.7 6175.8 6429.2 6446.8 6466.2 6471.9 6473.4 6040.1 6095.6 6117.5 6121.1 6131.6 5973.3 6037.5 6058.5 6112.4 6267.9 5932.3 5964.2 5965.0 5965.9 5986.0 5812.1 5824.3 5841.2 5852.3 5874.6 5754.8 5815.0 5848.1 5898.3 5927.5 6045.0 6052.6 6061.5 6074.6 6092.4 5847.4 5855.6 5901.7 5933.1 5957.8 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#1] ext.html Cycles:180 Average:63890.08 Median:43821.28 stddev:128083.55 (292.3%) stddev-sans-first:128354.74 03:48:55 INFO - PROCESS | 5794 | Values: 610.3 649.1 671.9 680.8 705.5 41050.8 44110.6 44432.3 44505.3 44545.0 44092.8 44941.1 44961.0 45081.8 45117.8 8736.0 8767.9 8813.3 8834.5 8887.3 8831.2 8848.4 8853.2 8877.7 8896.9 8819.1 8833.9 8885.8 8902.2 8929.6 8754.5 8795.4 8890.6 8895.0 8898.7 8765.9 8818.0 8856.5 8866.6 8887.3 41806.0 42184.2 42247.8 42296.4 42421.6 3597.6 3810.6 3842.6 3997.4 4292.2 33470.5 33556.3 33599.8 33838.2 34184.0 4582.3 4626.8 4631.1 4639.5 4646.9 346992.3 349044.0 350378.0 350609.0 351989.0 63849.4 63888.0 63997.7 64275.7 64278.7 68559.3 68998.7 69031.3 69063.0 69201.7 17193.3 17341.7 17439.0 17470.7 17576.7 11857.5 11866.6 11902.5 11924.9 11981.4 20397.2 20655.4 20683.7 20796.8 20833.1 7376.7 7419.3 7622.6 7631.0 7640.3 999.8 1012.5 1055.7 1089.2 1128.5 32915.8 33051.8 33225.0 33226.7 33259.5 1145.8 1153.3 1157.0 1174.8 1197.2 16509.8 17634.8 17754.7 17780.6 17789.9 484600.0 532111.0 549509.0 550818.0 814006.0 62648.7 63278.7 63290.4 63375.4 63379.7 1347.9 1372.2 1422.6 1432.7 1467.3 32515.3 33316.2 34189.0 35463.6 35884.3 59287.4 60079.7 60115.7 60142.7 60325.1 461147.0 463833.0 464709.0 465969.0 468230.0 30897.7 31212.8 31320.8 31560.8 31752.8 49701.0 50109.7 50252.0 50555.7 51808.7 41844.8 43647.1 43901.6 44284.6 44988.6 41583.0 41961.4 42913.6 43741.0 44338.6 41498.6 41567.6 42028.2 42535.4 42899.6 37369.8 38139.0 39129.6 39325.2 39522.8 28891.4 29399.4 29536.3 29567.4 31559.4 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#2] jquery.html Cycles:180 Average:29121.90 Median:2053.01 stddev:78736.52 (3835.2%) stddev-sans-first:78927.87 03:48:55 INFO - PROCESS | 5794 | Values: 405.5 405.6 416.1 419.8 432.1 18563.9 19634.9 19880.0 20120.0 20172.7 12147.9 12522.8 13039.8 13085.0 13410.9 4711.4 5312.8 5521.7 5559.3 5565.9 5872.1 6114.3 6130.8 6130.9 6132.5 6058.2 6113.5 6117.9 6579.6 6619.9 6610.2 6612.1 6615.7 6627.8 6683.8 5203.9 5518.8 5544.5 5604.3 5614.1 14534.1 14866.1 19852.2 22988.9 23146.7 2370.5 2396.1 2445.3 2645.9 2852.0 10667.1 10741.7 10851.5 11152.8 11278.9 1774.9 1784.7 1813.4 1866.2 1904.8 80129.2 81696.2 83853.6 89657.0 90821.1 11535.8 11988.5 12010.8 12065.2 12065.2 17140.8 17198.7 17292.7 17327.5 17372.5 8437.1 8477.4 8519.6 8553.1 8558.0 8080.5 8087.1 8301.7 8305.5 8359.0 5094.6 5110.9 5235.7 5278.5 5413.4 2051.7 2054.4 2068.2 2069.2 2122.8 906.4 995.3 1005.7 1024.4 1041.7 19225.2 19571.7 19812.3 19827.3 19988.0 1005.0 1015.4 1032.7 1041.6 1084.7 10188.2 10774.7 10900.7 11025.6 11127.6 459777.0 462150.0 464981.0 471064.0 511173.0 103476.5 104031.5 104595.0 104776.5 105178.0 1002.0 1007.0 1010.3 1025.8 1047.6 16174.6 17589.5 17722.5 17763.8 17769.5 44240.0 44265.1 45429.5 45843.5 46839.5 60729.0 61130.4 61678.4 62954.7 63533.0 9033.4 9212.2 9225.2 9279.3 9339.7 10070.7 12939.8 13276.2 14040.6 14141.4 10553.6 10761.3 11264.7 11423.2 11424.1 11301.9 11763.8 11968.5 12026.6 12039.6 11017.0 11165.3 11204.2 11258.2 11518.2 8953.1 8975.2 8983.6 9075.6 9337.4 8719.0 11382.3 11420.3 11568.2 11627.5 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#3] mootools.html Cycles:180 Average:6077.87 Median:4520.47 stddev:3436.85 (76.0%) stddev-sans-first:3429.28 03:48:55 INFO - PROCESS | 5794 | Values: 1500.9 1555.4 1676.1 1728.3 1793.5 8148.8 8415.2 8740.4 9394.3 9433.0 8730.1 8992.3 8995.1 9167.0 9299.0 2455.8 2477.7 2485.3 2489.3 2497.9 2413.9 2469.3 2478.5 2485.1 2496.9 2372.3 2375.0 2412.1 2413.2 2414.2 2402.3 2412.7 2413.8 2424.1 2438.0 2355.5 2376.7 2380.2 2380.6 2387.4 9154.6 9204.9 9216.6 9271.6 9290.7 5440.3 5541.5 5575.7 5600.8 5616.9 3504.4 3630.5 3632.5 3639.7 3732.5 1101.2 1106.1 1140.6 1142.2 1144.0 12788.8 12923.1 13003.9 13005.2 13027.5 4907.3 4972.8 5084.3 5115.6 5216.1 10787.2 10837.5 10894.9 10922.5 10936.7 5535.2 5541.8 5548.6 5557.5 5579.9 5035.1 5062.3 5154.2 5210.6 5253.2 4044.8 4073.1 4133.7 4158.9 4159.1 1305.2 1309.1 1311.6 1314.9 1315.3 1007.6 1028.9 1041.8 1059.6 1073.6 6183.4 6202.9 6257.8 6409.9 6441.9 499.0 1051.5 1118.9 1126.4 1153.8 4372.3 4482.0 4512.0 4529.0 4569.0 11342.8 11587.3 11626.8 11644.0 11672.9 11296.6 11372.0 11549.4 11589.2 11598.8 8645.7 8761.1 8780.3 8790.6 8852.8 6186.7 6225.4 6285.4 6321.0 6343.6 10547.3 10717.2 10745.0 10753.6 10814.5 9938.3 10497.6 10508.4 10784.4 10851.3 7371.1 7568.6 7929.1 8122.7 8292.2 8581.7 8873.2 8970.4 8980.4 9024.6 7460.0 7671.1 7818.1 7941.1 7984.2 7615.3 7615.9 7641.7 7696.6 7750.7 6836.3 7021.7 7248.6 7314.5 7328.6 5570.2 5638.4 5658.1 5658.9 5663.0 5405.6 5429.1 5488.6 5491.0 5612.4 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#4] prototype.html Cycles:180 Average:4968.26 Median:5666.55 stddev:1441.15 (25.4%) stddev-sans-first:1402.91 03:48:55 INFO - PROCESS | 5794 | Values: 351.2 358.7 366.6 367.2 368.1 5631.6 5731.8 5802.0 5855.8 5883.0 5596.0 5701.3 5701.4 5713.8 5723.3 4427.8 4475.8 4499.6 4511.6 4513.6 4269.3 4426.9 4442.5 4461.9 4506.9 4380.5 4402.6 4410.9 4413.6 4453.8 4394.4 4397.8 4423.7 4437.4 4452.8 3797.3 3885.7 3950.1 3950.2 3952.9 5451.6 5467.2 5491.5 5495.9 5536.7 5036.4 5059.4 5070.6 5078.2 5080.9 5685.3 5809.7 5879.4 5880.3 5935.8 4262.0 4277.4 4280.5 4280.9 4294.7 6109.3 6116.8 6130.7 6139.5 6139.8 4296.6 4363.2 4398.4 4414.8 4437.3 4404.4 4411.4 4452.7 4471.0 4472.9 5092.5 5114.2 5123.4 5132.5 5146.8 5806.5 5835.4 5933.6 5965.6 5996.5 1472.7 1499.9 1502.9 1508.7 1513.0 1013.9 1036.4 1044.9 1045.1 1056.9 5646.9 5647.9 5651.7 5671.7 5694.6 5923.2 5933.7 5937.6 5971.4 5987.9 5467.4 5569.8 5587.2 5597.9 5635.1 3146.2 3146.8 3169.3 3189.2 3199.6 5894.0 6016.5 6152.1 6155.2 6194.3 6015.2 6016.6 6023.7 6083.8 6125.8 6217.9 6223.7 6250.0 6256.9 6277.6 5674.6 5802.4 5826.2 5831.8 5901.1 5766.9 5770.2 5779.0 5833.2 5857.4 6003.9 6059.7 6084.9 6151.4 6167.5 4200.0 4200.2 4225.7 4226.6 4305.0 5903.9 5982.9 5984.7 5999.0 6095.5 5849.9 5923.6 5933.7 5934.1 5965.2 5877.3 5892.2 5893.6 5901.4 5903.9 5797.6 5827.0 5839.3 5914.7 5931.9 5995.9 6007.0 6010.7 6024.6 6033.2 5661.4 5827.8 5872.4 5901.6 5909.4 03:48:55 INFO - PROCESS | 5794 | 03:48:55 INFO - PROCESS | 5794 | [#5] yui.html Cycles:180 Average:17713.53 Median:4820.24 stddev:23024.72 (477.7%) stddev-sans-first:23054.21 03:48:55 INFO - PROCESS | 5794 | Values: 784.5 789.5 833.9 838.5 846.3 14862.1 15308.9 15541.2 15542.3 15730.9 14389.8 14404.6 14494.9 14604.1 14609.6 850.3 861.0 862.7 866.1 867.5 852.1 854.1 858.8 859.2 863.0 888.2 888.6 889.5 891.0 893.4 886.1 894.4 894.8 895.9 898.4 649.8 650.5 651.4 655.4 656.0 13221.1 13333.7 13334.3 13346.0 13355.5 12674.6 13024.2 13187.3 13246.0 13292.1 11176.4 11226.6 11325.2 11389.4 11452.9 3791.5 3802.5 3842.0 3885.6 3889.7 62189.4 63489.7 64295.0 64472.7 64910.7 9807.8 9890.7 9916.5 9942.9 9983.3 18937.5 18972.1 19017.7 19097.5 19139.9 7683.0 7989.4 8191.6 8207.9 8282.1 4586.4 4638.8 4645.2 4836.9 4892.5 3607.8 3641.2 3667.4 3669.0 3692.7 619.5 636.2 641.5 656.2 665.2 707.7 715.7 723.9 731.5 746.5 9453.4 9740.5 9912.2 10144.8 10490.7 718.3 726.6 727.3 755.2 759.9 4539.1 4645.2 4682.9 4688.3 4803.5 76720.2 86940.6 91320.0 91516.5 93124.5 46041.3 47964.0 71812.0 74527.6 74601.6 60394.4 69271.0 69835.7 70633.0 72197.6 9535.2 9976.4 10199.6 10327.2 10342.9 47527.0 48521.0 48568.0 48988.3 49629.3 59680.7 64907.0 66373.3 67499.7 68146.7 12467.2 13021.9 13059.4 13224.3 13313.6 14264.4 14466.6 14525.1 14650.7 14712.6 13357.9 13726.2 13802.4 14012.4 14470.5 13596.4 13611.5 13627.5 13665.7 13683.6 12730.3 12866.5 13558.0 13594.0 13613.0 11250.5 11514.8 11557.5 11837.2 12099.2 11693.9 11740.8 11874.4 12004.1 12036.6 03:48:55 INFO - PROCESS | 5794 | -------- Summary: end -------- 03:48:55 INFO - PROCESS | 5794 | 03:48:56 INFO - TEST-INFO | 5794: exit 0 03:48:56 INFO - TEST-OK | dromaeo_css | took 1113226ms 03:48:56 INFO - TEST-START | kraken 03:48:56 INFO - operating with platform_type : linux_ 03:48:56 INFO - Initialising browser for kraken test... 03:48:56 INFO - TEST-INFO | started process 6172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjFJLm/profile http://localhost:42170/getInfo.html) 03:48:58 ERROR - PROCESS | 6172 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:49:00 INFO - PROCESS | 6172 | __metrics Screen width/height:1600/1200 03:49:00 INFO - PROCESS | 6172 | colorDepth:24 03:49:00 INFO - PROCESS | 6172 | Browser inner width/height: 1024/697 03:49:00 INFO - PROCESS | 6172 | __metrics 03:49:00 ERROR - PROCESS | 6172 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 03:49:01 INFO - TEST-INFO | 6172: exit 0 03:49:01 INFO - Browser initialized. 03:49:01 INFO - Running cycle 1/1 for kraken test... 03:49:01 INFO - TEST-INFO | started process 6305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjFJLm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:13 INFO - PROCESS | 6305 | RSS: Main: 152117248 03:49:13 INFO - PROCESS | 6305 | 03:49:15 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42170/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:16 INFO - PROCESS | 6305 | RSS: Main: 156958720 03:49:16 INFO - PROCESS | 6305 | 03:49:19 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42170/tests/kraken/driver.html?testName=audio-dft) 03:49:19 INFO - PROCESS | 6305 | RSS: Main: 155328512 03:49:19 INFO - PROCESS | 6305 | 03:49:22 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42170/tests/kraken/driver.html?testName=audio-fft) 03:49:23 INFO - PROCESS | 6305 | RSS: Main: 155430912 03:49:23 INFO - PROCESS | 6305 | 03:49:25 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42170/tests/kraken/driver.html?testName=audio-oscillator) 03:49:25 INFO - PROCESS | 6305 | RSS: Main: 155013120 03:49:25 INFO - PROCESS | 6305 | 03:49:28 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:28 INFO - PROCESS | 6305 | RSS: Main: 155475968 03:49:28 INFO - PROCESS | 6305 | 03:49:31 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42170/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:32 INFO - PROCESS | 6305 | RSS: Main: 157941760 03:49:32 INFO - PROCESS | 6305 | 03:49:35 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42170/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:36 INFO - PROCESS | 6305 | RSS: Main: 158359552 03:49:36 INFO - PROCESS | 6305 | 03:49:38 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42170/tests/kraken/driver.html?testName=json-parse-financial) 03:49:39 INFO - PROCESS | 6305 | RSS: Main: 157655040 03:49:39 INFO - PROCESS | 6305 | 03:49:41 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:41 INFO - PROCESS | 6305 | RSS: Main: 157122560 03:49:41 INFO - PROCESS | 6305 | 03:49:43 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:44 INFO - PROCESS | 6305 | RSS: Main: 157425664 03:49:44 INFO - PROCESS | 6305 | 03:49:46 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:46 INFO - PROCESS | 6305 | RSS: Main: 157544448 03:49:46 INFO - PROCESS | 6305 | 03:49:49 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:50 INFO - PROCESS | 6305 | RSS: Main: 157536256 03:49:50 INFO - PROCESS | 6305 | 03:49:52 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:53 INFO - PROCESS | 6305 | RSS: Main: 157732864 03:49:53 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | Cycle 1(1): loaded http://localhost:42170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42170/tests/kraken/driver.html?testName=ai-astar) 03:49:55 INFO - PROCESS | 6305 | RSS: Main: 159694848 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | __start_tp_report 03:49:55 INFO - PROCESS | 6305 | _x_x_mozilla_page_load 03:49:55 INFO - PROCESS | 6305 | _x_x_mozilla_page_load_details 03:49:55 INFO - PROCESS | 6305 | |i|pagename|runs| 03:49:55 INFO - PROCESS | 6305 | |0;ai-astar;102;111;113;111;115;111;112;113;112;112 03:49:55 INFO - PROCESS | 6305 | |1;audio-beat-detection;159;122;135;163;122;124;124;123;150;123 03:49:55 INFO - PROCESS | 6305 | |2;audio-dft;162;162;161;162;161;162;164;162;161;164 03:49:55 INFO - PROCESS | 6305 | |3;audio-fft;74;77;78;109;77;74;77;77;102;76 03:49:55 INFO - PROCESS | 6305 | |4;audio-oscillator;81;80;113;82;83;81;93;82;82;106 03:49:55 INFO - PROCESS | 6305 | |5;imaging-gaussian-blur;117;118;118;118;117;118;118;118;118;118 03:49:55 INFO - PROCESS | 6305 | |6;imaging-darkroom;147;147;157;146;147;147;146;147;146;147 03:49:55 INFO - PROCESS | 6305 | |7;imaging-desaturate;85;85;86;85;86;85;85;85;84;85 03:49:55 INFO - PROCESS | 6305 | |8;json-parse-financial;52;51;51;51;51;51;53;52;51;51 03:49:55 INFO - PROCESS | 6305 | |9;json-stringify-tinderbox;58;59;59;58;58;60;59;60;60;59 03:49:55 INFO - PROCESS | 6305 | |10;stanford-crypto-aes;76;74;75;86;78;81;78;75;74;75 03:49:55 INFO - PROCESS | 6305 | |11;stanford-crypto-ccm;129;137;143;127;131;127;132;132;181;128 03:49:55 INFO - PROCESS | 6305 | |12;stanford-crypto-pbkdf2;162;159;158;157;157;156;162;155;157;162 03:49:55 INFO - PROCESS | 6305 | |13;stanford-crypto-sha256-iterative;65;62;63;66;63;62;63;66;62;64 03:49:55 INFO - PROCESS | 6305 | __end_tp_report 03:49:55 INFO - PROCESS | 6305 | __start_cc_report 03:49:55 INFO - PROCESS | 6305 | _x_x_mozilla_cycle_collect,801 03:49:55 INFO - PROCESS | 6305 | __end_cc_report 03:49:55 INFO - PROCESS | 6305 | __startTimestamp1479383395360__endTimestamp 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | ------- Summary: start ------- 03:49:55 INFO - PROCESS | 6305 | Number of tests: 14 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.46 (3.1%) stddev-sans-first:1.30 03:49:55 INFO - PROCESS | 6305 | Values: 102.0 111.0 113.0 111.0 115.0 111.0 112.0 113.0 112.0 112.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:129.50 stddev:16.50 (12.7%) stddev-sans-first:14.93 03:49:55 INFO - PROCESS | 6305 | Values: 159.0 122.0 135.0 163.0 122.0 124.0 124.0 123.0 150.0 123.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 03:49:55 INFO - PROCESS | 6305 | Values: 162.0 162.0 161.0 162.0 161.0 162.0 164.0 162.0 161.0 164.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:12.51 (16.2%) stddev-sans-first:12.92 03:49:55 INFO - PROCESS | 6305 | Values: 74.0 77.0 78.0 109.0 77.0 74.0 77.0 77.0 102.0 76.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:82.00 stddev:11.87 (14.5%) stddev-sans-first:12.29 03:49:55 INFO - PROCESS | 6305 | Values: 81.0 80.0 113.0 82.0 83.0 81.0 93.0 82.0 82.0 106.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:49:55 INFO - PROCESS | 6305 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:3.30 (2.2%) stddev-sans-first:3.49 03:49:55 INFO - PROCESS | 6305 | Values: 147.0 147.0 157.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 03:49:55 INFO - PROCESS | 6305 | Values: 85.0 85.0 86.0 85.0 86.0 85.0 85.0 85.0 84.0 85.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 03:49:55 INFO - PROCESS | 6305 | Values: 52.0 51.0 51.0 51.0 51.0 51.0 53.0 52.0 51.0 51.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.78 03:49:55 INFO - PROCESS | 6305 | Values: 58.0 59.0 59.0 58.0 58.0 60.0 59.0 60.0 60.0 59.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:3.79 (4.9%) stddev-sans-first:4.00 03:49:55 INFO - PROCESS | 6305 | Values: 76.0 74.0 75.0 86.0 78.0 81.0 78.0 75.0 74.0 75.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:132.00 stddev:16.34 (12.4%) stddev-sans-first:17.09 03:49:55 INFO - PROCESS | 6305 | Values: 129.0 137.0 143.0 127.0 131.0 127.0 132.0 132.0 181.0 128.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:158.50 stddev:2.64 (1.7%) stddev-sans-first:2.47 03:49:55 INFO - PROCESS | 6305 | Values: 162.0 159.0 158.0 157.0 157.0 156.0 162.0 155.0 157.0 162.0 03:49:55 INFO - PROCESS | 6305 | 03:49:55 INFO - PROCESS | 6305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.58 (2.5%) stddev-sans-first:1.59 03:49:55 INFO - PROCESS | 6305 | Values: 65.0 62.0 63.0 66.0 63.0 62.0 63.0 66.0 62.0 64.0 03:49:55 INFO - PROCESS | 6305 | -------- Summary: end -------- 03:49:55 INFO - PROCESS | 6305 | 03:49:56 INFO - TEST-INFO | 6305: exit 0 03:49:56 INFO - TEST-OK | kraken | took 60265ms 03:49:56 INFO - SUITE-END | took 1173s 03:49:56 INFO - Completed test suite (00:19:33) 03:49:56 INFO - javascript benchmark 03:49:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7510.238311160358, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.884014059508, 3340.4488259437207, 3343.4984752287155, 3345.096823857557, 3360.075979105744, 5734.569907256957, 5734.913976290359, 5749.626274292168, 5802.071668533035, 5827.7377518011735, 5708.971455142729, 5726.19833223348, 5751.079827227644, 5754.482096611304, 5759.049756790125, 5173.068847607438, 5201.713905735183, 5231.816886408977, 5237.607179461536, 5267.52592266696, 5248.580113590903, 5259.105951988171, 5273.762680679379, 5284.2602035714835, 5309.65487243328, 5108.48915108488, 5124.256982737501, 5269.3676758789, 5274.498922602346, 5284.894302113956, 5150.922736158942, 5205.453427390107, 5232.686038837682, 5234.764435600369, 5266.499682530153, 5232.816851410221, 5233.005728911495, 5234.057869583474, 5243.947560524422, 5320.866978325535, 5740.512056475163, 5785.537157027427, 5824.941750582482, 5866.6480011199465, 5910.852228694317, 6060.3333633300745, 6086.7565297388055, 6106.175666285039, 6133.527226366809, 6172.938270617281, 6172.07418887166, 6182.814515564541, 6216.564840461169, 6232.844178895519, 6248.281447633535, 5642.351129620064, 5662.065759149694, 5791.420857914217, 5794.246747922743, 5804.129380592903, 6129.325774164839, 6142.007694998198, 6179.969100154561, 6182.227221597301, 6252.437280644764, 5999.010163323002, 6009.729562169713, 6012.008018676869, 6032.577719559677, 6076.848078798065, 5987.341392446828, 6079.483243924227, 6095.939040609537, 6111.54163437735, 6131.63210207389, 5947.910781338283, 6008.399160083956, 6011.879762404727, 6026.849328766728, 6145.8156255312415, 6129.2032035835055, 6135.555754697269, 6147.784827531015, 6168.568200225941, 6184.5980011299125, 4729.834455794031, 4739.834105806281, 4740.1230772307235, 4740.834070807574, 4770.045990801854, 4118.19695159441, 4134.462519872397, 4143.08852052548, 4158.293090174678, 4179.456670632799, 5864.38423965486, 5874.441928016831, 5891.793787217427, 5905.4685078343155, 5909.438603332763, 6101.054336577838, 6185.969070154621, 6187.381261873777, 6201.596896201732, 6259.374062593795, 5815.04051831443, 5858.0, 5883.382244864228, 5895.20414744004, 5987.970060149672, 5297.390800057966, 5330.040592693353, 5332.200169974535, 5342.599305052059, 5357.517823395913, 6457.870842583122, 6495.870082598227, 6506.056621789814, 6537.5750576212395, 6542.084108224757, 6077.513798896166, 6114.206128133634, 6132.539076726543, 6138.723757430837, 6175.814725558241, 6429.164208652845, 6446.774362897276, 6466.191726034246, 6471.870562588816, 6473.449756770728, 6040.09398590215, 6095.573309868267, 6117.510599152146, 6121.112438696453, 6131.570790044654, 5973.283206015306, 6037.547183961133, 6058.545609079425, 6112.358202388685, 6267.9373206267355, 5932.317783454958, 5964.224650795369, 5964.970175149097, 5965.880682386415, 5986.042233242661, 5812.099124635688, 5824.271966004249, 5841.2406387171095, 5852.326982397079, 5874.618149820248, 5754.827355179351, 5815.0, 5848.122781582797, 5898.292204935264, 5927.4665280125, 6045.0, 6052.576319657582, 6061.454469097803, 6074.635521868702, 6092.421219984094, 5847.44449277318, 5855.648661080349, 5901.675407852437, 5933.050711886078, 5957.821265361873], "value": 5667.617904949974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.3103493052851, 649.0880313160011, 671.9361660642237, 680.819582810555, 705.4603228530173, 41050.794746026266, 44110.55889441105, 44432.3335149973, 44505.332420013685, 44545.0, 44092.77953610235, 44941.1011779765, 44961.0, 45081.77459112708, 45117.77441112798, 8735.95632021839, 8767.947846258427, 8813.294936405073, 8834.514101724402, 8887.333449991243, 8831.249343805785, 8848.380613357067, 8853.203211710945, 8877.73366798997, 8896.911030889705, 8819.073997230294, 8833.911660883374, 8885.822283554326, 8902.198802107809, 8929.598168082419, 8754.47473151613, 8795.384323097385, 8890.555472226362, 8894.955525222365, 8898.73303800887, 8765.868511972325, 8818.0, 8856.51289179095, 8866.601002954818, 8887.289016878698, 41806.0, 42184.1563168738, 42247.788761056, 42296.365554516706, 42421.57578424207, 3597.6402359764074, 3810.580836108026, 3842.634949679776, 3997.420374045747, 4292.1630282095, 33470.497942530885, 33556.32887342264, 33599.832000840084, 33838.1540461488, 34184.0, 4582.266837306015, 4626.83806066786, 4631.143238500888, 4639.489656137822, 4646.930296045562, 346992.2650386757, 349044.0, 350378.0, 350609.0, 351989.0, 63849.36150638527, 63888.0, 63997.680011600576, 64275.678621606596, 64278.67860660667, 68559.3144068563, 68998.65500672464, 69031.30968690349, 69063.0, 69201.65399172972, 17193.312267509158, 17341.7398739019, 17439.0, 17470.650586988188, 17576.736348954775, 11857.525698971944, 11866.644000679993, 11902.464389102512, 11924.88075119255, 11981.400929953468, 20397.18411263533, 20655.380338589566, 20683.689744653842, 20796.792032079484, 20833.06251218699, 7376.7418140364825, 7419.29516695913, 7622.618869056525, 7631.0, 7640.274173953466, 999.7950420163849, 1012.5190534496055, 1055.672741450153, 1089.1831126655009, 1128.514738662383, 32915.83542082274, 33051.83474082662, 33225.0, 33226.66773332284, 33259.501107483404, 1145.8109411947103, 1153.342594721001, 1156.9942150289194, 1174.8237764335247, 1197.2038594334845, 16509.752353714703, 17634.82365176332, 17754.733678994824, 17780.644387112185, 17789.911050444924, 484600.0, 532111.0, 549509.0, 550818.0, 814006.0, 62648.68675656593, 63278.683606581675, 63290.36709632937, 63375.36624633695, 63379.683101584196, 1347.919124852512, 1372.1904076594658, 1422.6087825847974, 1432.6776475292975, 1467.3103641288578, 32515.349693005533, 33316.16709582183, 34189.0, 35463.645363546035, 35884.28231435305, 59287.407125929916, 60079.699601501714, 60115.69942150436, 60142.69928650329, 60325.095123572304, 461147.0, 463833.0, 464709.0, 465969.0, 468230.0, 30897.69102309038, 31212.843935780176, 31320.843395782875, 31560.84219578979, 31752.841235793672, 49701.0, 50109.74945125251, 50252.0, 50555.74722126366, 51808.74095629648, 41844.79077604593, 43647.12705745804, 43901.56098438975, 44284.557154429334, 44988.55011449975, 41583.0, 41961.370579441944, 42913.57086429096, 43741.0, 44338.556614433444, 41498.585014149474, 41567.58432415758, 42028.15943681171, 42535.3619695711, 42899.5710042908, 37369.81315093516, 38139.03380582275, 39129.608703913735, 39325.213495730495, 39522.80238598789, 28891.42217155687, 29399.412011760072, 29536.261593459476, 29567.408651827274, 31559.368812624078], "value": 21092.72326008611, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.4708605270121, 405.5964315506072, 416.11367786614505, 419.7670292987391, 432.0775145065285, 18563.907180464095, 19634.90182549085, 19880.0, 20120.0, 20172.69740953887, 12147.939260303687, 12522.812157817618, 13039.804402933964, 13085.0, 13410.865891341084, 4711.387519622444, 5312.787488500456, 5521.668699878, 5559.277293951801, 5565.860853478655, 5872.089826076944, 6114.296855861566, 6130.785422510213, 6130.877382452349, 6132.540059495534, 6058.1518587397795, 6113.510919126459, 6117.938820611804, 6579.638119903403, 6619.867602647944, 6610.239822420411, 6612.107365505643, 6615.702293396808, 6627.801165965029, 6683.7660681875905, 5203.947960520384, 5518.779248830042, 5544.528715059225, 5604.299462567179, 5614.101743720985, 14534.127952322895, 14866.108033517916, 19852.20591176351, 22988.885055574614, 23146.65280020801, 2370.454795397051, 2396.1373905394044, 2445.303088619735, 2645.933851653724, 2851.957220641692, 10667.14662826972, 10741.677749667522, 10851.457427128613, 11152.832707509393, 11278.887211127865, 1774.902380369079, 1784.6787578236042, 1813.4197056941784, 1866.2348437140706, 1904.828565429118, 80129.19870801276, 81696.18303816945, 83853.58073209655, 89656.99999999935, 90821.09178908193, 11535.76928461426, 11988.460519276654, 12010.759784804255, 12065.155439119177, 12065.155439119177, 17140.828591714173, 17198.74201886973, 17292.740608890876, 17327.480175594752, 17372.47882563525, 8437.114103019218, 8477.406581539357, 8519.57402129891, 8553.059163492011, 8557.957210214034, 8080.515169089874, 8087.110417854032, 8301.6679332826, 8305.46014509055, 8359.0, 5094.617903657167, 5110.872228194325, 5235.712035837989, 5278.498542638443, 5413.404525502192, 2051.661475856497, 2054.367401509586, 2068.1520576563535, 2069.1826728442484, 2122.7664956854733, 906.419891269588, 995.3182070281736, 1005.6631028605353, 1024.4109636958779, 1041.7239431550645, 19225.230990760494, 19571.706424403645, 19812.30033933019, 19827.30604428867, 19988.0, 1004.9849252261222, 1015.3704703084135, 1032.6747074671455, 1041.6250149946165, 1084.6529110684662, 10188.184945204366, 10774.730631734112, 10900.727481812859, 11025.6141035065, 11127.610533631285, 459777.0, 462150.0, 464981.0, 471064.0, 511173.0, 103476.48261758643, 104031.4798426003, 104595.0, 104776.47611762045, 105178.0, 1001.9549120289604, 1006.9798604028025, 1010.2726037253166, 1025.8307379282485, 1047.6490375724218, 16174.595635109217, 17589.472315830546, 17722.46832595024, 17763.822361776216, 17769.46691599254, 44240.0, 44265.11469770522, 45429.54570454253, 45843.541564583924, 46839.531604683514, 60729.0, 61130.388696112466, 61678.38321616726, 62954.685226575406, 63533.0, 9033.367664263438, 9212.170904618617, 9225.169734723908, 9279.257659387367, 9339.673111441067, 10070.69787906364, 12939.805902911276, 13276.203427794364, 14040.578782636538, 14141.434342626591, 10553.63062292816, 10761.30051546647, 11264.718382040186, 11423.200375973602, 11424.143189260672, 11301.886981130083, 11763.764724705628, 11968.46141923633, 12026.639200823989, 12039.578614748441, 11017.0, 11165.274257173258, 11204.215704900578, 11258.21192516516, 11518.157890808885, 8953.149450802164, 8975.237104846161, 8983.550822458721, 9075.591598378222, 9337.439753614804, 8719.0, 11382.260153090023, 11420.31478111316, 11568.24806387582, 11627.53489860396], "value": 9367.526954348908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.9474668386608, 1555.4322672224637, 1676.103284742663, 1728.2741248675554, 1793.4798908316598, 8148.796280093001, 8415.242628163463, 8740.43187192832, 9394.34239603228, 9432.952835235823, 8730.126987301266, 8992.32557558184, 8995.055519170492, 9167.037461066575, 9299.0, 2455.7544245575477, 2477.665515155458, 2485.2668462803517, 2489.253224032792, 2497.900083996647, 2413.9034438622434, 2469.271564888353, 2478.5252774599176, 2485.1177831869695, 2496.8501889886575, 2372.323887692008, 2374.9762502375015, 2412.07135252928, 2413.2036427978815, 2414.2153800015067, 2402.291324059398, 2412.7345991940874, 2413.8310318277727, 2424.1151979527435, 2437.9512409751883, 2355.51711899062, 2376.65538496917, 2380.214529205358, 2380.6071998120287, 2387.3673476528734, 9154.633814647406, 9204.861927071099, 9216.631334746602, 9271.629134834599, 9290.721278361592, 5440.319960004999, 5541.473560011793, 5575.665460072368, 5600.803971861006, 5616.943830561683, 3504.440523966836, 3630.528031355907, 3632.4551317302353, 3639.7452178347526, 3732.458793474958, 1101.24014430043, 1106.1261603333357, 1140.5722853929776, 1142.1833389126814, 1143.9542418303258, 12788.808167877489, 12923.09538332317, 13003.869961300361, 13005.21968681882, 13027.544035958696, 4907.337509436252, 4972.776225069808, 5084.2627818966785, 5115.641905066684, 5216.061109000417, 10787.190960677981, 10837.45812709377, 10894.891051089546, 10922.508487118099, 10936.671899843017, 5535.169724541351, 5541.806036788774, 5548.639338442988, 5557.472040156179, 5579.916301255404, 5035.093683136997, 5062.316587260746, 5154.201098829687, 5210.583153347723, 5253.212018197301, 4044.838206471767, 4073.0835561998315, 4133.731307465006, 4158.854440094582, 4159.085001299709, 1305.2168698780656, 1309.1425116548676, 1311.6261865368515, 1314.8553659097493, 1315.2634524666219, 1007.5516395204211, 1028.922830787679, 1041.7812259425605, 1059.613241166984, 1073.640330489295, 6183.396527639212, 6202.937970620236, 6257.843553911189, 6409.903851442232, 6441.903371449432, 498.98752531186284, 1051.4795176387738, 1118.9160812939062, 1126.3917484558247, 1153.8269259611125, 4372.256716358227, 4481.955180448153, 4511.954880451153, 4528.977355113269, 4568.977155114203, 11342.829857551978, 11587.304761714324, 11626.825597616042, 11644.0, 11672.88327116735, 11296.55193035086, 11372.0, 11549.36478493674, 11589.24669896454, 11598.826017609743, 8645.697400591074, 8761.080086590944, 8780.253678437277, 8790.560471976376, 8852.822943541094, 6186.690665466619, 6225.408586184305, 6285.43431091204, 6320.968395157995, 6343.619382837044, 10547.261691681508, 10717.249792514449, 10745.032947034804, 10753.623623173151, 10814.45927703596, 9938.30431869791, 10497.580096796042, 10508.42203678805, 10784.406857622593, 10851.294665846695, 7371.115466143882, 7568.621568921642, 7929.088154862034, 8122.715704950535, 8292.212239837207, 8581.699640512552, 8873.245774109273, 8970.41692289999, 8980.371374003757, 9024.639014439348, 7459.962700186465, 7671.117821450604, 7818.140004599603, 7941.086775020946, 7984.20157984197, 7615.276548727862, 7615.923840761743, 7641.732539361095, 7696.615169241403, 7750.6899724012665, 6836.316368363124, 7021.68402421882, 7248.637568121468, 7314.524555903849, 7328.560286382834, 5570.220169176399, 5638.351589567088, 5658.122990936411, 5658.886822263449, 5663.0, 5405.648632838853, 5429.131338985743, 5488.615796894179, 5491.0, 5612.354579223442], "value": 4870.715427895952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2220431743687, 358.71123745384966, 366.5619584596405, 367.2214904402665, 368.055936522819, 5631.63394379366, 5731.770729170838, 5801.970990145049, 5855.79504717335, 5882.970585147079, 5596.0, 5701.34434540028, 5701.372848986608, 5713.8285851424525, 5723.25440740574, 4427.800748966296, 4475.75383353917, 4499.572540608637, 4511.6165125964335, 4513.593776560109, 4269.295566231568, 4426.933595996063, 4442.533533978934, 4461.933071003938, 4506.8873278167985, 4380.452443444569, 4402.559744025604, 4410.933835992462, 4413.558644135593, 4453.75294917422, 4394.4287242658565, 4397.802098905541, 4423.712458690175, 4437.4009508716235, 4452.799624016895, 3797.316483033053, 3885.6891448684037, 3950.1112249743865, 3950.1902110067367, 3952.9011774705573, 5451.64564303323, 5467.17992301158, 5491.544740643732, 5495.945040549584, 5536.695481748502, 5036.370453693288, 5059.443461219263, 5070.594352451832, 5078.21287700407, 5080.900650603129, 5685.260916080924, 5809.738561764731, 5879.412058794129, 5880.26496687914, 5935.762569497215, 4262.0, 4277.379779931924, 4280.486341638992, 4280.935785963213, 4294.720843145217, 6109.266887973427, 6116.847078823021, 6130.693465326761, 6139.50883929289, 6139.815805525842, 4296.570342965679, 4363.170997510463, 4398.3842262083335, 4414.785933868212, 4437.33439984005, 4404.383386325917, 4411.382406463098, 4452.732836029849, 4471.0, 4472.932906006413, 5092.490750924952, 5114.232865070269, 5123.410807757081, 5132.5124113209185, 5146.794128234828, 5806.535477161817, 5835.416458354215, 5933.554983376178, 5965.612235204698, 5996.4603185713495, 1472.690734945652, 1499.8725108365693, 1502.9098254104788, 1508.6982603479348, 1512.9924350378178, 1013.878583557835, 1036.4403222259896, 1044.9185093428266, 1045.0698877998586, 1056.8744287334118, 5646.887062258732, 5647.915281270784, 5651.717414129277, 5671.6597004179885, 5694.60137790359, 5923.200367950358, 5933.703314834327, 5937.554683398763, 5971.4327138921735, 5987.880242395127, 5467.398586155519, 5569.805056822992, 5587.189857470644, 5597.8600534986135, 5635.14040366678, 3146.166265939528, 3146.8426578670974, 3169.2869104451775, 3189.188919241484, 3199.600049993751, 5893.968555502855, 6016.458518733335, 6152.107944348134, 6155.169052177988, 6194.256689197235, 6015.218021657244, 6016.578839481194, 6023.728932198062, 6083.80982846175, 6125.754969801247, 6217.906731399033, 6223.719932602953, 6249.968750156311, 6256.906146407808, 6277.5605707600025, 5674.574406919415, 5802.390748971466, 5826.184334193132, 5831.825045248649, 5901.0821483017335, 5766.942330576809, 5770.192173095686, 5779.0, 5833.212516310414, 5857.384974577608, 6003.87992240144, 6059.666718330358, 6084.939150608614, 6151.354107818794, 6167.532986805314, 4200.0, 4200.201961627281, 4225.66194704429, 4226.5773422657485, 4304.978475107604, 5903.911441328298, 5982.9145226557075, 5984.713286643392, 5999.0, 6095.481884039729, 5849.947009538154, 5923.644581325134, 5933.703314834154, 5934.139549765347, 5965.164876917322, 5877.2947246329, 5892.204552385373, 5893.6425429826695, 5901.350851406256, 5903.881922361615, 5797.623154494944, 5826.980278451169, 5839.299284085937, 5914.7338369774325, 5931.9110213345975, 5995.890760209375, 6006.969965150146, 6010.7295171716505, 6024.578279520391, 6033.18551995475, 5661.433856614471, 5827.825165245049, 5872.442117998783, 5901.557383196363, 5909.438603332676], "value": 4512.001416598564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4587234807979, 789.5065584009993, 833.8624127019042, 838.5094719589041, 846.3018010141635, 14862.108273503583, 15308.923455382708, 15541.222938853069, 15542.300596473158, 15730.921345393272, 14389.78415323771, 14404.567862964102, 14494.927525362385, 14604.050736702107, 14609.561713148596, 850.2772643253247, 861.0313397427893, 862.7196161247588, 866.1295398124907, 867.5185272173941, 852.1478521478522, 854.0647990450478, 858.8497013022727, 859.1623167411786, 862.995685021574, 888.2228050455851, 888.5779254853925, 889.5374405309235, 890.9664788844941, 893.4058850864168, 886.0696268917611, 894.369469523984, 894.8389289927778, 895.9014508404103, 898.3890954151175, 649.8342922554718, 650.5413683353224, 651.4365074210774, 655.4003087175229, 655.9639219842907, 13221.140625859289, 13333.733325333536, 13334.266615336153, 13346.0, 13355.465781368734, 12674.556390526379, 13024.153430027018, 13187.34063296841, 13246.0, 13292.069555131146, 11176.441177941071, 11226.607068752555, 11325.207235493519, 11389.406243015736, 11452.94273528627, 3791.4881490998637, 3802.524684414448, 3841.9757023689713, 3885.592012838668, 3889.747166434173, 62189.378106219265, 63489.68255158695, 64294.999999999534, 64472.677636611515, 64910.67544662247, 9807.803843923082, 9890.65382711616, 9916.454594997344, 9942.900570994341, 9983.251256155818, 18937.526561835788, 18972.051397430074, 19017.714734278998, 19097.522561935784, 19139.904300478407, 7683.0, 7989.440739148204, 8191.590420479071, 8207.876881846778, 8282.088970213272, 4586.3579098926175, 4638.79125439356, 4645.187092258909, 4836.927446088312, 4892.535209155125, 3607.7654952428006, 3641.198936234024, 3667.431548110047, 3669.046048027532, 3692.6861216796874, 619.4517851701277, 636.1952130554852, 641.5252712992445, 656.1994366872503, 665.215046245435, 707.7381368893542, 715.6886754261913, 723.9457040721861, 731.4879584291018, 746.4811955690851, 9453.385529940531, 9740.512974351253, 9912.15746661542, 10144.797104058025, 10490.737731556772, 718.3175982816241, 726.5822152262471, 727.2978808555657, 755.1693137548763, 759.9354054905284, 4539.137563862855, 4645.163870503275, 4682.859514214579, 4688.348368392935, 4803.543663351976, 76720.23279767131, 86940.5652971731, 91320.0, 91516.54241728749, 93124.53437732768, 46041.30938035932, 47964.0, 71812.0, 74527.62736186392, 74601.62699186469, 60394.39605603975, 69271.0, 69835.65082174557, 70633.0, 72197.63901180566, 9535.189508891544, 9976.401415915068, 10199.592016319264, 10327.173826093744, 10342.948285258526, 47527.0, 48521.0, 48568.0, 48988.265176021676, 49629.25556116589, 59680.70159649174, 64907.02639460318, 66373.33626663865, 67499.66250168718, 68146.65926670335, 12467.189632673848, 13021.869781302066, 13059.412326445143, 13224.338783060615, 13313.600591982256, 14264.42942282297, 14466.638334041732, 14525.128492290496, 14650.70698586001, 14712.55862324132, 13357.933210333886, 13726.176429414267, 13802.37889294964, 14012.43950241979, 14470.493532726305, 13596.388162532907, 13611.52359667407, 13627.454901803816, 13665.658358541115, 13683.589492315246, 12730.299833509245, 12866.485340586647, 13558.0, 13594.0, 13613.0, 11250.493727782434, 11514.769704605693, 11557.537698491966, 11837.230580012272, 12099.153059285765, 11693.941530292293, 11740.765184696429, 11874.406279686154, 12004.09969252327, 12036.578719745117], "value": 7290.5545053023525, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 111.0, 115.0, 111.0, 112.0, 113.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 135.0, 163.0, 122.0, 124.0, 124.0, 123.0, 150.0, 123.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 164.0, 162.0, 161.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 78.0, 109.0, 77.0, 74.0, 77.0, 77.0, 102.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 113.0, 82.0, 83.0, 81.0, 93.0, 82.0, 82.0, 106.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 157.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 52.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 58.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 86.0, 78.0, 81.0, 78.0, 75.0, 74.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 137.0, 143.0, 127.0, 131.0, 127.0, 132.0, 132.0, 181.0, 128.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 158.0, 157.0, 157.0, 156.0, 162.0, 155.0, 157.0, 162.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 66.0, 63.0, 62.0, 63.0, 66.0, 62.0, 64.0], "value": 63.6, "unit": "score"}]}]} 03:49:56 INFO - Return code: 0 03:49:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:56 ERROR - # TBPL SUCCESS # 03:49:56 INFO - Running post-action listener: _resource_record_post_action 03:49:56 INFO - [mozharness: 2016-11-17 11:49:56.677278Z] Finished run-tests step (success) 03:49:56 INFO - Running post-run listener: _resource_record_post_run 03:49:56 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 270336; Write bytes: 356618240; Read time: 188; Write time: 210420 03:49:56 INFO - TinderboxPrint: CPU usage
13.4% 03:49:56 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 188 03:49:56 INFO - TinderboxPrint: I/O write bytes / time
356,618,240 / 210,420 03:49:56 INFO - TinderboxPrint: CPU idle
8,225.0 (86.6%) 03:49:56 INFO - TinderboxPrint: CPU user
1,212.7 (12.8%) 03:49:56 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107483136; Read time: 0; Write time: 69384 03:49:56 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248606720; Read time: 180; Write time: 141012 03:49:57 INFO - Running post-run listener: _upload_blobber_files 03:49:57 INFO - Blob upload gear active. 03:49:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:57 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:49:57 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:49:57 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:49:57 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:00 INFO - (blobuploader) - INFO - Done attempting. 03:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:01 INFO - (blobuploader) - INFO - Done attempting. 03:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:02 INFO - (blobuploader) - INFO - Done attempting. 03:50:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:02 INFO - Return code: 0 03:50:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd9172a8e8d0a17c441c6930fafbdebf4208ec42e0311597b8c512564e593193f148f8d6988498f4b62edc192fb8f358721f3644b07fb8523d69191e4768c674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b1b92b3c817910a068765cab87f6d0f2675bd05ee020c515b0b6704e8107dff2c115b3e0fb5145b406acf0f9d5c3f0a005e489901160bee0fab5a8daef35092", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65ea9c65a1aa7408eb3a0f77a95296fde7668f059b6f4d32a8e468bdb767d04741617f0d9561785c7403ba61f42486de510f449f43eb28c5e5d6b16fcf39dda5"} 03:50:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:02 INFO - Contents: 03:50:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd9172a8e8d0a17c441c6930fafbdebf4208ec42e0311597b8c512564e593193f148f8d6988498f4b62edc192fb8f358721f3644b07fb8523d69191e4768c674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b1b92b3c817910a068765cab87f6d0f2675bd05ee020c515b0b6704e8107dff2c115b3e0fb5145b406acf0f9d5c3f0a005e489901160bee0fab5a8daef35092", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65ea9c65a1aa7408eb3a0f77a95296fde7668f059b6f4d32a8e468bdb767d04741617f0d9561785c7403ba61f42486de510f449f43eb28c5e5d6b16fcf39dda5"} 03:50:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:02 INFO - Copying logs to upload dir... 03:50:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.750483 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-11-17 03:50:01.863015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:01.867055) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd9172a8e8d0a17c441c6930fafbdebf4208ec42e0311597b8c512564e593193f148f8d6988498f4b62edc192fb8f358721f3644b07fb8523d69191e4768c674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b1b92b3c817910a068765cab87f6d0f2675bd05ee020c515b0b6704e8107dff2c115b3e0fb5145b406acf0f9d5c3f0a005e489901160bee0fab5a8daef35092", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65ea9c65a1aa7408eb3a0f77a95296fde7668f059b6f4d32a8e468bdb767d04741617f0d9561785c7403ba61f42486de510f449f43eb28c5e5d6b16fcf39dda5"} build_url:https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011863 build_url: 'https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd9172a8e8d0a17c441c6930fafbdebf4208ec42e0311597b8c512564e593193f148f8d6988498f4b62edc192fb8f358721f3644b07fb8523d69191e4768c674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b1b92b3c817910a068765cab87f6d0f2675bd05ee020c515b0b6704e8107dff2c115b3e0fb5145b406acf0f9d5c3f0a005e489901160bee0fab5a8daef35092", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65ea9c65a1aa7408eb3a0f77a95296fde7668f059b6f4d32a8e468bdb767d04741617f0d9561785c7403ba61f42486de510f449f43eb28c5e5d6b16fcf39dda5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:01.894871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:01.895205) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479382168.188416-68100631 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:01.978735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 03:50:01.979239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 03:50:01.979704) ========= ========= Total master_lag: 0.17 =========