builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1479382210.08 results: success (0) buildid: 20161117004016 builduid: bf7f5794d2c24b5fa40e4a339be5456a revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.079228) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.079655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.079927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.094331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.094596) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 03:30:10-- 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% 567K=0.02s 2016-11-17 03:30:10 (567 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.210183) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.210489) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017090 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:10.259688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 03:30:10.260025) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 03:30:10,937 truncating revision to first 12 chars 2016-11-17 03:30:10,938 Setting DEBUG logging. 2016-11-17 03:30:10,938 attempt 1/10 2016-11-17 03:30:10,938 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:30:12,314 unpacking tar archive at: mozilla-aurora-d86e4e3d92b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.713464 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 03:30:11.987137) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:11.987532) ========= script_repo_revision: d86e4e3d92b082d1e86160ac182f8c73cd80597a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:11.987967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:11.988291) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 03:30:11.998858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-17 03:30:11.999173) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:12 INFO - MultiFileLogger online at 20161117 03:30:12 in /builds/slave/test 03:30:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:30:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:12 INFO - {'append_to_log': False, 03:30:12 INFO - 'base_work_dir': '/builds/slave/test', 03:30:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:12 INFO - 'branch': 'Mozilla-Aurora', 03:30:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:12 INFO - 'config_files': ('talos/linux_config.py',), 03:30:12 INFO - 'default_actions': ('clobber', 03:30:12 INFO - 'read-buildbot-config', 03:30:12 INFO - 'download-and-extract', 03:30:12 INFO - 'populate-webroot', 03:30:12 INFO - 'create-virtualenv', 03:30:12 INFO - 'install', 03:30:12 INFO - 'run-tests'), 03:30:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:12 INFO - 'download_minidump_stackwalk': True, 03:30:12 INFO - 'download_symbols': 'ondemand', 03:30:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:12 INFO - 'installer_path': 'installer.exe', 03:30:12 INFO - 'log_level': 'info', 03:30:12 INFO - 'log_name': 'talos', 03:30:12 INFO - 'log_to_console': True, 03:30:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:12 INFO - 'opt_config_files': (), 03:30:12 INFO - 'pip_index': False, 03:30:12 INFO - 'sps_profile': False, 03:30:12 INFO - 'sps_profile_interval': 0, 03:30:12 INFO - 'suite': 'dromaeojs', 03:30:12 INFO - 'system_bits': '32', 03:30:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:12 INFO - 'title': 'talos-linux64-ix-036', 03:30:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:12 INFO - 'use_talos_json': True, 03:30:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:12 INFO - 'work_dir': 'build'} 03:30:12 INFO - [mozharness: 2016-11-17 11:30:12.776703Z] Running clobber step. 03:30:12 INFO - Running pre-action listener: _resource_record_pre_action 03:30:12 INFO - Running main action method: clobber 03:30:12 INFO - rmtree: /builds/slave/test/build 03:30:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:13 INFO - Running post-action listener: _resource_record_post_action 03:30:13 INFO - [mozharness: 2016-11-17 11:30:13.253046Z] Finished clobber step (success) 03:30:13 INFO - [mozharness: 2016-11-17 11:30:13.253156Z] Running read-buildbot-config step. 03:30:13 INFO - Running pre-action listener: _resource_record_pre_action 03:30:13 INFO - Running main action method: read_buildbot_config 03:30:13 INFO - Using buildbot properties: 03:30:13 INFO - { 03:30:13 INFO - "project": "", 03:30:13 INFO - "product": "firefox", 03:30:13 INFO - "script_repo_revision": "production", 03:30:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:30:13 INFO - "repository": "", 03:30:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:30:13 INFO - "buildid": "20161117004016", 03:30:13 INFO - "stage_platform": "linux64-pgo", 03:30:13 INFO - "basedir": "/builds/slave/test", 03:30:13 INFO - "nightly_build": "True", 03:30:13 INFO - "buildnumber": 603, 03:30:13 INFO - "slavename": "talos-linux64-ix-036", 03:30:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:13 INFO - "platform": "ubuntu64_hw", 03:30:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:13 INFO - "branch": "mozilla-aurora", 03:30:13 INFO - "repo_path": "releases/mozilla-aurora", 03:30:13 INFO - "revision": "d86e4e3d92b082d1e86160ac182f8c73cd80597a", 03:30:13 INFO - "pgo_build": "True", 03:30:13 INFO - "builduid": "bf7f5794d2c24b5fa40e4a339be5456a", 03:30:13 INFO - "slavebuilddir": "test" 03:30:13 INFO - } 03:30:13 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:30:13 INFO - Running post-action listener: _resource_record_post_action 03:30:13 INFO - [mozharness: 2016-11-17 11:30:13.255625Z] Finished read-buildbot-config step (success) 03:30:13 INFO - [mozharness: 2016-11-17 11:30:13.255712Z] Running download-and-extract step. 03:30:13 INFO - Running pre-action listener: _resource_record_pre_action 03:30:13 INFO - Running main action method: download_and_extract 03:30:13 INFO - mkdir: /builds/slave/test/build/tests 03:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:13 INFO - trying https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:13 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:30:13 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:30:13 INFO - Downloaded 1361 bytes. 03:30:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:13 INFO - Using the following test package requirements: 03:30:13 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:13 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:13 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:13 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'jsshell-linux-x86_64.zip'], 03:30:13 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:13 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:13 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:13 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:13 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:13 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:13 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:13 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:13 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:30:13 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:30:13 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:30:14 INFO - Http code: 200 03:30:14 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 03:30:14 INFO - x-amz-cf-id: 7I-pUpJcVbVJ-3Jpa0tLLwqbsZwwSAjMjbaHhtpMKlfwKupQAuDnZw== 03:30:14 INFO - x-amz-version-id: TX9Au3UhIXM2kgd96J6hZ5r3oYbyPhld 03:30:14 INFO - Expected file size: 21999690 03:30:14 INFO - Obtained file size: 21999690 03:30:18 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:30:18 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:30:18 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:30:18 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:30:19 INFO - Http code: 200 03:30:19 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 03:30:19 INFO - x-amz-cf-id: 4zrN8cmXtJFzN-hzo5IyulcwvMdeNfc_sep4QPP7Bh3tgKtYWQ2wlg== 03:30:19 INFO - x-amz-version-id: TX9Au3UhIXM2kgd96J6hZ5r3oYbyPhld 03:30:19 INFO - Expected file size: 21999690 03:30:19 INFO - Obtained file size: 21999690 03:30:23 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:30:23 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:30:23 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:30:24 INFO - Http code: 200 03:30:24 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 03:30:24 INFO - x-amz-cf-id: 1urBFvNFdym8HHMGAerYGtx0wXB53JEW7qWQxF9SMNWQELaV0MnD8w== 03:30:24 INFO - x-amz-version-id: Mpf5lTmaVVCKGMj9eAD8DKCmhXVNn4p_ 03:30:24 INFO - Expected file size: 14409038 03:30:24 INFO - Obtained file size: 14409038 03:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:24 INFO - trying https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:24 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:30:24 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:30:26 INFO - Downloaded 63923661 bytes. 03:30:26 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:30:26 INFO - mkdir: /builds/slave/test/properties 03:30:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:26 INFO - Contents: 03:30:26 INFO - build_url:https://queue.taskcluster.net/v1/task/DZYGJshpRZy2TwUGKgiN7g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:26 INFO - Running post-action listener: _resource_record_post_action 03:30:26 INFO - Running post-action listener: set_extra_try_arguments 03:30:26 INFO - [mozharness: 2016-11-17 11:30:26.734133Z] Finished download-and-extract step (success) 03:30:26 INFO - [mozharness: 2016-11-17 11:30:26.734358Z] Running populate-webroot step. 03:30:26 INFO - Running pre-action listener: _resource_record_pre_action 03:30:26 INFO - Running main action method: populate_webroot 03:30:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:26 INFO - '--tppagecycles', 03:30:26 INFO - '7'], 03:30:26 INFO - 'tests': ['tsvgm']}}, 03:30:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['damp', 'tps']}, 03:30:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'tests': ['damp', 'tps']}, 03:30:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['dromaeo_dom']}, 03:30:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['basic_compositor_video']}, 03:30:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['a11yr', 03:30:26 INFO - 'ts_paint', 03:30:26 INFO - 'tpaint', 03:30:26 INFO - 'sessionrestore', 03:30:26 INFO - 'sessionrestore_no_auto_restore', 03:30:26 INFO - 'tabpaint']}, 03:30:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['tsvgx', 03:30:26 INFO - 'tsvgr_opacity', 03:30:26 INFO - 'tart', 03:30:26 INFO - 'tscrollx', 03:30:26 INFO - 'cart']}, 03:30:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:26 INFO - 'tsvgr_opacity', 03:30:26 INFO - 'tart', 03:30:26 INFO - 'tscrollx', 03:30:26 INFO - 'cart']}, 03:30:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'talos_options': ['--disable-e10s'], 03:30:26 INFO - 'tests': ['tp5o']}, 03:30:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'tests': ['tp5o']}, 03:30:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'talos_options': ['--disable-e10s', 03:30:26 INFO - '--xperf_path', 03:30:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:26 INFO - 'tests': ['tp5n']}, 03:30:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:26 INFO - 'talos_options': ['--xperf_path', 03:30:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:26 INFO - 'tests': ['tp5n']}}, 03:30:26 INFO - 'talos.zip': {'path': '', 03:30:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:26 INFO - Running post-action listener: _resource_record_post_action 03:30:26 INFO - [mozharness: 2016-11-17 11:30:26.751832Z] Finished populate-webroot step (success) 03:30:26 INFO - [mozharness: 2016-11-17 11:30:26.751919Z] Running create-virtualenv step. 03:30:26 INFO - Running pre-action listener: _resource_record_pre_action 03:30:26 INFO - Running main action method: create_virtualenv 03:30:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:26 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:30:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:26 INFO - Using real prefix '/usr' 03:30:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:29 INFO - Installing pip.................done. 03:30:29 INFO - Return code: 0 03:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:29 INFO - Reading from file tmpfile_stdout 03:30:29 INFO - Output received: 03:30:29 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:30:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:29 INFO - Using env: {'DISPLAY': ':0', 03:30:29 INFO - 'HOME': '/home/cltbld', 03:30:29 INFO - 'LANG': 'en_US.UTF-8', 03:30:29 INFO - 'LANGUAGE': 'en_US:en', 03:30:29 INFO - 'LOGNAME': 'cltbld', 03:30:29 INFO - 'MAIL': '/var/mail/cltbld', 03:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:29 INFO - 'MOZ_NO_REMOTE': '1', 03:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:29 INFO - 'NO_EM_RESTART': '1', 03:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:29 INFO - 'PWD': '/builds/slave/test', 03:30:29 INFO - 'SHELL': '/bin/bash', 03:30:29 INFO - 'SHLVL': '1', 03:30:29 INFO - 'TERM': 'linux', 03:30:29 INFO - 'TMOUT': '86400', 03:30:29 INFO - 'USER': 'cltbld', 03:30:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:29 INFO - '_': '/tools/buildbot/bin/python'} 03:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:29 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:30:29 INFO - Cleaning up... 03:30:29 INFO - Return code: 0 03:30:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:30:29 INFO - Using env: {'DISPLAY': ':0', 03:30:29 INFO - 'HOME': '/home/cltbld', 03:30:29 INFO - 'LANG': 'en_US.UTF-8', 03:30:29 INFO - 'LANGUAGE': 'en_US:en', 03:30:29 INFO - 'LOGNAME': 'cltbld', 03:30:29 INFO - 'MAIL': '/var/mail/cltbld', 03:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:29 INFO - 'MOZ_NO_REMOTE': '1', 03:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:29 INFO - 'NO_EM_RESTART': '1', 03:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:29 INFO - 'PWD': '/builds/slave/test', 03:30:29 INFO - 'SHELL': '/bin/bash', 03:30:29 INFO - 'SHLVL': '1', 03:30:29 INFO - 'TERM': 'linux', 03:30:29 INFO - 'TMOUT': '86400', 03:30:29 INFO - 'USER': 'cltbld', 03:30:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:29 INFO - '_': '/tools/buildbot/bin/python'} 03:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:29 INFO - Downloading/unpacking psutil>=3.1.1 03:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:32 INFO - Installing collected packages: psutil 03:30:32 INFO - Running setup.py install for psutil 03:30:32 INFO - building 'psutil._psutil_linux' extension 03:30:32 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:30:32 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:30:32 INFO - building 'psutil._psutil_posix' extension 03:30:32 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:30:32 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:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:32 INFO - Successfully installed psutil 03:30:32 INFO - Cleaning up... 03:30:32 INFO - Return code: 0 03:30:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:32 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:32 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:30:32 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:30:32 INFO - Using env: {'DISPLAY': ':0', 03:30:32 INFO - 'HOME': '/home/cltbld', 03:30:32 INFO - 'LANG': 'en_US.UTF-8', 03:30:32 INFO - 'LANGUAGE': 'en_US:en', 03:30:32 INFO - 'LOGNAME': 'cltbld', 03:30:32 INFO - 'MAIL': '/var/mail/cltbld', 03:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:32 INFO - 'MOZ_NO_REMOTE': '1', 03:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:32 INFO - 'NO_EM_RESTART': '1', 03:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:32 INFO - 'PWD': '/builds/slave/test', 03:30:32 INFO - 'SHELL': '/bin/bash', 03:30:32 INFO - 'SHLVL': '1', 03:30:32 INFO - 'TERM': 'linux', 03:30:32 INFO - 'TMOUT': '86400', 03:30:32 INFO - 'USER': 'cltbld', 03:30:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:32 INFO - '_': '/tools/buildbot/bin/python'} 03:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:34 INFO - Installing collected packages: mozsystemmonitor 03:30:34 INFO - Running setup.py install for mozsystemmonitor 03:30:34 INFO - Successfully installed mozsystemmonitor 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:34 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:34 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:30:34 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:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:37 INFO - warning: no files found matching '*.txt' 03:30:37 INFO - no previously-included directories found matching 'build' 03:30:37 INFO - no previously-included directories found matching 'dist' 03:30:37 INFO - no previously-included directories found matching '.git*' 03:30:37 INFO - Installing collected packages: jsonschema, functools32 03:30:37 INFO - Running setup.py install for functools32 03:30:37 INFO - warning: no files found matching '*.txt' 03:30:37 INFO - no previously-included directories found matching 'build' 03:30:37 INFO - no previously-included directories found matching 'dist' 03:30:37 INFO - no previously-included directories found matching '.git*' 03:30:37 INFO - Successfully installed jsonschema functools32 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:37 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:30:37 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:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:37 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:30:37 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:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:38 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:38 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:38 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:38 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:38 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:38 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:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:40 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:40 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:40 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:40 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:40 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:40 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:40 INFO - Downloading docopt-0.6.1.tar.gz 03:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:40 INFO - Running setup.py install for blobuploader 03:30:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:40 INFO - Running setup.py install for requests 03:30:41 INFO - Running setup.py install for docopt 03:30:41 INFO - Successfully installed blobuploader requests docopt 03:30:41 INFO - Cleaning up... 03:30:41 INFO - Return code: 0 03:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:41 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:41 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:30:41 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:30:41 INFO - Using env: {'DISPLAY': ':0', 03:30:41 INFO - 'HOME': '/home/cltbld', 03:30:41 INFO - 'LANG': 'en_US.UTF-8', 03:30:41 INFO - 'LANGUAGE': 'en_US:en', 03:30:41 INFO - 'LOGNAME': 'cltbld', 03:30:41 INFO - 'MAIL': '/var/mail/cltbld', 03:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:41 INFO - 'MOZ_NO_REMOTE': '1', 03:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:41 INFO - 'NO_EM_RESTART': '1', 03:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:41 INFO - 'PWD': '/builds/slave/test', 03:30:41 INFO - 'SHELL': '/bin/bash', 03:30:41 INFO - 'SHLVL': '1', 03:30:41 INFO - 'TERM': 'linux', 03:30:41 INFO - 'TMOUT': '86400', 03:30:41 INFO - 'USER': 'cltbld', 03:30:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:41 INFO - '_': '/tools/buildbot/bin/python'} 03:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:41 INFO - Running setup.py (path:/tmp/pip-C7ULcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:41 INFO - Running setup.py (path:/tmp/pip-Ww4rKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:41 INFO - Running setup.py (path:/tmp/pip-yg84Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:41 INFO - Running setup.py (path:/tmp/pip-GNoki3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:41 INFO - Running setup.py (path:/tmp/pip-w7aVu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:41 INFO - Running setup.py (path:/tmp/pip-hPVvtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:42 INFO - Running setup.py (path:/tmp/pip-fOw9_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:42 INFO - Running setup.py (path:/tmp/pip-CgV44g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:42 INFO - Running setup.py (path:/tmp/pip-b40PE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:42 INFO - Running setup.py (path:/tmp/pip-UEadfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:42 INFO - Running setup.py (path:/tmp/pip-AX1Wyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:42 INFO - Running setup.py (path:/tmp/pip-VCL8fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:42 INFO - Running setup.py (path:/tmp/pip-bWkMva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:42 INFO - Running setup.py (path:/tmp/pip-7_UG9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:42 INFO - Running setup.py (path:/tmp/pip-In_YbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:42 INFO - Running setup.py (path:/tmp/pip-x2f1GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:42 INFO - Running setup.py (path:/tmp/pip-ljFBkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:42 INFO - Running setup.py install for manifestparser 03:30:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:42 INFO - Running setup.py install for mozcrash 03:30:43 INFO - Running setup.py install for mozdebug 03:30:43 INFO - Running setup.py install for mozdevice 03:30:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozfile 03:30:43 INFO - Running setup.py install for mozhttpd 03:30:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozinfo 03:30:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozInstall 03:30:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozleak 03:30:43 INFO - Running setup.py install for mozlog 03:30:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for moznetwork 03:30:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozprocess 03:30:44 INFO - Running setup.py install for mozprofile 03:30:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozrunner 03:30:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozscreenshot 03:30:44 INFO - Running setup.py install for moztest 03:30:44 INFO - Running setup.py install for mozversion 03:30:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:44 INFO - Cleaning up... 03:30:44 INFO - Return code: 0 03:30:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 03:30:44 INFO - 'HOME': '/home/cltbld', 03:30:44 INFO - 'LANG': 'en_US.UTF-8', 03:30:44 INFO - 'LANGUAGE': 'en_US:en', 03:30:44 INFO - 'LOGNAME': 'cltbld', 03:30:44 INFO - 'MAIL': '/var/mail/cltbld', 03:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:44 INFO - 'MOZ_NO_REMOTE': '1', 03:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:44 INFO - 'NO_EM_RESTART': '1', 03:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:44 INFO - 'PWD': '/builds/slave/test', 03:30:44 INFO - 'SHELL': '/bin/bash', 03:30:44 INFO - 'SHLVL': '1', 03:30:44 INFO - 'TERM': 'linux', 03:30:44 INFO - 'TMOUT': '86400', 03:30:44 INFO - 'USER': 'cltbld', 03:30:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:44 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:44 INFO - Running setup.py (path:/tmp/pip-GOdThc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:44 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:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:44 INFO - Running setup.py (path:/tmp/pip-CFU8O6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:45 INFO - Running setup.py (path:/tmp/pip-hZeJBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:45 INFO - Running setup.py (path:/tmp/pip-_fHCwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:45 INFO - Running setup.py (path:/tmp/pip-dzwBTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:45 INFO - Running setup.py (path:/tmp/pip-Bx76In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:45 INFO - Running setup.py (path:/tmp/pip-q7dLCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:45 INFO - Running setup.py (path:/tmp/pip-mgQ7aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:45 INFO - Running setup.py (path:/tmp/pip-JeENSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:45 INFO - Running setup.py (path:/tmp/pip-RUK2ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:45 INFO - Running setup.py (path:/tmp/pip-wOKozQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:45 INFO - Running setup.py (path:/tmp/pip-b3D3Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:45 INFO - Running setup.py (path:/tmp/pip-ljKDBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:45 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:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:45 INFO - Running setup.py (path:/tmp/pip-2H8I9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:45 INFO - Running setup.py (path:/tmp/pip-y0D4Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:45 INFO - Running setup.py (path:/tmp/pip-e09lqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:46 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:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:46 INFO - Running setup.py (path:/tmp/pip-cWH4PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - Downloading blessings-1.6.tar.gz 03:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:48 INFO - Installing collected packages: blessings 03:30:48 INFO - Running setup.py install for blessings 03:30:48 INFO - Successfully installed blessings 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:48 INFO - Reading from file tmpfile_stdout 03:30:48 INFO - Current package versions: 03:30:48 INFO - argparse == 1.2.1 03:30:48 INFO - blessings == 1.6 03:30:48 INFO - blobuploader == 1.2.4 03:30:48 INFO - docopt == 0.6.1 03:30:48 INFO - functools32 == 3.2.3-2 03:30:48 INFO - jsonschema == 2.5.1 03:30:48 INFO - manifestparser == 1.1 03:30:48 INFO - mozInstall == 1.12 03:30:48 INFO - mozcrash == 1.0 03:30:48 INFO - mozdebug == 0.1 03:30:48 INFO - mozdevice == 0.48 03:30:48 INFO - mozfile == 1.2 03:30:48 INFO - mozhttpd == 0.7 03:30:48 INFO - mozinfo == 0.9 03:30:48 INFO - mozleak == 0.1 03:30:48 INFO - mozlog == 3.4 03:30:48 INFO - moznetwork == 0.27 03:30:48 INFO - mozprocess == 0.23 03:30:48 INFO - mozprofile == 0.28 03:30:48 INFO - mozrunner == 6.13 03:30:48 INFO - mozscreenshot == 0.1 03:30:48 INFO - mozsystemmonitor == 0.3 03:30:48 INFO - moztest == 0.7 03:30:48 INFO - mozversion == 1.4 03:30:48 INFO - psutil == 3.1.1 03:30:48 INFO - requests == 1.2.3 03:30:48 INFO - wsgiref == 0.1.2 03:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 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:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 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 0x7fbd755aff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', '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:48 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:48 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:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Running post-action listener: _resource_record_post_action 03:30:48 INFO - Running post-action listener: _start_resource_monitoring 03:30:48 INFO - Starting resource monitoring. 03:30:48 INFO - [mozharness: 2016-11-17 11:30:48.990796Z] Finished create-virtualenv step (success) 03:30:48 INFO - [mozharness: 2016-11-17 11:30:48.991300Z] Running install step. 03:30:48 INFO - Running pre-action listener: _resource_record_pre_action 03:30:48 INFO - Running main action method: install 03:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:49 INFO - Reading from file tmpfile_stdout 03:30:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:49 INFO - Reading from file tmpfile_stdout 03:30:49 INFO - Output received: 03:30:49 INFO - Usage: mozinstall [options] installer 03:30:49 INFO - Options: 03:30:49 INFO - -h, --help show this help message and exit 03:30:49 INFO - -d DEST, --destination=DEST 03:30:49 INFO - Directory to install application into. [default: 03:30:49 INFO - "/builds/slave/test"] 03:30:49 INFO - --app=APP Application being installed. [default: firefox] 03:30:49 INFO - mkdir: /builds/slave/test/build/application 03:30:49 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:49 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:31:05 INFO - Reading from file tmpfile_stdout 03:31:05 INFO - Output received: 03:31:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:05 INFO - Running post-action listener: _resource_record_post_action 03:31:05 INFO - [mozharness: 2016-11-17 11:31:05.195914Z] Finished install step (success) 03:31:05 INFO - [mozharness: 2016-11-17 11:31:05.196156Z] Running run-tests step. 03:31:05 INFO - Running pre-action listener: _resource_record_pre_action 03:31:05 INFO - Running main action method: run_tests 03:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:05 INFO - Python 2.7.3 03:31:05 INFO - Return code: 0 03:31:05 INFO - grabbing minidump binary from tooltool 03:31: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:31:05 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 0x21c0f60>, '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 0x21c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21c21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:05 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:31:05 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:31:05 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:31:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:05 INFO - Return code: 0 03:31:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:05 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', '--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-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:31:05 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 --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-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:31:05 INFO - Using env: {'DISPLAY': ':0', 03:31:05 INFO - 'HOME': '/home/cltbld', 03:31:05 INFO - 'LANG': 'en_US.UTF-8', 03:31:05 INFO - 'LANGUAGE': 'en_US:en', 03:31:05 INFO - 'LOGNAME': 'cltbld', 03:31:05 INFO - 'MAIL': '/var/mail/cltbld', 03:31:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:05 INFO - 'MOZ_NO_REMOTE': '1', 03:31:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:05 INFO - 'NO_EM_RESTART': '1', 03:31:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:05 INFO - 'PWD': '/builds/slave/test', 03:31:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:05 INFO - 'SHELL': '/bin/bash', 03:31:05 INFO - 'SHLVL': '1', 03:31:05 INFO - 'TERM': 'linux', 03:31:05 INFO - 'TMOUT': '86400', 03:31:05 INFO - 'USER': 'cltbld', 03:31:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450', 03:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:05 INFO - '_': '/tools/buildbot/bin/python'} 03:31:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:31:05 INFO - mozversion application_buildid: 20161117004016 03:31:05 INFO - mozversion application_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 03:31:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:05 INFO - mozversion application_name: Firefox 03:31:05 INFO - mozversion application_remotingname: firefox-dev 03:31:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:05 INFO - mozversion application_vendor: Mozilla 03:31:05 INFO - mozversion application_version: 52.0a2 03:31:05 INFO - mozversion platform_buildid: 20161117004016 03:31:05 INFO - mozversion platform_changeset: d86e4e3d92b082d1e86160ac182f8c73cd80597a 03:31:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:05 INFO - mozversion platform_version: 52.0a2 03:31:05 INFO - using testdate: 1479382265 03:31:05 INFO - actual date: 1479382265 03:31:05 INFO - starting webserver on 'localhost:46342' 03:31:05 INFO - SUITE-START | Running 2 tests 03:31:05 INFO - TEST-START | dromaeo_css 03:31:05 INFO - operating with platform_type : linux_ 03:31:05 INFO - Initialising browser for dromaeo_css test... 03:31:05 INFO - TEST-INFO | started process 30543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsggrCL/profile http://localhost:46342/getInfo.html) 03:31:08 ERROR - PROCESS | 30543 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:31:09 INFO - PROCESS | 30543 | __metrics Screen width/height:1600/1200 03:31:09 INFO - PROCESS | 30543 | colorDepth:24 03:31:09 INFO - PROCESS | 30543 | Browser inner width/height: 1024/697 03:31:09 INFO - PROCESS | 30543 | __metrics 03:31:10 INFO - PROCESS | 30543 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:31:10 INFO - PROCESS | 30543 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:10 INFO - PROCESS | 30543 | console.error: PushService: 03:31:10 INFO - PROCESS | 30543 | stateChangeProcessEnqueue: Error transitioning state 03:31:10 INFO - PROCESS | 30543 | UnknownError 03:31:11 INFO - TEST-INFO | 30543: exit 0 03:31:11 INFO - Browser initialized. 03:31:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:11 INFO - TEST-INFO | started process 30635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsggrCL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:23 INFO - PROCESS | 30635 | RSS: Main: 147750912 03:31:23 INFO - PROCESS | 30635 | 03:32:14 INFO - PROCESS | 30635 | 1479382334783 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:34:25 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46342/tests/dromaeo/cssquery-ext.html) 03:34:26 INFO - PROCESS | 30635 | RSS: Main: 233332736 03:34:26 INFO - PROCESS | 30635 | 03:37:28 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-ext.html (next: http://localhost:46342/tests/dromaeo/cssquery-jquery.html) 03:37:29 INFO - PROCESS | 30635 | RSS: Main: 225329152 03:37:29 INFO - PROCESS | 30635 | 03:40:31 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46342/tests/dromaeo/cssquery-mootools.html) 03:40:31 INFO - PROCESS | 30635 | RSS: Main: 175616000 03:40:31 INFO - PROCESS | 30635 | 03:43:33 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46342/tests/dromaeo/cssquery-prototype.html) 03:43:34 INFO - PROCESS | 30635 | RSS: Main: 198115328 03:43:34 INFO - PROCESS | 30635 | 03:46:37 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46342/tests/dromaeo/cssquery-yui.html) 03:46:37 INFO - PROCESS | 30635 | RSS: Main: 175190016 03:46:37 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | Cycle 1(1): loaded http://localhost:46342/tests/dromaeo/cssquery-yui.html (next: http://localhost:46342/tests/dromaeo/cssquery-dojo.html) 03:49:40 INFO - PROCESS | 30635 | RSS: Main: 267452416 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | __start_tp_report 03:49:40 INFO - PROCESS | 30635 | _x_x_mozilla_page_load 03:49:40 INFO - PROCESS | 30635 | _x_x_mozilla_page_load_details 03:49:40 INFO - PROCESS | 30635 | |i|pagename|runs| 03:49:40 INFO - PROCESS | 30635 | |0;dojo.html;3228.4188846007714;3258.788178768379;3276.230085929806;3293.654166312536;3315.0883507035564;5582.385937546866;5598.244237028;5647.43525647435;5658.490735833774;5692.231548740924;5631.63394379365;5704.54363650908;5706.1440783882435;5718.885622287552;5756.597038207327;5117.744112794355;5176.844694659167;5193.246979188016;5217.34783152106;5254.054270231357;5072.67027643202;5234.973825130869;5252.658577192489;5275.419703832576;5280;5052.9747351263195;5094.363204599425;5120.769565369567;5136.895567453015;5149.433562308143;5182.948170518303;5212.4266330703595;5233.136532472137;5298.761555729963;5308.8141915033175;5122;5166.793328266903;5237.16205407133;5246.737663116829;5273;5475.06923822951;5535.114381698909;5536.114221724545;5552.77788888444;5584.776608935637;5949.553783466214;5969.850753731148;6130.049842274455;6134.17188679527;6138.202033735631;6154.261488621394;6183.690815459209;6191.473724733403;6202.317745048041;6203.1005504202085;5553.4724201200825;5591.944080559224;5593.580481463907;5616.66300022;5629.324481062217;6176;6190;6192.256929168529;6210.7515699371515;6212.596181248205;5961.582689211714;5964.373740757244;5965.254343207099;5966.552508561788;5979;5876.7355469004;5907.202527658797;5992.520598352121;6032.939670603326;6037.486813620892;6016.909746353808;6026.819195424145;6042.6072305300895;6064.514838812885;6077.118817771398;6020.729067191987;6032.547558933097;6081.787137450168;6083.330833608299;6105.8168254952425;4523.977380113079;4554.36238926544;4572.1312950539295;4600;4660.930086048712;4130.235906357273;4134.710570260113;4165.396017577495;4165.97917010413;4180.707350485498;5738.68437235956;5755.165501002415;5759.107338362561;5759.769609215585;5762.337331206881;5904.143899134688;6036.305824830113;6051.969740151271;6060.090986352083;6098.054801505774;5558.166275058693;5641.294838145232;5688.829335119953;5694.515966142924;5768.855778605484;5092.38891333035;5126.333576635014;5136.049830781318;5141.38303403594;5156.2523434102595;6237.4698150657705;6281.497480201573;6314.810555683337;6318.462930650946;6319.747210111544;5881.794137205177;5928.407159284037;6013.819585412444;6082.7262773174425;6112.602680825732;6342.556021078664;6347.460465860268;6357.650329231937;6359.17330747;6359.96820015897;5976.8804623908145;6027.156198132177;6035.185249991195;6044.667543284985;6051.364606716232;5875.970620146872;5920.289565252025;5966.850828729316;6014.48876845473;6152.661603611844;5971.044632858721;5976.073708575178;5992.580519363602;6008.068749343859;6023.1266466363;5807.361190269152;5864.384239654945;5866.7066646668345;5871.383504732113;5871.588988770916;5653.491185793134;5687.77248910039;5855.707214639337;5932.377100404396;5933.584649074523;5871.588988770745;5907.556933229939;5932.2584676915385;6015.578909476295;6041.728122234598;5797.333306669619;5807.157962095388;5849.1226316052935;5856.238688970407;5888.3228428731245 03:49:40 INFO - PROCESS | 30635 | |1;ext.html;584.3396961433582;623.4544773323342;650.3496503496503;663.505688262245;670.3765498086777;34513.65486345136;44640;45732.31401528972;45914.770426147865;49111;45529.77235113828;45877.31184032242;45921.77039114808;45980.310295345516;46177.769111154485;8461.450005749606;8819.691310804106;8950.776230594221;8965.551722413886;8972.955135224347;8387.706430274942;8627.396082274212;8628.784280392978;10755.354678719303;11030.669079927615;10848.457577121151;10901.672949811518;10904.01863832255;10906.781864362709;10906.836397454044;10646.680599582025;10667.093297069758;10705.732356691067;10710;10714.571417143305;10625.309354891908;10725.731856703567;10740.516676749565;10742.677719668422;10749.193810464169;43092.56907430917;43432.56567434348;43452.3482147768;43493.13013739708;43495.34756978648;3659.0120667419915;3748.4377343398437;3764.6611804937415;3955.129871428281;4283.87148385549;32406.189845253823;32429.189270268194;32586;32731.345373092405;32826.17934551631;4342.848000320006;4414.602685758297;4438.533953934855;4442.267025940716;4544.659150563721;357326;362386;364079;364212;364422;60684.696576516835;60954.69522652358;61043.6947815267;61069.38930610726;61124.388756112756;39883.60116398857;40780.18439631191;41029.384559231636;43409;43456.78271608685;17646.735298970525;17779.377721779936;17796.37712680076;17801.397874191127;17806.109694515224;13492.257925813978;13508.594742157751;13514.05401621877;13523.188608683511;13564.593062208149;18463.723044154347;18769;19508.987941365427;20540.486487837625;20545.383638490868;7243.5653860768525;7435.665395057235;7439.665215065335;7453.664585093684;7531.887021694679;1037.8339465685453;1086.21792309537;1092.7541303206874;1126.0709914320719;1151.090638395658;33238.66761332356;33260;33261;33317.83341083279;34130.82934585311;1065.63235683689;1175.8530183727034;1182.9112816538793;1193.117093350914;1201.8077107662732;15888.364465421253;17513.211905464286;17694.734578981326;17987.550311242325;18126.365577204735;496022;498967;499628;500995;501947;60927.695361523794;61713.69143154255;61715;61814.381856180866;62091.37908620856;1346.3537501999094;1377.2218696436482;1380.0339762166523;1435.5549779568366;1461.400825661495;29426.558601620563;33836;33880.49179262362;33898.322033558696;34010.82994585011;52375.47624523706;52911.470885290655;52912.470875292296;52956;52956.73521632367;378977;379794;379949;380830;383273;30137.246568835955;30256.84871575628;30675.84662076675;30926.381472369976;32232.516512252805;49300.26049609187;49523.50476495189;49680.50319496759;50956.74521627368;51196.232056519926;41540.79229603833;42285.788571056946;43115.56884431116;43539;44114;42883.7855810719;43129.56870431256;43669.56330436655;43683.78158109189;43957.56042439535;41547.7922610385;41585.79207104066;42022;42177.36733949055;42464.36303455389;36464;37353.252934941695;38252.617473826016;38563;38784.80607597057;28528.14567053135;28678.283042924093;28726.569101463076;28929.42141157207;28979.275518112216 03:49:40 INFO - PROCESS | 30635 | |2;jquery.html;392.1842567459684;416.88535652695504;428.4301878501592;432.5739146940263;443.3482780312941;14980.325885335158;19402.021726610124;20156;20341.28805491808;20543.691844622343;19467.513312167204;19707.113179906904;20306.796932030677;20374.185032598678;20675.689864652042;5593.74828132734;5839.357670656224;5840.328362238333;5841.15303281024;5846.707664616773;5458.372287186965;5697.287839020122;5731.426857314277;5732.656040637554;5734.627249228808;5699.373068962432;5700.144978253254;5702.486776190142;5706.857328566777;5713.800016999406;5523.061079616475;5682.687452190128;5690.516306113986;5714.79998200061;5720.942790572103;5055.064813009605;5118.820841270538;5131.435542090367;5137.152369858969;5141.665791723526;20099.39701808948;20516.179352825868;20556.177752889867;22984.310470685905;24287.514249714906;2711.200195942202;2800.047983685536;2808.0452646100425;2878.2228798224573;2882.9135125946254;14390.208538530376;14890.553283401407;15314.234288285541;15485.458008969745;15700.76448853268;1976.456474469518;1990.5919286546368;2007.5382661987824;2010.1155491583656;2069.244725675133;87813;89143.55428222883;90585;90757.54621226918;91293.54353228191;10539.683809485574;11547.191696581327;11627;11788.823167652492;12156.452959616838;15663.68672626564;16114.919425403032;16161.111138887474;16165.515034548747;16211.189440527927;8360.707375241838;8464.238218560358;8487.957560212159;8537.53043582609;8605.870911936327;8145.877811832827;8199.385046121564;8278.254957053894;8364.623591938378;8422;4975.228839529878;5130.615203859726;5147.613928955268;5162.896742065138;5181.922271165936;2094.8009939055764;2113.17586141405;2130.6910497978015;2139.9144034238766;2157.094020511389;965.0397854135181;993.6174572789528;1017.2269075502523;1026.1175389165312;1061.4003088255265;19550.120244589027;20063.799362006484;20217.090230939644;20280.695789563168;20336.898315508326;1016.3393794033938;1019.2966852871494;1029.2280789407944;1037.2479952034714;1049.1134990932649;10198.269414602637;10813.891256516526;10974.451277436096;11017.228793984345;11150.163737719704;479066;479545;481744;487212;490288;89656;92304;92539.53730231305;92651.5367423172;93923;1016.7102375822855;1021.341234903483;1025.8615086963314;1028.0695970147028;1028.2699283508794;16943.491695248667;17097;17256.482305530855;17684.91157544204;17831.73252401241;40168.196636067696;40569.59430405776;41874;42985;43101.3534796972;56860.715696421255;57104.714476427354;57177.71411143084;57620.71189644025;59351.70324148352;8606.612702428281;8674;8793.956030220064;8800.38397312182;8924.598393072198;9776.1690256329;11738.94130529342;11807.527698891949;11929;12941.28822914711;10718.89281107179;11109.666709998713;11221.214514983873;11289.322640641587;11487.655370338904;10831.729206769895;11180.385078820744;11343.262687925258;11655.708607284547;11720;10861.185411094042;10895.237333386904;10898.891011089787;11204.607838725606;11257.71855703614;7915.287624113857;8250;9144.26845852317;9229.307801914749;9474.005229450808;11774.882251177378;11920.105992050458;12032;12152.392380380768;12184.756304873676 03:49:40 INFO - PROCESS | 30635 | |3;mootools.html;1414.8302203735552;1508.8642022218003;1528.1595122682525;1660.709375859225;1798.5054110119725;7698.345640620547;8628.223459888608;8941.463512189273;8965.372423930328;9168.12902774237;8954.373193876416;9022.413543119708;9028.052054534277;9028.90971090289;9044.412113212653;2512.032867346076;2535.492901419714;2538.1370334086405;2541.390066384073;2542.415244493758;2391.9162829300976;2513.5978243481045;2519.571672815626;2525.936851578707;2530.089167899564;2318.8376813623054;2322.349742072214;2403.9158629447975;2407.0492155598527;2411.035585765699;2462.249014050714;2464.4578192797558;2469.5307891500556;2477.6283557466345;2495.43852633157;2397.2328854766483;2421.8425802322795;2425.5755242832433;2430.9392265193333;2435.4641978764644;8969.551522423853;8999.370044096915;9050.321225908017;9070.591823367964;9153.22197613197;5421.186821976696;5588.1059030555325;5602.411746766612;5667.829965101054;5679.233303504016;3552.3605750964816;3661.176235347052;3705.3515634764076;3713.925721485555;3725.0873535983856;1091.1816137896578;1102.509383324421;1107.2747350485445;1119.6864877834219;1134.3194083549804;12847.35763211845;12913.289769062698;12970;13013.154144980546;13036.283004434847;4757.191277482836;4853.320535125085;4860.270959356125;4937.8271760488215;4962.578180854595;10263.076323130954;10285.588576456857;10288.176945844314;10296.176305895511;10297.845532317022;5437.021336159451;5533.972330138324;5541.833744987657;5545.223668686387;5548.167774833726;4409.404730361424;4495.730256184639;4705.223638099744;5162.767675454614;5166.5866730661455;3982.143839074613;4073.3075377185355;4079.265732168179;4172.248995180897;4175.645070169009;1231.5566396097397;1272.6945533071996;1276.8403949506312;1286.2925391034894;1286.8584455709865;966.1787480641399;1053.4627340056472;1060.575769692114;1066.386827574148;1067.5356220044305;6269.749210031548;6309.305976342599;6391.6804159792755;6462.838429039311;6619;500.19468655464675;508.5346907579523;513.1456125550991;515.3635260453337;517.0873408434117;4461.888452788641;4468.4637843458995;4532.388127602798;4534.455865296186;4547.295169248771;11073.169512286611;11437.256578322382;11491.138164637685;11558.768824623461;11558.826617600742;10645.254832161674;11088;11192.328460292409;11307.321560706385;11318.26431281964;8405.873911891327;8617.224449799549;8620.396572239883;8624.051354351017;8634.136586341316;6247.5001999840815;6412.775552855815;6490.188726409199;6494.253160886369;6555.573887697476;9807.521527853976;9931.354461959949;9942.204623629948;10060.69817905464;10139.391636501834;9409.905900941178;9741.561629726537;10420.426876521864;10443.68668939933;10449.529771160163;7878.724244651639;7888.447808653339;8046.798830029062;8131.105578386255;8319.708810191856;8818.647254110021;9125.498097604695;9131.406458580172;9136.360454768102;9141.222996045411;8000.279974802295;8008.799780005546;8079.6768129276525;8108.2297181767635;8206.671733130846;7902.288794008567;7938.64276107565;7944.483608565425;8098.51408915467;8104;7260.782176534713;7289.781306560812;7372.299631534996;7443.106827180773;7479.728446164057;5422.267993820784;5493.780248790164;5635.239242702182;5676.716164191691;5741.0527263002805;5420.701861397661;5604.439556044363;5765.56758243125;5802.796902108406;5817.214676018683 03:49:40 INFO - PROCESS | 30635 | |4;prototype.html;343.12674244048895;355.57686353239626;358.18155514649015;358.86004458261266;359.33881657749737;5330;5359.59803014774;5397.62216644835;5402.810901618444;5432.728363581825;5051.459304912;5078.603384069383;5126.897462050757;5179.818706345279;5238.345206849144;4232.978835105828;4239.215745087154;4242.300020496615;4245.384419259206;4256.2338779019765;4212.4945006599255;4242.703010789231;4243.936340954888;4268.103698223377;4270.722403043807;3884.1063407761258;3952.407138929155;4087.734297270683;4163.125743593849;4206.558311377307;4142.399352093959;4148.751074935513;4154.646855017327;4159.83360665573;4170.436991006206;3707.796071216082;3714.7028237741188;3718.200586873808;3720.9813950930343;3734.8879533614036;5121.74517243274;5149.948500515022;5192.818251361185;5245.396779370383;5265.447128051576;4741.525847415265;4777.5222477752295;4782.426108866924;4801.591864691505;4812.927806082912;5538.390777014565;5553.389127196006;5564.443555644443;5584.46947539983;5586.301712285965;3932.4101384792225;4070.837166513336;4125.876223713293;4130.409792229983;4134.235166494178;5746.224259724925;5763.884722305573;5765.971170144165;5773.278340207474;5780.248567686174;4199.580041995837;4217.725847819943;4228.746275223496;4229.323308270662;4237.915241695149;4037.475128233311;4201.222773786798;4297.183535128315;4298.46269216348;4300.720453170534;4767.785449654774;4783.545563171563;4789.425268967746;4790.281457781361;4799.832005879847;5618.747156377973;5621.269234999424;5633.155026745939;5639.295088113986;5646.802361917313;1365.7609918264263;1413.5264686329988;1415.2852809331223;1423.8504956979575;1431.2128329418986;935.2471260635253;953.8950715421298;1015.6496008876926;1056.6724315462232;1059.5338051257422;5170.97414512925;5193.195054766517;5196.92204616931;5211.228182417996;5254.65844720092;5576.804811831566;5576.972115139399;5584.776608935678;5589.273394458694;5649.887002259932;5173.146430838945;5232.514555586143;5236.188390799356;5285.577153827685;5289.523942845162;2906.4041871416307;2912.301047748525;2913.606663100497;2923.4213524696424;2944.263934016496;5531.170324451284;5662.37713851476;5704.543636509153;5707.6575405475805;5712.571557133231;5534.833954981357;5538;5584.692841893735;5587.631030397579;5600.243967064475;5659.830205093772;5660.122680984454;5686.402927692616;5706.457886500942;5717.399673034354;5290.603204759582;5438.184272359178;5444.809431670031;5451.400345961862;5453.945460545502;5398.64908780928;5398.78404863801;5433.9456605435025;5434.581611183144;5440.891182176413;5508.20131080983;5694.629849059798;5695.930621746732;5723.7407770290465;5734.971325143514;4088.99458897704;4134.297169481256;4135.710500264952;4142.502899652061;4174.436451079187;5501.229827824028;5510.724463776875;5532.419095994863;5532.612717109763;5632.915506267327;5087.847364579068;5346.78612855497;5410.161424979135;5470.659688376214;5474.562035037108;5251.842444726664;5253.634055145613;5254.185601231815;5264.4735526448585;5286.97356513215;5208.557272631869;5270.367555893164;5291.285676433632;5318.7074710891275;5371.838844834661;5448.785216722153;5580.107182850725;5586.581006424453;5593.636413633101;5599.984005758005;5391.649542779707;5441.340391180728;5450.700211488248;5458.007827143144;5471.72641367938 03:49:40 INFO - PROCESS | 30635 | |5;yui.html;786.1431040166218;789.1280135450323;791.7189397763793;854.2013217641505;881.2289246908955;14375.2812359382;15074.1551179188;15741.291641876114;15896.04623722576;15917.204139793022;14096.64758381041;14282.571522854305;14408.35162417691;14635.12189268642;14650.487232946849;713.8572285542887;848.8429640516508;863.4905405810571;865.4288169807928;865.9004214515317;724.7753196509072;846.1411667157809;862.0302160069921;866.7573079537708;868.5657171414293;918.3663272342096;919.9586018629144;920.691568324612;920.7191806499015;920.9079092090805;742.4431676242818;911.4850109688072;913.0960349254224;913.2693844924067;913.4793167894303;561.2675458526621;646.7510008646658;659.6240143118424;661.794843598486;666.183924692253;13210.933945330213;13213.471461141542;13224.867751322556;13228.404721787543;13252.668683282898;13385.330733463288;13402.530911418053;13543.051986360959;13617.251051192181;13818.239996800172;12766.744665106646;12900.09699321048;13059.216447013114;13171.538996135088;13234.801477977839;4416.24923762961;4433.290673492225;4455.908302465884;4456.8885777855485;4567.634589232854;56099;57837;57908;65941.01088483725;66535;11459.942700286612;11698.766024679458;11861.229020113666;11886.940565297118;11933.58232461877;20710.79289207119;20885.164593416397;21049.579008419747;21107.26124585632;21224.469388265108;8653.437526560754;8677.39258251929;8753.781155471164;8757.2994160467;8780.297576193889;4691.483936766953;4762.690425122425;4954.256861470736;5054.317667114966;5069.239614057921;3524.242287908061;3641.8543258269374;3673.081729567608;3679.0066681995713;3696.74122811406;640.3116649601603;642.2229102785682;645.2901808011244;656.0847617573459;670.165643773505;633.6451587111233;708.6067232685908;726.3789460011719;732.9230430804795;739.1832025611621;9639.9036009639;9927.553260103312;10027.699169024942;10389.168866490663;10435.582576696846;695.3220609905403;712.3766704133883;752.3454594502817;776.1036003416064;795.129333379948;4809;4935.531124543163;4973.850784476472;5012.548870601663;5015.147424937696;57766.7111664439;65212;99887.46721925042;101667;101914;56220.15669764957;63003.05495417572;85432.57283713542;87762;90127.54936225277;49230.01539969181;50078.74960625174;60460.69769651123;61619.07571386433;62845.37154628486;9186.494742789211;9464.384814987005;9514.714558563253;9541.998090200428;9553.426794392359;34206;46795.532044679116;47047;47953.28070078882;48989;37488;56259.156112657525;64221;64268.67865660642;65961;12865.614031579067;12936.676583085498;13008.739825203633;13034.348282585643;13262.734745305233;14014.579562613138;14305.284735763378;14468.348924298642;14581.270936453348;14802.77795833085;10105.696829095139;13270.1374410663;13491.123076999964;13598.11612245201;14082.647933801736;12845.486180552673;12914.677133071373;12988.025898057494;13022.218666880017;13349.399277032751;13553.932230338785;13640.181589104686;13725.107867988949;13731.107478013897;14433.278336082943;11044.226904116635;11457.942710286396;11882.57199478841;11938.58214962472;12116.27302361861;11145.164112691418;11543.942280288546;11707;11785.941070294593;11846.407679616157 03:49:40 INFO - PROCESS | 30635 | __end_tp_report 03:49:40 INFO - PROCESS | 30635 | __start_cc_report 03:49:40 INFO - PROCESS | 30635 | _x_x_mozilla_cycle_collect,995 03:49:40 INFO - PROCESS | 30635 | __end_cc_report 03:49:40 INFO - PROCESS | 30635 | __startTimestamp1479383380459__endTimestamp 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | ------- Summary: start ------- 03:49:40 INFO - PROCESS | 30635 | Number of tests: 6 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#0] dojo.html Cycles:165 Average:5626.34 Median:5856.24 stddev:640.70 (10.9%) stddev-sans-first:614.43 03:49:40 INFO - PROCESS | 30635 | Values: 3228.4 3258.8 3276.2 3293.7 3315.1 5582.4 5598.2 5647.4 5658.5 5692.2 5631.6 5704.5 5706.1 5718.9 5756.6 5117.7 5176.8 5193.2 5217.3 5254.1 5072.7 5235.0 5252.7 5275.4 5280.0 5053.0 5094.4 5120.8 5136.9 5149.4 5182.9 5212.4 5233.1 5298.8 5308.8 5122.0 5166.8 5237.2 5246.7 5273.0 5475.1 5535.1 5536.1 5552.8 5584.8 5949.6 5969.9 6130.0 6134.2 6138.2 6154.3 6183.7 6191.5 6202.3 6203.1 5553.5 5591.9 5593.6 5616.7 5629.3 6176.0 6190.0 6192.3 6210.8 6212.6 5961.6 5964.4 5965.3 5966.6 5979.0 5876.7 5907.2 5992.5 6032.9 6037.5 6016.9 6026.8 6042.6 6064.5 6077.1 6020.7 6032.5 6081.8 6083.3 6105.8 4524.0 4554.4 4572.1 4600.0 4660.9 4130.2 4134.7 4165.4 4166.0 4180.7 5738.7 5755.2 5759.1 5759.8 5762.3 5904.1 6036.3 6052.0 6060.1 6098.1 5558.2 5641.3 5688.8 5694.5 5768.9 5092.4 5126.3 5136.0 5141.4 5156.3 6237.5 6281.5 6314.8 6318.5 6319.7 5881.8 5928.4 6013.8 6082.7 6112.6 6342.6 6347.5 6357.7 6359.2 6360.0 5976.9 6027.2 6035.2 6044.7 6051.4 5876.0 5920.3 5966.9 6014.5 6152.7 5971.0 5976.1 5992.6 6008.1 6023.1 5807.4 5864.4 5866.7 5871.4 5871.6 5653.5 5687.8 5855.7 5932.4 5933.6 5871.6 5907.6 5932.3 6015.6 6041.7 5797.3 5807.2 5849.1 5856.2 5888.3 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#1] ext.html Cycles:180 Average:58526.97 Median:380389.50 stddev:110449.93 (29.0%) stddev-sans-first:110674.09 03:49:40 INFO - PROCESS | 30635 | Values: 584.3 623.5 650.3 663.5 670.4 34513.7 44640.0 45732.3 45914.8 49111.0 45529.8 45877.3 45921.8 45980.3 46177.8 8461.5 8819.7 8950.8 8965.6 8973.0 8387.7 8627.4 8628.8 10755.4 11030.7 10848.5 10901.7 10904.0 10906.8 10906.8 10646.7 10667.1 10705.7 10710.0 10714.6 10625.3 10725.7 10740.5 10742.7 10749.2 43092.6 43432.6 43452.3 43493.1 43495.3 3659.0 3748.4 3764.7 3955.1 4283.9 32406.2 32429.2 32586.0 32731.3 32826.2 4342.8 4414.6 4438.5 4442.3 4544.7 357326.0 362386.0 364079.0 364212.0 364422.0 60684.7 60954.7 61043.7 61069.4 61124.4 39883.6 40780.2 41029.4 43409.0 43456.8 17646.7 17779.4 17796.4 17801.4 17806.1 13492.3 13508.6 13514.1 13523.2 13564.6 18463.7 18769.0 19509.0 20540.5 20545.4 7243.6 7435.7 7439.7 7453.7 7531.9 1037.8 1086.2 1092.8 1126.1 1151.1 33238.7 33260.0 33261.0 33317.8 34130.8 1065.6 1175.9 1182.9 1193.1 1201.8 15888.4 17513.2 17694.7 17987.6 18126.4 496022.0 498967.0 499628.0 500995.0 501947.0 60927.7 61713.7 61715.0 61814.4 62091.4 1346.4 1377.2 1380.0 1435.6 1461.4 29426.6 33836.0 33880.5 33898.3 34010.8 52375.5 52911.5 52912.5 52956.0 52956.7 378977.0 379794.0 379949.0 380830.0 383273.0 30137.2 30256.8 30675.8 30926.4 32232.5 49300.3 49523.5 49680.5 50956.7 51196.2 41540.8 42285.8 43115.6 43539.0 44114.0 42883.8 43129.6 43669.6 43683.8 43957.6 41547.8 41585.8 42022.0 42177.4 42464.4 36464.0 37353.3 38252.6 38563.0 38784.8 28528.1 28678.3 28726.6 28929.4 28979.3 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#2] jquery.html Cycles:180 Average:29222.72 Median:23635.91 stddev:79912.50 (338.1%) stddev-sans-first:80107.36 03:49:40 INFO - PROCESS | 30635 | Values: 392.2 416.9 428.4 432.6 443.3 14980.3 19402.0 20156.0 20341.3 20543.7 19467.5 19707.1 20306.8 20374.2 20675.7 5593.7 5839.4 5840.3 5841.2 5846.7 5458.4 5697.3 5731.4 5732.7 5734.6 5699.4 5700.1 5702.5 5706.9 5713.8 5523.1 5682.7 5690.5 5714.8 5720.9 5055.1 5118.8 5131.4 5137.2 5141.7 20099.4 20516.2 20556.2 22984.3 24287.5 2711.2 2800.0 2808.0 2878.2 2882.9 14390.2 14890.6 15314.2 15485.5 15700.8 1976.5 1990.6 2007.5 2010.1 2069.2 87813.0 89143.6 90585.0 90757.5 91293.5 10539.7 11547.2 11627.0 11788.8 12156.5 15663.7 16114.9 16161.1 16165.5 16211.2 8360.7 8464.2 8488.0 8537.5 8605.9 8145.9 8199.4 8278.3 8364.6 8422.0 4975.2 5130.6 5147.6 5162.9 5181.9 2094.8 2113.2 2130.7 2139.9 2157.1 965.0 993.6 1017.2 1026.1 1061.4 19550.1 20063.8 20217.1 20280.7 20336.9 1016.3 1019.3 1029.2 1037.2 1049.1 10198.3 10813.9 10974.5 11017.2 11150.2 479066.0 479545.0 481744.0 487212.0 490288.0 89656.0 92304.0 92539.5 92651.5 93923.0 1016.7 1021.3 1025.9 1028.1 1028.3 16943.5 17097.0 17256.5 17684.9 17831.7 40168.2 40569.6 41874.0 42985.0 43101.4 56860.7 57104.7 57177.7 57620.7 59351.7 8606.6 8674.0 8794.0 8800.4 8924.6 9776.2 11738.9 11807.5 11929.0 12941.3 10718.9 11109.7 11221.2 11289.3 11487.7 10831.7 11180.4 11343.3 11655.7 11720.0 10861.2 10895.2 10898.9 11204.6 11257.7 7915.3 8250.0 9144.3 9229.3 9474.0 11774.9 11920.1 12032.0 12152.4 12184.8 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#3] mootools.html Cycles:180 Average:6020.46 Median:4950.20 stddev:3384.04 (68.4%) stddev-sans-first:3375.83 03:49:40 INFO - PROCESS | 30635 | Values: 1414.8 1508.9 1528.2 1660.7 1798.5 7698.3 8628.2 8941.5 8965.4 9168.1 8954.4 9022.4 9028.1 9028.9 9044.4 2512.0 2535.5 2538.1 2541.4 2542.4 2391.9 2513.6 2519.6 2525.9 2530.1 2318.8 2322.3 2403.9 2407.0 2411.0 2462.2 2464.5 2469.5 2477.6 2495.4 2397.2 2421.8 2425.6 2430.9 2435.5 8969.6 8999.4 9050.3 9070.6 9153.2 5421.2 5588.1 5602.4 5667.8 5679.2 3552.4 3661.2 3705.4 3713.9 3725.1 1091.2 1102.5 1107.3 1119.7 1134.3 12847.4 12913.3 12970.0 13013.2 13036.3 4757.2 4853.3 4860.3 4937.8 4962.6 10263.1 10285.6 10288.2 10296.2 10297.8 5437.0 5534.0 5541.8 5545.2 5548.2 4409.4 4495.7 4705.2 5162.8 5166.6 3982.1 4073.3 4079.3 4172.2 4175.6 1231.6 1272.7 1276.8 1286.3 1286.9 966.2 1053.5 1060.6 1066.4 1067.5 6269.7 6309.3 6391.7 6462.8 6619.0 500.2 508.5 513.1 515.4 517.1 4461.9 4468.5 4532.4 4534.5 4547.3 11073.2 11437.3 11491.1 11558.8 11558.8 10645.3 11088.0 11192.3 11307.3 11318.3 8405.9 8617.2 8620.4 8624.1 8634.1 6247.5 6412.8 6490.2 6494.3 6555.6 9807.5 9931.4 9942.2 10060.7 10139.4 9409.9 9741.6 10420.4 10443.7 10449.5 7878.7 7888.4 8046.8 8131.1 8319.7 8818.6 9125.5 9131.4 9136.4 9141.2 8000.3 8008.8 8079.7 8108.2 8206.7 7902.3 7938.6 7944.5 8098.5 8104.0 7260.8 7289.8 7372.3 7443.1 7479.7 5422.3 5493.8 5635.2 5676.7 5741.1 5420.7 5604.4 5765.6 5802.8 5817.2 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#4] prototype.html Cycles:180 Average:4637.63 Median:5248.62 stddev:1321.15 (25.2%) stddev-sans-first:1284.93 03:49:40 INFO - PROCESS | 30635 | Values: 343.1 355.6 358.2 358.9 359.3 5330.0 5359.6 5397.6 5402.8 5432.7 5051.5 5078.6 5126.9 5179.8 5238.3 4233.0 4239.2 4242.3 4245.4 4256.2 4212.5 4242.7 4243.9 4268.1 4270.7 3884.1 3952.4 4087.7 4163.1 4206.6 4142.4 4148.8 4154.6 4159.8 4170.4 3707.8 3714.7 3718.2 3721.0 3734.9 5121.7 5149.9 5192.8 5245.4 5265.4 4741.5 4777.5 4782.4 4801.6 4812.9 5538.4 5553.4 5564.4 5584.5 5586.3 3932.4 4070.8 4125.9 4130.4 4134.2 5746.2 5763.9 5766.0 5773.3 5780.2 4199.6 4217.7 4228.7 4229.3 4237.9 4037.5 4201.2 4297.2 4298.5 4300.7 4767.8 4783.5 4789.4 4790.3 4799.8 5618.7 5621.3 5633.2 5639.3 5646.8 1365.8 1413.5 1415.3 1423.9 1431.2 935.2 953.9 1015.6 1056.7 1059.5 5171.0 5193.2 5196.9 5211.2 5254.7 5576.8 5577.0 5584.8 5589.3 5649.9 5173.1 5232.5 5236.2 5285.6 5289.5 2906.4 2912.3 2913.6 2923.4 2944.3 5531.2 5662.4 5704.5 5707.7 5712.6 5534.8 5538.0 5584.7 5587.6 5600.2 5659.8 5660.1 5686.4 5706.5 5717.4 5290.6 5438.2 5444.8 5451.4 5453.9 5398.6 5398.8 5433.9 5434.6 5440.9 5508.2 5694.6 5695.9 5723.7 5735.0 4089.0 4134.3 4135.7 4142.5 4174.4 5501.2 5510.7 5532.4 5532.6 5632.9 5087.8 5346.8 5410.2 5470.7 5474.6 5251.8 5253.6 5254.2 5264.5 5287.0 5208.6 5270.4 5291.3 5318.7 5371.8 5448.8 5580.1 5586.6 5593.6 5600.0 5391.6 5441.3 5450.7 5458.0 5471.7 03:49:40 INFO - PROCESS | 30635 | 03:49:40 INFO - PROCESS | 30635 | [#5] yui.html Cycles:180 Average:17452.38 Median:26357.99 stddev:22615.85 (85.8%) stddev-sans-first:22644.66 03:49:40 INFO - PROCESS | 30635 | Values: 786.1 789.1 791.7 854.2 881.2 14375.3 15074.2 15741.3 15896.0 15917.2 14096.6 14282.6 14408.4 14635.1 14650.5 713.9 848.8 863.5 865.4 865.9 724.8 846.1 862.0 866.8 868.6 918.4 920.0 920.7 920.7 920.9 742.4 911.5 913.1 913.3 913.5 561.3 646.8 659.6 661.8 666.2 13210.9 13213.5 13224.9 13228.4 13252.7 13385.3 13402.5 13543.1 13617.3 13818.2 12766.7 12900.1 13059.2 13171.5 13234.8 4416.2 4433.3 4455.9 4456.9 4567.6 56099.0 57837.0 57908.0 65941.0 66535.0 11459.9 11698.8 11861.2 11886.9 11933.6 20710.8 20885.2 21049.6 21107.3 21224.5 8653.4 8677.4 8753.8 8757.3 8780.3 4691.5 4762.7 4954.3 5054.3 5069.2 3524.2 3641.9 3673.1 3679.0 3696.7 640.3 642.2 645.3 656.1 670.2 633.6 708.6 726.4 732.9 739.2 9639.9 9927.6 10027.7 10389.2 10435.6 695.3 712.4 752.3 776.1 795.1 4809.0 4935.5 4973.9 5012.5 5015.1 57766.7 65212.0 99887.5 101667.0 101914.0 56220.2 63003.1 85432.6 87762.0 90127.5 49230.0 50078.7 60460.7 61619.1 62845.4 9186.5 9464.4 9514.7 9542.0 9553.4 34206.0 46795.5 47047.0 47953.3 48989.0 37488.0 56259.2 64221.0 64268.7 65961.0 12865.6 12936.7 13008.7 13034.3 13262.7 14014.6 14305.3 14468.3 14581.3 14802.8 10105.7 13270.1 13491.1 13598.1 14082.6 12845.5 12914.7 12988.0 13022.2 13349.4 13553.9 13640.2 13725.1 13731.1 14433.3 11044.2 11457.9 11882.6 11938.6 12116.3 11145.2 11543.9 11707.0 11785.9 11846.4 03:49:40 INFO - PROCESS | 30635 | -------- Summary: end -------- 03:49:40 INFO - PROCESS | 30635 | 03:49:41 INFO - TEST-INFO | 30635: exit 0 03:49:41 INFO - TEST-OK | dromaeo_css | took 1115777ms 03:49:41 INFO - TEST-START | kraken 03:49:41 INFO - operating with platform_type : linux_ 03:49:41 INFO - Initialising browser for kraken test... 03:49:41 INFO - TEST-INFO | started process 30953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSV8uPJ/profile http://localhost:46342/getInfo.html) 03:49:44 ERROR - PROCESS | 30953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:49:45 INFO - PROCESS | 30953 | __metrics Screen width/height:1600/1200 03:49:45 INFO - PROCESS | 30953 | colorDepth:24 03:49:45 INFO - PROCESS | 30953 | Browser inner width/height: 1024/697 03:49:45 INFO - PROCESS | 30953 | __metrics 03:49:46 INFO - PROCESS | 30953 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:49:46 INFO - PROCESS | 30953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:46 INFO - PROCESS | 30953 | console.error: PushService: 03:49:46 INFO - PROCESS | 30953 | stateChangeProcessEnqueue: Error transitioning state 03:49:46 INFO - PROCESS | 30953 | UnknownError 03:49:47 INFO - TEST-INFO | 30953: exit 0 03:49:47 INFO - Browser initialized. 03:49:47 INFO - Running cycle 1/1 for kraken test... 03:49:47 INFO - TEST-INFO | started process 31048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSV8uPJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:58 INFO - PROCESS | 31048 | RSS: Main: 144814080 03:49:58 INFO - PROCESS | 31048 | 03:50:01 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:02 INFO - PROCESS | 31048 | RSS: Main: 185745408 03:50:02 INFO - PROCESS | 31048 | 03:50:04 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-dft) 03:50:05 INFO - PROCESS | 31048 | RSS: Main: 175603712 03:50:05 INFO - PROCESS | 31048 | 03:50:08 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-fft) 03:50:08 INFO - PROCESS | 31048 | RSS: Main: 266948608 03:50:08 INFO - PROCESS | 31048 | 03:50:10 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46342/tests/kraken/driver.html?testName=audio-oscillator) 03:50:11 INFO - PROCESS | 31048 | RSS: Main: 172691456 03:50:11 INFO - PROCESS | 31048 | 03:50:13 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:14 INFO - PROCESS | 31048 | RSS: Main: 175656960 03:50:14 INFO - PROCESS | 31048 | 03:50:17 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:17 INFO - PROCESS | 31048 | RSS: Main: 214630400 03:50:17 INFO - PROCESS | 31048 | 03:50:21 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46342/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:21 INFO - PROCESS | 31048 | RSS: Main: 213299200 03:50:21 INFO - PROCESS | 31048 | 03:50:24 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46342/tests/kraken/driver.html?testName=json-parse-financial) 03:50:24 INFO - PROCESS | 31048 | RSS: Main: 211939328 03:50:24 INFO - PROCESS | 31048 | 03:50:26 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:26 INFO - PROCESS | 31048 | RSS: Main: 174284800 03:50:26 INFO - PROCESS | 31048 | 03:50:28 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:29 INFO - PROCESS | 31048 | RSS: Main: 181219328 03:50:29 INFO - PROCESS | 31048 | 03:50:31 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:31 INFO - PROCESS | 31048 | RSS: Main: 190115840 03:50:31 INFO - PROCESS | 31048 | 03:50:34 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:35 INFO - PROCESS | 31048 | RSS: Main: 198758400 03:50:35 INFO - PROCESS | 31048 | 03:50:37 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:38 INFO - PROCESS | 31048 | RSS: Main: 195866624 03:50:38 INFO - PROCESS | 31048 | 03:50:39 INFO - PROCESS | 31048 | Cycle 1(1): loaded http://localhost:46342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46342/tests/kraken/driver.html?testName=ai-astar) 03:50:40 INFO - PROCESS | 31048 | RSS: Main: 246362112 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | __start_tp_report 03:50:40 INFO - PROCESS | 31048 | _x_x_mozilla_page_load 03:50:40 INFO - PROCESS | 31048 | _x_x_mozilla_page_load_details 03:50:40 INFO - PROCESS | 31048 | |i|pagename|runs| 03:50:40 INFO - PROCESS | 31048 | |0;ai-astar;103;113;112;110;111;114;113;115;111;111 03:50:40 INFO - PROCESS | 31048 | |1;audio-beat-detection;145;122;121;161;123;122;122;122;153;123 03:50:40 INFO - PROCESS | 31048 | |2;audio-dft;161;162;161;160;162;160;161;160;161;162 03:50:40 INFO - PROCESS | 31048 | |3;audio-fft;75;75;75;113;76;75;75;74;95;74 03:50:40 INFO - PROCESS | 31048 | |4;audio-oscillator;82;82;123;82;82;82;101;81;81;108 03:50:40 INFO - PROCESS | 31048 | |5;imaging-gaussian-blur;116;117;117;117;118;117;119;117;116;117 03:50:40 INFO - PROCESS | 31048 | |6;imaging-darkroom;147;146;146;145;146;147;146;146;146;145 03:50:40 INFO - PROCESS | 31048 | |7;imaging-desaturate;84;85;85;84;85;85;84;85;85;85 03:50:40 INFO - PROCESS | 31048 | |8;json-parse-financial;51;49;50;49;53;50;49;50;50;49 03:50:40 INFO - PROCESS | 31048 | |9;json-stringify-tinderbox;58;59;59;58;59;58;59;58;58;58 03:50:40 INFO - PROCESS | 31048 | |10;stanford-crypto-aes;89;81;76;74;74;74;75;74;74;75 03:50:40 INFO - PROCESS | 31048 | |11;stanford-crypto-ccm;129;122;126;126;128;127;124;132;174;133 03:50:40 INFO - PROCESS | 31048 | |12;stanford-crypto-pbkdf2;156;154;157;160;153;162;155;154;155;162 03:50:40 INFO - PROCESS | 31048 | |13;stanford-crypto-sha256-iterative;62;62;64;62;63;61;64;63;61;60 03:50:40 INFO - PROCESS | 31048 | __end_tp_report 03:50:40 INFO - PROCESS | 31048 | __start_cc_report 03:50:40 INFO - PROCESS | 31048 | _x_x_mozilla_cycle_collect,1600 03:50:40 INFO - PROCESS | 31048 | __end_cc_report 03:50:40 INFO - PROCESS | 31048 | __startTimestamp1479383440221__endTimestamp 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | ------- Summary: start ------- 03:50:40 INFO - PROCESS | 31048 | Number of tests: 14 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.30 (2.9%) stddev-sans-first:1.64 03:50:40 INFO - PROCESS | 31048 | Values: 103.0 113.0 112.0 110.0 111.0 114.0 113.0 115.0 111.0 111.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:123.00 stddev:15.39 (12.5%) stddev-sans-first:15.51 03:50:40 INFO - PROCESS | 31048 | Values: 145.0 122.0 121.0 161.0 123.0 122.0 122.0 122.0 153.0 123.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:50:40 INFO - PROCESS | 31048 | Values: 161.0 162.0 161.0 160.0 162.0 160.0 161.0 160.0 161.0 162.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:13.00 (17.3%) stddev-sans-first:13.63 03:50:40 INFO - PROCESS | 31048 | Values: 75.0 75.0 75.0 113.0 76.0 75.0 75.0 74.0 95.0 74.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:14.96 (18.2%) stddev-sans-first:15.56 03:50:40 INFO - PROCESS | 31048 | Values: 82.0 82.0 123.0 82.0 82.0 82.0 101.0 81.0 81.0 108.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 03:50:40 INFO - PROCESS | 31048 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 119.0 117.0 116.0 117.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 03:50:40 INFO - PROCESS | 31048 | Values: 147.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 146.0 145.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 03:50:40 INFO - PROCESS | 31048 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 85.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:1.25 (2.5%) stddev-sans-first:1.27 03:50:40 INFO - PROCESS | 31048 | Values: 51.0 49.0 50.0 49.0 53.0 50.0 49.0 50.0 50.0 49.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:50:40 INFO - PROCESS | 31048 | Values: 58.0 59.0 59.0 58.0 59.0 58.0 59.0 58.0 58.0 58.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:75.00 stddev:4.86 (6.5%) stddev-sans-first:2.28 03:50:40 INFO - PROCESS | 31048 | Values: 89.0 81.0 76.0 74.0 74.0 74.0 75.0 74.0 74.0 75.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:128.50 stddev:15.10 (11.7%) stddev-sans-first:15.97 03:50:40 INFO - PROCESS | 31048 | Values: 129.0 122.0 126.0 126.0 128.0 127.0 124.0 132.0 174.0 133.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.80 Median:156.50 stddev:3.36 (2.1%) stddev-sans-first:3.55 03:50:40 INFO - PROCESS | 31048 | Values: 156.0 154.0 157.0 160.0 153.0 162.0 155.0 154.0 155.0 162.0 03:50:40 INFO - PROCESS | 31048 | 03:50:40 INFO - PROCESS | 31048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.32 (2.1%) stddev-sans-first:1.39 03:50:40 INFO - PROCESS | 31048 | Values: 62.0 62.0 64.0 62.0 63.0 61.0 64.0 63.0 61.0 60.0 03:50:40 INFO - PROCESS | 31048 | -------- Summary: end -------- 03:50:40 INFO - PROCESS | 31048 | 03:50:41 INFO - TEST-INFO | 31048: exit 0 03:50:41 INFO - TEST-OK | kraken | took 60047ms 03:50:41 INFO - SUITE-END | took 1175s 03:50:41 INFO - Completed test suite (00:19:35) 03:50:41 INFO - javascript benchmark 03:50:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.4188846007714, 3258.788178768379, 3276.230085929806, 3293.654166312536, 3315.0883507035564, 5582.385937546866, 5598.244237028, 5647.43525647435, 5658.490735833774, 5692.231548740924, 5631.63394379365, 5704.54363650908, 5706.1440783882435, 5718.885622287552, 5756.597038207327, 5117.744112794355, 5176.844694659167, 5193.246979188016, 5217.34783152106, 5254.054270231357, 5072.67027643202, 5234.973825130869, 5252.658577192489, 5275.419703832576, 5280.0, 5052.9747351263195, 5094.363204599425, 5120.769565369567, 5136.895567453015, 5149.433562308143, 5182.948170518303, 5212.4266330703595, 5233.136532472137, 5298.761555729963, 5308.8141915033175, 5122.0, 5166.793328266903, 5237.16205407133, 5246.737663116829, 5273.0, 5475.06923822951, 5535.114381698909, 5536.114221724545, 5552.77788888444, 5584.776608935637, 5949.553783466214, 5969.850753731148, 6130.049842274455, 6134.17188679527, 6138.202033735631, 6154.261488621394, 6183.690815459209, 6191.473724733403, 6202.317745048041, 6203.1005504202085, 5553.4724201200825, 5591.944080559224, 5593.580481463907, 5616.66300022, 5629.324481062217, 6176.0, 6190.0, 6192.256929168529, 6210.7515699371515, 6212.596181248205, 5961.582689211714, 5964.373740757244, 5965.254343207099, 5966.552508561788, 5979.0, 5876.7355469004, 5907.202527658797, 5992.520598352121, 6032.939670603326, 6037.486813620892, 6016.909746353808, 6026.819195424145, 6042.6072305300895, 6064.514838812885, 6077.118817771398, 6020.729067191987, 6032.547558933097, 6081.787137450168, 6083.330833608299, 6105.8168254952425, 4523.977380113079, 4554.36238926544, 4572.1312950539295, 4600.0, 4660.930086048712, 4130.235906357273, 4134.710570260113, 4165.396017577495, 4165.97917010413, 4180.707350485498, 5738.68437235956, 5755.165501002415, 5759.107338362561, 5759.769609215585, 5762.337331206881, 5904.143899134688, 6036.305824830113, 6051.969740151271, 6060.090986352083, 6098.054801505774, 5558.166275058693, 5641.294838145232, 5688.829335119953, 5694.515966142924, 5768.855778605484, 5092.38891333035, 5126.333576635014, 5136.049830781318, 5141.38303403594, 5156.2523434102595, 6237.4698150657705, 6281.497480201573, 6314.810555683337, 6318.462930650946, 6319.747210111544, 5881.794137205177, 5928.407159284037, 6013.819585412444, 6082.7262773174425, 6112.602680825732, 6342.556021078664, 6347.460465860268, 6357.650329231937, 6359.17330747, 6359.96820015897, 5976.8804623908145, 6027.156198132177, 6035.185249991195, 6044.667543284985, 6051.364606716232, 5875.970620146872, 5920.289565252025, 5966.850828729316, 6014.48876845473, 6152.661603611844, 5971.044632858721, 5976.073708575178, 5992.580519363602, 6008.068749343859, 6023.1266466363, 5807.361190269152, 5864.384239654945, 5866.7066646668345, 5871.383504732113, 5871.588988770916, 5653.491185793134, 5687.77248910039, 5855.707214639337, 5932.377100404396, 5933.584649074523, 5871.588988770745, 5907.556933229939, 5932.2584676915385, 6015.578909476295, 6041.728122234598, 5797.333306669619, 5807.157962095388, 5849.1226316052935, 5856.238688970407, 5888.3228428731245], "value": 5583.006205924599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.3396961433582, 623.4544773323342, 650.3496503496503, 663.505688262245, 670.3765498086777, 34513.65486345136, 44640.0, 45732.31401528972, 45914.770426147865, 49111.0, 45529.77235113828, 45877.31184032242, 45921.77039114808, 45980.310295345516, 46177.769111154485, 8461.450005749606, 8819.691310804106, 8950.776230594221, 8965.551722413886, 8972.955135224347, 8387.706430274942, 8627.396082274212, 8628.784280392978, 10755.354678719303, 11030.669079927615, 10848.457577121151, 10901.672949811518, 10904.01863832255, 10906.781864362709, 10906.836397454044, 10646.680599582025, 10667.093297069758, 10705.732356691067, 10710.0, 10714.571417143305, 10625.309354891908, 10725.731856703567, 10740.516676749565, 10742.677719668422, 10749.193810464169, 43092.56907430917, 43432.56567434348, 43452.3482147768, 43493.13013739708, 43495.34756978648, 3659.0120667419915, 3748.4377343398437, 3764.6611804937415, 3955.129871428281, 4283.87148385549, 32406.189845253823, 32429.189270268194, 32586.0, 32731.345373092405, 32826.17934551631, 4342.848000320006, 4414.602685758297, 4438.533953934855, 4442.267025940716, 4544.659150563721, 357326.0, 362386.0, 364079.0, 364212.0, 364422.0, 60684.696576516835, 60954.69522652358, 61043.6947815267, 61069.38930610726, 61124.388756112756, 39883.60116398857, 40780.18439631191, 41029.384559231636, 43409.0, 43456.78271608685, 17646.735298970525, 17779.377721779936, 17796.37712680076, 17801.397874191127, 17806.109694515224, 13492.257925813978, 13508.594742157751, 13514.05401621877, 13523.188608683511, 13564.593062208149, 18463.723044154347, 18769.0, 19508.987941365427, 20540.486487837625, 20545.383638490868, 7243.5653860768525, 7435.665395057235, 7439.665215065335, 7453.664585093684, 7531.887021694679, 1037.8339465685453, 1086.21792309537, 1092.7541303206874, 1126.0709914320719, 1151.090638395658, 33238.66761332356, 33260.0, 33261.0, 33317.83341083279, 34130.82934585311, 1065.63235683689, 1175.8530183727034, 1182.9112816538793, 1193.117093350914, 1201.8077107662732, 15888.364465421253, 17513.211905464286, 17694.734578981326, 17987.550311242325, 18126.365577204735, 496022.0, 498967.0, 499628.0, 500995.0, 501947.0, 60927.695361523794, 61713.69143154255, 61715.0, 61814.381856180866, 62091.37908620856, 1346.3537501999094, 1377.2218696436482, 1380.0339762166523, 1435.5549779568366, 1461.400825661495, 29426.558601620563, 33836.0, 33880.49179262362, 33898.322033558696, 34010.82994585011, 52375.47624523706, 52911.470885290655, 52912.470875292296, 52956.0, 52956.73521632367, 378977.0, 379794.0, 379949.0, 380830.0, 383273.0, 30137.246568835955, 30256.84871575628, 30675.84662076675, 30926.381472369976, 32232.516512252805, 49300.26049609187, 49523.50476495189, 49680.50319496759, 50956.74521627368, 51196.232056519926, 41540.79229603833, 42285.788571056946, 43115.56884431116, 43539.0, 44114.0, 42883.7855810719, 43129.56870431256, 43669.56330436655, 43683.78158109189, 43957.56042439535, 41547.7922610385, 41585.79207104066, 42022.0, 42177.36733949055, 42464.36303455389, 36464.0, 37353.252934941695, 38252.617473826016, 38563.0, 38784.80607597057, 28528.14567053135, 28678.283042924093, 28726.569101463076, 28929.42141157207, 28979.275518112216], "value": 20832.702984382904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.1842567459684, 416.88535652695504, 428.4301878501592, 432.5739146940263, 443.3482780312941, 14980.325885335158, 19402.021726610124, 20156.0, 20341.28805491808, 20543.691844622343, 19467.513312167204, 19707.113179906904, 20306.796932030677, 20374.185032598678, 20675.689864652042, 5593.74828132734, 5839.357670656224, 5840.328362238333, 5841.15303281024, 5846.707664616773, 5458.372287186965, 5697.287839020122, 5731.426857314277, 5732.656040637554, 5734.627249228808, 5699.373068962432, 5700.144978253254, 5702.486776190142, 5706.857328566777, 5713.800016999406, 5523.061079616475, 5682.687452190128, 5690.516306113986, 5714.79998200061, 5720.942790572103, 5055.064813009605, 5118.820841270538, 5131.435542090367, 5137.152369858969, 5141.665791723526, 20099.39701808948, 20516.179352825868, 20556.177752889867, 22984.310470685905, 24287.514249714906, 2711.200195942202, 2800.047983685536, 2808.0452646100425, 2878.2228798224573, 2882.9135125946254, 14390.208538530376, 14890.553283401407, 15314.234288285541, 15485.458008969745, 15700.76448853268, 1976.456474469518, 1990.5919286546368, 2007.5382661987824, 2010.1155491583656, 2069.244725675133, 87813.0, 89143.55428222883, 90585.0, 90757.54621226918, 91293.54353228191, 10539.683809485574, 11547.191696581327, 11627.0, 11788.823167652492, 12156.452959616838, 15663.68672626564, 16114.919425403032, 16161.111138887474, 16165.515034548747, 16211.189440527927, 8360.707375241838, 8464.238218560358, 8487.957560212159, 8537.53043582609, 8605.870911936327, 8145.877811832827, 8199.385046121564, 8278.254957053894, 8364.623591938378, 8422.0, 4975.228839529878, 5130.615203859726, 5147.613928955268, 5162.896742065138, 5181.922271165936, 2094.8009939055764, 2113.17586141405, 2130.6910497978015, 2139.9144034238766, 2157.094020511389, 965.0397854135181, 993.6174572789528, 1017.2269075502523, 1026.1175389165312, 1061.4003088255265, 19550.120244589027, 20063.799362006484, 20217.090230939644, 20280.695789563168, 20336.898315508326, 1016.3393794033938, 1019.2966852871494, 1029.2280789407944, 1037.2479952034714, 1049.1134990932649, 10198.269414602637, 10813.891256516526, 10974.451277436096, 11017.228793984345, 11150.163737719704, 479066.0, 479545.0, 481744.0, 487212.0, 490288.0, 89656.0, 92304.0, 92539.53730231305, 92651.5367423172, 93923.0, 1016.7102375822855, 1021.341234903483, 1025.8615086963314, 1028.0695970147028, 1028.2699283508794, 16943.491695248667, 17097.0, 17256.482305530855, 17684.91157544204, 17831.73252401241, 40168.196636067696, 40569.59430405776, 41874.0, 42985.0, 43101.3534796972, 56860.715696421255, 57104.714476427354, 57177.71411143084, 57620.71189644025, 59351.70324148352, 8606.612702428281, 8674.0, 8793.956030220064, 8800.38397312182, 8924.598393072198, 9776.1690256329, 11738.94130529342, 11807.527698891949, 11929.0, 12941.28822914711, 10718.89281107179, 11109.666709998713, 11221.214514983873, 11289.322640641587, 11487.655370338904, 10831.729206769895, 11180.385078820744, 11343.262687925258, 11655.708607284547, 11720.0, 10861.185411094042, 10895.237333386904, 10898.891011089787, 11204.607838725606, 11257.71855703614, 7915.287624113857, 8250.0, 9144.26845852317, 9229.307801914749, 9474.005229450808, 11774.882251177378, 11920.105992050458, 12032.0, 12152.392380380768, 12184.756304873676], "value": 9463.02286418617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.8302203735552, 1508.8642022218003, 1528.1595122682525, 1660.709375859225, 1798.5054110119725, 7698.345640620547, 8628.223459888608, 8941.463512189273, 8965.372423930328, 9168.12902774237, 8954.373193876416, 9022.413543119708, 9028.052054534277, 9028.90971090289, 9044.412113212653, 2512.032867346076, 2535.492901419714, 2538.1370334086405, 2541.390066384073, 2542.415244493758, 2391.9162829300976, 2513.5978243481045, 2519.571672815626, 2525.936851578707, 2530.089167899564, 2318.8376813623054, 2322.349742072214, 2403.9158629447975, 2407.0492155598527, 2411.035585765699, 2462.249014050714, 2464.4578192797558, 2469.5307891500556, 2477.6283557466345, 2495.43852633157, 2397.2328854766483, 2421.8425802322795, 2425.5755242832433, 2430.9392265193333, 2435.4641978764644, 8969.551522423853, 8999.370044096915, 9050.321225908017, 9070.591823367964, 9153.22197613197, 5421.186821976696, 5588.1059030555325, 5602.411746766612, 5667.829965101054, 5679.233303504016, 3552.3605750964816, 3661.176235347052, 3705.3515634764076, 3713.925721485555, 3725.0873535983856, 1091.1816137896578, 1102.509383324421, 1107.2747350485445, 1119.6864877834219, 1134.3194083549804, 12847.35763211845, 12913.289769062698, 12970.0, 13013.154144980546, 13036.283004434847, 4757.191277482836, 4853.320535125085, 4860.270959356125, 4937.8271760488215, 4962.578180854595, 10263.076323130954, 10285.588576456857, 10288.176945844314, 10296.176305895511, 10297.845532317022, 5437.021336159451, 5533.972330138324, 5541.833744987657, 5545.223668686387, 5548.167774833726, 4409.404730361424, 4495.730256184639, 4705.223638099744, 5162.767675454614, 5166.5866730661455, 3982.143839074613, 4073.3075377185355, 4079.265732168179, 4172.248995180897, 4175.645070169009, 1231.5566396097397, 1272.6945533071996, 1276.8403949506312, 1286.2925391034894, 1286.8584455709865, 966.1787480641399, 1053.4627340056472, 1060.575769692114, 1066.386827574148, 1067.5356220044305, 6269.749210031548, 6309.305976342599, 6391.6804159792755, 6462.838429039311, 6619.0, 500.19468655464675, 508.5346907579523, 513.1456125550991, 515.3635260453337, 517.0873408434117, 4461.888452788641, 4468.4637843458995, 4532.388127602798, 4534.455865296186, 4547.295169248771, 11073.169512286611, 11437.256578322382, 11491.138164637685, 11558.768824623461, 11558.826617600742, 10645.254832161674, 11088.0, 11192.328460292409, 11307.321560706385, 11318.26431281964, 8405.873911891327, 8617.224449799549, 8620.396572239883, 8624.051354351017, 8634.136586341316, 6247.5001999840815, 6412.775552855815, 6490.188726409199, 6494.253160886369, 6555.573887697476, 9807.521527853976, 9931.354461959949, 9942.204623629948, 10060.69817905464, 10139.391636501834, 9409.905900941178, 9741.561629726537, 10420.426876521864, 10443.68668939933, 10449.529771160163, 7878.724244651639, 7888.447808653339, 8046.798830029062, 8131.105578386255, 8319.708810191856, 8818.647254110021, 9125.498097604695, 9131.406458580172, 9136.360454768102, 9141.222996045411, 8000.279974802295, 8008.799780005546, 8079.6768129276525, 8108.2297181767635, 8206.671733130846, 7902.288794008567, 7938.64276107565, 7944.483608565425, 8098.51408915467, 8104.0, 7260.782176534713, 7289.781306560812, 7372.299631534996, 7443.106827180773, 7479.728446164057, 5422.267993820784, 5493.780248790164, 5635.239242702182, 5676.716164191691, 5741.0527263002805, 5420.701861397661, 5604.439556044363, 5765.56758243125, 5802.796902108406, 5817.214676018683], "value": 4760.127481635763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.12674244048895, 355.57686353239626, 358.18155514649015, 358.86004458261266, 359.33881657749737, 5330.0, 5359.59803014774, 5397.62216644835, 5402.810901618444, 5432.728363581825, 5051.459304912, 5078.603384069383, 5126.897462050757, 5179.818706345279, 5238.345206849144, 4232.978835105828, 4239.215745087154, 4242.300020496615, 4245.384419259206, 4256.2338779019765, 4212.4945006599255, 4242.703010789231, 4243.936340954888, 4268.103698223377, 4270.722403043807, 3884.1063407761258, 3952.407138929155, 4087.734297270683, 4163.125743593849, 4206.558311377307, 4142.399352093959, 4148.751074935513, 4154.646855017327, 4159.83360665573, 4170.436991006206, 3707.796071216082, 3714.7028237741188, 3718.200586873808, 3720.9813950930343, 3734.8879533614036, 5121.74517243274, 5149.948500515022, 5192.818251361185, 5245.396779370383, 5265.447128051576, 4741.525847415265, 4777.5222477752295, 4782.426108866924, 4801.591864691505, 4812.927806082912, 5538.390777014565, 5553.389127196006, 5564.443555644443, 5584.46947539983, 5586.301712285965, 3932.4101384792225, 4070.837166513336, 4125.876223713293, 4130.409792229983, 4134.235166494178, 5746.224259724925, 5763.884722305573, 5765.971170144165, 5773.278340207474, 5780.248567686174, 4199.580041995837, 4217.725847819943, 4228.746275223496, 4229.323308270662, 4237.915241695149, 4037.475128233311, 4201.222773786798, 4297.183535128315, 4298.46269216348, 4300.720453170534, 4767.785449654774, 4783.545563171563, 4789.425268967746, 4790.281457781361, 4799.832005879847, 5618.747156377973, 5621.269234999424, 5633.155026745939, 5639.295088113986, 5646.802361917313, 1365.7609918264263, 1413.5264686329988, 1415.2852809331223, 1423.8504956979575, 1431.2128329418986, 935.2471260635253, 953.8950715421298, 1015.6496008876926, 1056.6724315462232, 1059.5338051257422, 5170.97414512925, 5193.195054766517, 5196.92204616931, 5211.228182417996, 5254.65844720092, 5576.804811831566, 5576.972115139399, 5584.776608935678, 5589.273394458694, 5649.887002259932, 5173.146430838945, 5232.514555586143, 5236.188390799356, 5285.577153827685, 5289.523942845162, 2906.4041871416307, 2912.301047748525, 2913.606663100497, 2923.4213524696424, 2944.263934016496, 5531.170324451284, 5662.37713851476, 5704.543636509153, 5707.6575405475805, 5712.571557133231, 5534.833954981357, 5538.0, 5584.692841893735, 5587.631030397579, 5600.243967064475, 5659.830205093772, 5660.122680984454, 5686.402927692616, 5706.457886500942, 5717.399673034354, 5290.603204759582, 5438.184272359178, 5444.809431670031, 5451.400345961862, 5453.945460545502, 5398.64908780928, 5398.78404863801, 5433.9456605435025, 5434.581611183144, 5440.891182176413, 5508.20131080983, 5694.629849059798, 5695.930621746732, 5723.7407770290465, 5734.971325143514, 4088.99458897704, 4134.297169481256, 4135.710500264952, 4142.502899652061, 4174.436451079187, 5501.229827824028, 5510.724463776875, 5532.419095994863, 5532.612717109763, 5632.915506267327, 5087.847364579068, 5346.78612855497, 5410.161424979135, 5470.659688376214, 5474.562035037108, 5251.842444726664, 5253.634055145613, 5254.185601231815, 5264.4735526448585, 5286.97356513215, 5208.557272631869, 5270.367555893164, 5291.285676433632, 5318.7074710891275, 5371.838844834661, 5448.785216722153, 5580.107182850725, 5586.581006424453, 5593.636413633101, 5599.984005758005, 5391.649542779707, 5441.340391180728, 5450.700211488248, 5458.007827143144, 5471.72641367938], "value": 4225.434774685114, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.1431040166218, 789.1280135450323, 791.7189397763793, 854.2013217641505, 881.2289246908955, 14375.2812359382, 15074.1551179188, 15741.291641876114, 15896.04623722576, 15917.204139793022, 14096.64758381041, 14282.571522854305, 14408.35162417691, 14635.12189268642, 14650.487232946849, 713.8572285542887, 848.8429640516508, 863.4905405810571, 865.4288169807928, 865.9004214515317, 724.7753196509072, 846.1411667157809, 862.0302160069921, 866.7573079537708, 868.5657171414293, 918.3663272342096, 919.9586018629144, 920.691568324612, 920.7191806499015, 920.9079092090805, 742.4431676242818, 911.4850109688072, 913.0960349254224, 913.2693844924067, 913.4793167894303, 561.2675458526621, 646.7510008646658, 659.6240143118424, 661.794843598486, 666.183924692253, 13210.933945330213, 13213.471461141542, 13224.867751322556, 13228.404721787543, 13252.668683282898, 13385.330733463288, 13402.530911418053, 13543.051986360959, 13617.251051192181, 13818.239996800172, 12766.744665106646, 12900.09699321048, 13059.216447013114, 13171.538996135088, 13234.801477977839, 4416.24923762961, 4433.290673492225, 4455.908302465884, 4456.8885777855485, 4567.634589232854, 56099.0, 57837.0, 57908.0, 65941.01088483725, 66535.0, 11459.942700286612, 11698.766024679458, 11861.229020113666, 11886.940565297118, 11933.58232461877, 20710.79289207119, 20885.164593416397, 21049.579008419747, 21107.26124585632, 21224.469388265108, 8653.437526560754, 8677.39258251929, 8753.781155471164, 8757.2994160467, 8780.297576193889, 4691.483936766953, 4762.690425122425, 4954.256861470736, 5054.317667114966, 5069.239614057921, 3524.242287908061, 3641.8543258269374, 3673.081729567608, 3679.0066681995713, 3696.74122811406, 640.3116649601603, 642.2229102785682, 645.2901808011244, 656.0847617573459, 670.165643773505, 633.6451587111233, 708.6067232685908, 726.3789460011719, 732.9230430804795, 739.1832025611621, 9639.9036009639, 9927.553260103312, 10027.699169024942, 10389.168866490663, 10435.582576696846, 695.3220609905403, 712.3766704133883, 752.3454594502817, 776.1036003416064, 795.129333379948, 4809.0, 4935.531124543163, 4973.850784476472, 5012.548870601663, 5015.147424937696, 57766.7111664439, 65212.0, 99887.46721925042, 101667.0, 101914.0, 56220.15669764957, 63003.05495417572, 85432.57283713542, 87762.0, 90127.54936225277, 49230.01539969181, 50078.74960625174, 60460.69769651123, 61619.07571386433, 62845.37154628486, 9186.494742789211, 9464.384814987005, 9514.714558563253, 9541.998090200428, 9553.426794392359, 34206.0, 46795.532044679116, 47047.0, 47953.28070078882, 48989.0, 37488.0, 56259.156112657525, 64221.0, 64268.67865660642, 65961.0, 12865.614031579067, 12936.676583085498, 13008.739825203633, 13034.348282585643, 13262.734745305233, 14014.579562613138, 14305.284735763378, 14468.348924298642, 14581.270936453348, 14802.77795833085, 10105.696829095139, 13270.1374410663, 13491.123076999964, 13598.11612245201, 14082.647933801736, 12845.486180552673, 12914.677133071373, 12988.025898057494, 13022.218666880017, 13349.399277032751, 13553.932230338785, 13640.181589104686, 13725.107867988949, 13731.107478013897, 14433.278336082943, 11044.226904116635, 11457.942710286396, 11882.57199478841, 11938.58214962472, 12116.27302361861, 11145.164112691418, 11543.942280288546, 11707.0, 11785.941070294593, 11846.407679616157], "value": 7343.656393717888, "unit": "score"}], "name": "dromaeo_css", "value": 7387.800391557516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 110.0, 111.0, 114.0, 113.0, 115.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 121.0, 161.0, 123.0, 122.0, 122.0, 122.0, 153.0, 123.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 76.0, 75.0, 75.0, 74.0, 95.0, 74.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 123.0, 82.0, 82.0, 82.0, 101.0, 81.0, 81.0, 108.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 50.0, 49.0, 53.0, 50.0, 49.0, 50.0, 50.0, 49.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 76.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 122.0, 126.0, 126.0, 128.0, 127.0, 124.0, 132.0, 174.0, 133.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 157.0, 160.0, 153.0, 162.0, 155.0, 154.0, 155.0, 162.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 62.0, 63.0, 61.0, 64.0, 63.0, 61.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1458.6999999999998, "alertThreshold": 2.0}]} 03:50:41 INFO - Return code: 0 03:50:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:41 ERROR - # TBPL SUCCESS # 03:50:41 INFO - Running post-action listener: _resource_record_post_action 03:50:41 INFO - [mozharness: 2016-11-17 11:50:41.532741Z] Finished run-tests step (success) 03:50:41 INFO - Running post-run listener: _resource_record_post_run 03:50:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 354004992; Read time: 0; Write time: 258044 03:50:41 INFO - TinderboxPrint: CPU usage
13.0% 03:50:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:50:41 INFO - TinderboxPrint: I/O write bytes / time
354,004,992 / 258,044 03:50:41 INFO - TinderboxPrint: CPU idle
8,273.4 (87.0%) 03:50:41 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 03:50:41 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107945984; Read time: 0; Write time: 94492 03:50:41 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 245592064; Read time: 0; Write time: 163548 03:50:42 INFO - Running post-run listener: _upload_blobber_files 03:50:42 INFO - Blob upload gear active. 03:50:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:42 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:50:42 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:50:42 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:50:42 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:50:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:43 INFO - (blobuploader) - INFO - Done attempting. 03:50:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:50:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:50:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:45 INFO - (blobuploader) - INFO - Done attempting. 03:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:48 INFO - (blobuploader) - INFO - Done attempting. 03:50:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:48 INFO - Return code: 0 03:50:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12379d251550d81ead3bf4c73457f94e3b91752f7cc6012f673a2615f64fc19b1403d548c0608f4e891ccc7083c505b8d8726fe867acf28e9bdffa9ed748b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3fa1c46bf2705c1a80cfd591499318c0238c7ae24e64088aa95e265876b673f894ee8d5ede69dd04dd5e5313d8eedb18be841d6745a5999ac3120e234f51166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b485615f90723b1fe331c11215da1e29d6efceb7fddadf76f3251837fb5f0d292610a8814ac99bf4905d1db7f93e9f3cc29eacd5d015fe023e4c9123ab102ce0"} 03:50:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:48 INFO - Contents: 03:50:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12379d251550d81ead3bf4c73457f94e3b91752f7cc6012f673a2615f64fc19b1403d548c0608f4e891ccc7083c505b8d8726fe867acf28e9bdffa9ed748b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3fa1c46bf2705c1a80cfd591499318c0238c7ae24e64088aa95e265876b673f894ee8d5ede69dd04dd5e5313d8eedb18be841d6745a5999ac3120e234f51166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b485615f90723b1fe331c11215da1e29d6efceb7fddadf76f3251837fb5f0d292610a8814ac99bf4905d1db7f93e9f3cc29eacd5d015fe023e4c9123ab102ce0"} 03:50:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:48 INFO - Copying logs to upload dir... 03:50:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.245520 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-17 03:50:48.274586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:48.278716) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12379d251550d81ead3bf4c73457f94e3b91752f7cc6012f673a2615f64fc19b1403d548c0608f4e891ccc7083c505b8d8726fe867acf28e9bdffa9ed748b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3fa1c46bf2705c1a80cfd591499318c0238c7ae24e64088aa95e265876b673f894ee8d5ede69dd04dd5e5313d8eedb18be841d6745a5999ac3120e234f51166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b485615f90723b1fe331c11215da1e29d6efceb7fddadf76f3251837fb5f0d292610a8814ac99bf4905d1db7f93e9f3cc29eacd5d015fe023e4c9123ab102ce0"} 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.011817 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/12379d251550d81ead3bf4c73457f94e3b91752f7cc6012f673a2615f64fc19b1403d548c0608f4e891ccc7083c505b8d8726fe867acf28e9bdffa9ed748b0b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3fa1c46bf2705c1a80cfd591499318c0238c7ae24e64088aa95e265876b673f894ee8d5ede69dd04dd5e5313d8eedb18be841d6745a5999ac3120e234f51166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b485615f90723b1fe331c11215da1e29d6efceb7fddadf76f3251837fb5f0d292610a8814ac99bf4905d1db7f93e9f3cc29eacd5d015fe023e4c9123ab102ce0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:48.304369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:48.304697) ========= 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=14ef55db36f7623abb31b9cf000001d5-1479382210.38668-1575833450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 03:50:48.389869) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 03:50:48.390206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 03:50:48.390488) ========= ========= Total master_lag: 0.18 =========