builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1476787694.9 results: success (0) buildid: 20161018034806 builduid: b8ce3f944a584ec8b9745b983f8d4f01 revision: 4c00c744b5cc395f1b497085229bcffd5033513c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:14.901535) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:14.901963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:14.902872) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:14.925555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:14.925881) ========= 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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 03:48:15-- 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% 113M=0s 2016-10-18 03:48:16 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.030534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.030868) ========= 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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013043 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.082498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.082870) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4c00c744b5cc395f1b497085229bcffd5033513c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4c00c744b5cc395f1b497085229bcffd5033513c --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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 03:48:16,125 truncating revision to first 12 chars 2016-10-18 03:48:16,125 Setting DEBUG logging. 2016-10-18 03:48:16,126 attempt 1/10 2016-10-18 03:48:16,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4c00c744b5cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 03:48:16,585 unpacking tar archive at: autoland-4c00c744b5cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.878010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.878357) ========= script_repo_revision: 4c00c744b5cc395f1b497085229bcffd5033513c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.878810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.879191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 03:48:15.889896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-18 03:48:15.890225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:17 INFO - MultiFileLogger online at 20161018 03:48:17 in /builds/slave/test 03:48:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:48:17 INFO - {'append_to_log': False, 03:48:17 INFO - 'base_work_dir': '/builds/slave/test', 03:48:17 INFO - 'blob_upload_branch': 'Autoland', 03:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:48:17 INFO - 'branch': 'Autoland', 03:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:17 INFO - 'config_files': ('talos/linux_config.py',), 03:48:17 INFO - 'default_actions': ('clobber', 03:48:17 INFO - 'read-buildbot-config', 03:48:17 INFO - 'download-and-extract', 03:48:17 INFO - 'populate-webroot', 03:48:17 INFO - 'create-virtualenv', 03:48:17 INFO - 'install', 03:48:17 INFO - 'run-tests'), 03:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:17 INFO - 'download_minidump_stackwalk': True, 03:48:17 INFO - 'download_symbols': 'ondemand', 03:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:17 INFO - 'installer_path': 'installer.exe', 03:48:17 INFO - 'log_level': 'info', 03:48:17 INFO - 'log_name': 'talos', 03:48:17 INFO - 'log_to_console': True, 03:48:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:17 INFO - 'opt_config_files': (), 03:48:17 INFO - 'pip_index': False, 03:48:17 INFO - 'sps_profile': False, 03:48:17 INFO - 'sps_profile_interval': 0, 03:48:17 INFO - 'suite': 'dromaeojs', 03:48:17 INFO - 'system_bits': '32', 03:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:17 INFO - 'title': 'talos-linux64-ix-028', 03:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:17 INFO - 'use_talos_json': True, 03:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:17 INFO - 'work_dir': 'build'} 03:48:17 INFO - [mozharness: 2016-10-18 10:48:17.033400Z] Running clobber step. 03:48:17 INFO - Running pre-action listener: _resource_record_pre_action 03:48:17 INFO - Running main action method: clobber 03:48:17 INFO - rmtree: /builds/slave/test/build 03:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:48:18 INFO - Running post-action listener: _resource_record_post_action 03:48:18 INFO - [mozharness: 2016-10-18 10:48:18.021921Z] Finished clobber step (success) 03:48:18 INFO - [mozharness: 2016-10-18 10:48:18.022021Z] Running read-buildbot-config step. 03:48:18 INFO - Running pre-action listener: _resource_record_pre_action 03:48:18 INFO - Running main action method: read_buildbot_config 03:48:18 INFO - Using buildbot properties: 03:48:18 INFO - { 03:48:18 INFO - "project": "", 03:48:18 INFO - "product": "firefox", 03:48:18 INFO - "script_repo_revision": "production", 03:48:18 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:48:18 INFO - "repository": "", 03:48:18 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 03:48:18 INFO - "buildid": "20161018034806", 03:48:18 INFO - "stage_platform": "linux64-pgo", 03:48:18 INFO - "basedir": "/builds/slave/test", 03:48:18 INFO - "buildnumber": 361, 03:48:18 INFO - "platform": "ubuntu64_hw", 03:48:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:48:18 INFO - "slavebuilddir": "test", 03:48:18 INFO - "branch": "autoland", 03:48:18 INFO - "revision": "4c00c744b5cc395f1b497085229bcffd5033513c", 03:48:18 INFO - "slavename": "talos-linux64-ix-028", 03:48:18 INFO - "builduid": "b8ce3f944a584ec8b9745b983f8d4f01", 03:48:18 INFO - "repo_path": "integration/autoland" 03:48:18 INFO - } 03:48:18 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:48:18 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 03:48:18 INFO - Running post-action listener: _resource_record_post_action 03:48:18 INFO - [mozharness: 2016-10-18 10:48:18.024383Z] Finished read-buildbot-config step (success) 03:48:18 INFO - [mozharness: 2016-10-18 10:48:18.024471Z] Running download-and-extract step. 03:48:18 INFO - Running pre-action listener: _resource_record_pre_action 03:48:18 INFO - Running main action method: download_and_extract 03:48:18 INFO - mkdir: /builds/slave/test/build/tests 03:48:18 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:48:18 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:48:18 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:48:18 INFO - Downloaded 1361 bytes. 03:48:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:48:18 INFO - Using the following test package requirements: 03:48:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:48:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'jsshell-linux-x86_64.zip'], 03:48:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:48:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:18 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:48:18 INFO - Http code: 200 03:48:18 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 03:48:18 INFO - x-amz-cf-id: zprHiuqiEpjkBRqlFB5wACQFv-6NK4xZeisGVl3FgAPYo6bl8EiJjA== 03:48:18 INFO - x-amz-replication-status: COMPLETED 03:48:18 INFO - x-amz-version-id: XDUtYm9.Pr2ndh1U66CqJxFo9VWD80DC 03:48:18 INFO - Expected file size: 22090437 03:48:18 INFO - Obtained file size: 22090437 03:48:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:48:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:48:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:48:22 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:48:22 INFO - Http code: 200 03:48:22 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 03:48:22 INFO - x-amz-cf-id: Gla89igapSmWUpP3GB3aMFwtfDwsh33L3v_plbdpXU_CpaZviDCniA== 03:48:22 INFO - x-amz-replication-status: COMPLETED 03:48:22 INFO - x-amz-version-id: XDUtYm9.Pr2ndh1U66CqJxFo9VWD80DC 03:48:22 INFO - Expected file size: 22090437 03:48:22 INFO - Obtained file size: 22090437 03:48:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:48:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:48:27 INFO - Http code: 200 03:48:27 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 03:48:27 INFO - x-amz-cf-id: pVdj9RXelet8RFmcVhjPQpAVrIpGqNmlr66oOGDTRCu-Dd3luhccMw== 03:48:27 INFO - x-amz-replication-status: COMPLETED 03:48:27 INFO - x-amz-version-id: 5gZe.rzwoTDma3p946HnIGRAK3tNpPc7 03:48:27 INFO - Expected file size: 14409028 03:48:27 INFO - Obtained file size: 14409028 03:48:27 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:48:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:48:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:48:29 INFO - Downloaded 59502022 bytes. 03:48:29 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:48:29 INFO - mkdir: /builds/slave/test/properties 03:48:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:48:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:48:29 INFO - Contents: 03:48:29 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:48:30 INFO - Running post-action listener: _resource_record_post_action 03:48:30 INFO - Running post-action listener: set_extra_try_arguments 03:48:30 INFO - [mozharness: 2016-10-18 10:48:30.103393Z] Finished download-and-extract step (success) 03:48:30 INFO - [mozharness: 2016-10-18 10:48:30.103621Z] Running populate-webroot step. 03:48:30 INFO - Running pre-action listener: _resource_record_pre_action 03:48:30 INFO - Running main action method: populate_webroot 03:48:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:30 INFO - '--tppagecycles', 03:48:30 INFO - '7'], 03:48:30 INFO - 'tests': ['tsvgm']}}, 03:48:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:48:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:48:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:48:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['damp', 'tps']}, 03:48:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'tests': ['damp', 'tps']}, 03:48:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['dromaeo_dom']}, 03:48:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['basic_compositor_video']}, 03:48:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:48:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['a11yr', 03:48:30 INFO - 'ts_paint', 03:48:30 INFO - 'tpaint', 03:48:30 INFO - 'sessionrestore', 03:48:30 INFO - 'sessionrestore_no_auto_restore', 03:48:30 INFO - 'tabpaint']}, 03:48:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['tsvgx', 03:48:30 INFO - 'tsvgr_opacity', 03:48:30 INFO - 'tart', 03:48:30 INFO - 'tscrollx', 03:48:30 INFO - 'cart']}, 03:48:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:48:30 INFO - 'tsvgr_opacity', 03:48:30 INFO - 'tart', 03:48:30 INFO - 'tscrollx', 03:48:30 INFO - 'cart']}, 03:48:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'talos_options': ['--disable-e10s'], 03:48:30 INFO - 'tests': ['tp5o']}, 03:48:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'tests': ['tp5o']}, 03:48:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'talos_options': ['--disable-e10s', 03:48:30 INFO - '--xperf_path', 03:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:30 INFO - 'tests': ['tp5n']}, 03:48:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:30 INFO - 'talos_options': ['--xperf_path', 03:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:30 INFO - 'tests': ['tp5n']}}, 03:48:30 INFO - 'talos.zip': {'path': '', 03:48:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:30 INFO - Running post-action listener: _resource_record_post_action 03:48:30 INFO - [mozharness: 2016-10-18 10:48:30.119025Z] Finished populate-webroot step (success) 03:48:30 INFO - [mozharness: 2016-10-18 10:48:30.119113Z] Running create-virtualenv step. 03:48:30 INFO - Running pre-action listener: _resource_record_pre_action 03:48:30 INFO - Running main action method: create_virtualenv 03:48:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:48:30 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:48:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:48:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:30 INFO - Using real prefix '/usr' 03:48:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:48:32 INFO - Installing pip.................done. 03:48:32 INFO - Return code: 0 03:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:48:32 INFO - Reading from file tmpfile_stdout 03:48:32 INFO - Output received: 03:48:32 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:48:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:48: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:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48: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', 'pip>=1.5'] in /builds/slave/test/build 03:48: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 pip>=1.5 03:48:32 INFO - Using env: {'DISPLAY': ':0', 03:48:32 INFO - 'HOME': '/home/cltbld', 03:48:32 INFO - 'LANG': 'en_US.UTF-8', 03:48:32 INFO - 'LANGUAGE': 'en_US:en', 03:48:32 INFO - 'LOGNAME': 'cltbld', 03:48:32 INFO - 'MAIL': '/var/mail/cltbld', 03:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:32 INFO - 'MOZ_NO_REMOTE': '1', 03:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:32 INFO - 'NO_EM_RESTART': '1', 03:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:32 INFO - 'PWD': '/builds/slave/test', 03:48:32 INFO - 'SHELL': '/bin/bash', 03:48:32 INFO - 'SHLVL': '1', 03:48:32 INFO - 'TERM': 'linux', 03:48:32 INFO - 'TMOUT': '86400', 03:48:32 INFO - 'USER': 'cltbld', 03:48:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:32 INFO - '_': '/tools/buildbot/bin/python'} 03:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:33 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:48:33 INFO - Cleaning up... 03:48:33 INFO - Return code: 0 03:48:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:48:33 INFO - Using env: {'DISPLAY': ':0', 03:48:33 INFO - 'HOME': '/home/cltbld', 03:48:33 INFO - 'LANG': 'en_US.UTF-8', 03:48:33 INFO - 'LANGUAGE': 'en_US:en', 03:48:33 INFO - 'LOGNAME': 'cltbld', 03:48:33 INFO - 'MAIL': '/var/mail/cltbld', 03:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:33 INFO - 'MOZ_NO_REMOTE': '1', 03:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:33 INFO - 'NO_EM_RESTART': '1', 03:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:33 INFO - 'PWD': '/builds/slave/test', 03:48:33 INFO - 'SHELL': '/bin/bash', 03:48:33 INFO - 'SHLVL': '1', 03:48:33 INFO - 'TERM': 'linux', 03:48:33 INFO - 'TMOUT': '86400', 03:48:33 INFO - 'USER': 'cltbld', 03:48:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:33 INFO - '_': '/tools/buildbot/bin/python'} 03:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:33 INFO - Downloading/unpacking psutil>=3.1.1 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:35 INFO - Installing collected packages: psutil 03:48:35 INFO - Running setup.py install for psutil 03:48:35 INFO - building 'psutil._psutil_linux' extension 03:48:35 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:48:35 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:48:35 INFO - building 'psutil._psutil_posix' extension 03:48:35 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:48:35 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:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:48:35 INFO - Successfully installed psutil 03:48:35 INFO - Cleaning up... 03:48:35 INFO - Return code: 0 03:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:48:35 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:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:35 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:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:35 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:35 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:48:35 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:48:35 INFO - Using env: {'DISPLAY': ':0', 03:48:35 INFO - 'HOME': '/home/cltbld', 03:48:35 INFO - 'LANG': 'en_US.UTF-8', 03:48:35 INFO - 'LANGUAGE': 'en_US:en', 03:48:35 INFO - 'LOGNAME': 'cltbld', 03:48:35 INFO - 'MAIL': '/var/mail/cltbld', 03:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:35 INFO - 'MOZ_NO_REMOTE': '1', 03:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:35 INFO - 'NO_EM_RESTART': '1', 03:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:35 INFO - 'PWD': '/builds/slave/test', 03:48:35 INFO - 'SHELL': '/bin/bash', 03:48:35 INFO - 'SHLVL': '1', 03:48:35 INFO - 'TERM': 'linux', 03:48:35 INFO - 'TMOUT': '86400', 03:48:35 INFO - 'USER': 'cltbld', 03:48:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:35 INFO - '_': '/tools/buildbot/bin/python'} 03:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:48:38 INFO - Installing collected packages: mozsystemmonitor 03:48:38 INFO - Running setup.py install for mozsystemmonitor 03:48:38 INFO - Successfully installed mozsystemmonitor 03:48:38 INFO - Cleaning up... 03:48:38 INFO - Return code: 0 03:48:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:38 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:38 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:48:38 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:48:38 INFO - Using env: {'DISPLAY': ':0', 03:48:38 INFO - 'HOME': '/home/cltbld', 03:48:38 INFO - 'LANG': 'en_US.UTF-8', 03:48:38 INFO - 'LANGUAGE': 'en_US:en', 03:48:38 INFO - 'LOGNAME': 'cltbld', 03:48:38 INFO - 'MAIL': '/var/mail/cltbld', 03:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:38 INFO - 'MOZ_NO_REMOTE': '1', 03:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:38 INFO - 'NO_EM_RESTART': '1', 03:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:38 INFO - 'PWD': '/builds/slave/test', 03:48:38 INFO - 'SHELL': '/bin/bash', 03:48:38 INFO - 'SHLVL': '1', 03:48:38 INFO - 'TERM': 'linux', 03:48:38 INFO - 'TMOUT': '86400', 03:48:38 INFO - 'USER': 'cltbld', 03:48:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:38 INFO - '_': '/tools/buildbot/bin/python'} 03:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:48: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:48: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:48: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:48: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:48: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:48: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:48:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:48: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:48: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:48: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:48: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:48: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:48: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:48:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:40 INFO - warning: no files found matching '*.txt' 03:48:40 INFO - no previously-included directories found matching 'build' 03:48:40 INFO - no previously-included directories found matching 'dist' 03:48:40 INFO - no previously-included directories found matching '.git*' 03:48:40 INFO - Installing collected packages: jsonschema, functools32 03:48:40 INFO - Running setup.py install for functools32 03:48:40 INFO - warning: no files found matching '*.txt' 03:48:40 INFO - no previously-included directories found matching 'build' 03:48:40 INFO - no previously-included directories found matching 'dist' 03:48:40 INFO - no previously-included directories found matching '.git*' 03:48:40 INFO - Successfully installed jsonschema functools32 03:48:40 INFO - Cleaning up... 03:48:40 INFO - Return code: 0 03:48:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:48:40 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:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:40 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:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:40 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:40 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:48:40 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:48:40 INFO - Using env: {'DISPLAY': ':0', 03:48:40 INFO - 'HOME': '/home/cltbld', 03:48:40 INFO - 'LANG': 'en_US.UTF-8', 03:48:40 INFO - 'LANGUAGE': 'en_US:en', 03:48:40 INFO - 'LOGNAME': 'cltbld', 03:48:40 INFO - 'MAIL': '/var/mail/cltbld', 03:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:40 INFO - 'MOZ_NO_REMOTE': '1', 03:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:40 INFO - 'NO_EM_RESTART': '1', 03:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:40 INFO - 'PWD': '/builds/slave/test', 03:48:40 INFO - 'SHELL': '/bin/bash', 03:48:40 INFO - 'SHLVL': '1', 03:48:40 INFO - 'TERM': 'linux', 03:48:40 INFO - 'TMOUT': '86400', 03:48:40 INFO - 'USER': 'cltbld', 03:48:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:40 INFO - '_': '/tools/buildbot/bin/python'} 03:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:48:41 INFO - Cleaning up... 03:48:41 INFO - Return code: 0 03:48:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:48: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:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:41 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:41 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:48:41 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:48:41 INFO - Using env: {'DISPLAY': ':0', 03:48:41 INFO - 'HOME': '/home/cltbld', 03:48:41 INFO - 'LANG': 'en_US.UTF-8', 03:48:41 INFO - 'LANGUAGE': 'en_US:en', 03:48:41 INFO - 'LOGNAME': 'cltbld', 03:48:41 INFO - 'MAIL': '/var/mail/cltbld', 03:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:41 INFO - 'MOZ_NO_REMOTE': '1', 03:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:41 INFO - 'NO_EM_RESTART': '1', 03:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:41 INFO - 'PWD': '/builds/slave/test', 03:48:41 INFO - 'SHELL': '/bin/bash', 03:48:41 INFO - 'SHLVL': '1', 03:48:41 INFO - 'TERM': 'linux', 03:48:41 INFO - 'TMOUT': '86400', 03:48:41 INFO - 'USER': 'cltbld', 03:48:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:41 INFO - '_': '/tools/buildbot/bin/python'} 03:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:43 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:48:43 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:48:43 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:48:43 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:48:43 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:48:43 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:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:43 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:48:43 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:48:43 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:48:43 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:48:43 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:48:43 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:48:43 INFO - Downloading docopt-0.6.1.tar.gz 03:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:44 INFO - Running setup.py install for blobuploader 03:48:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:48:44 INFO - Running setup.py install for requests 03:48:44 INFO - Running setup.py install for docopt 03:48:44 INFO - Successfully installed blobuploader requests docopt 03:48:44 INFO - Cleaning up... 03:48:44 INFO - Return code: 0 03:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48: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:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:44 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:44 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:48:44 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:48:44 INFO - Using env: {'DISPLAY': ':0', 03:48:44 INFO - 'HOME': '/home/cltbld', 03:48:44 INFO - 'LANG': 'en_US.UTF-8', 03:48:44 INFO - 'LANGUAGE': 'en_US:en', 03:48:44 INFO - 'LOGNAME': 'cltbld', 03:48:44 INFO - 'MAIL': '/var/mail/cltbld', 03:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:44 INFO - 'MOZ_NO_REMOTE': '1', 03:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:44 INFO - 'NO_EM_RESTART': '1', 03:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:44 INFO - 'PWD': '/builds/slave/test', 03:48:44 INFO - 'SHELL': '/bin/bash', 03:48:44 INFO - 'SHLVL': '1', 03:48:44 INFO - 'TERM': 'linux', 03:48:44 INFO - 'TMOUT': '86400', 03:48:44 INFO - 'USER': 'cltbld', 03:48:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:44 INFO - '_': '/tools/buildbot/bin/python'} 03:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:44 INFO - Running setup.py (path:/tmp/pip-mSf5G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:44 INFO - Running setup.py (path:/tmp/pip-GEKHU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:45 INFO - Running setup.py (path:/tmp/pip-hj9XXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:45 INFO - Running setup.py (path:/tmp/pip-9TpG_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:45 INFO - Running setup.py (path:/tmp/pip-Rjfoqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:45 INFO - Running setup.py (path:/tmp/pip-s63EJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:45 INFO - Running setup.py (path:/tmp/pip-DKstQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:45 INFO - Running setup.py (path:/tmp/pip-PUXRSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:45 INFO - Running setup.py (path:/tmp/pip-gTkGu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:45 INFO - Running setup.py (path:/tmp/pip-nKSsI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:45 INFO - Running setup.py (path:/tmp/pip-AjwuRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:45 INFO - Running setup.py (path:/tmp/pip-xuVyuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:45 INFO - Running setup.py (path:/tmp/pip-js4j6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:45 INFO - Running setup.py (path:/tmp/pip-lr2XUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:45 INFO - Running setup.py (path:/tmp/pip-4gqC6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:45 INFO - Running setup.py (path:/tmp/pip-5WHA6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:46 INFO - Running setup.py (path:/tmp/pip-9s3Oit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:46 INFO - Running setup.py install for manifestparser 03:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Running setup.py install for mozcrash 03:48:46 INFO - Running setup.py install for mozdebug 03:48:46 INFO - Running setup.py install for mozdevice 03:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Running setup.py install for mozfile 03:48:46 INFO - Running setup.py install for mozhttpd 03:48:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Running setup.py install for mozinfo 03:48:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Running setup.py install for mozInstall 03:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:46 INFO - Running setup.py install for mozleak 03:48:47 INFO - Running setup.py install for mozlog 03:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Running setup.py install for moznetwork 03:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Running setup.py install for mozprocess 03:48:47 INFO - Running setup.py install for mozprofile 03:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Running setup.py install for mozrunner 03:48:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Running setup.py install for mozscreenshot 03:48:47 INFO - Running setup.py install for moztest 03:48:47 INFO - Running setup.py install for mozversion 03:48:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:47 INFO - Cleaning up... 03:48:47 INFO - Return code: 0 03:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:47 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:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:47 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:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:47 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:47 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:48:47 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:48:47 INFO - Using env: {'DISPLAY': ':0', 03:48:47 INFO - 'HOME': '/home/cltbld', 03:48:47 INFO - 'LANG': 'en_US.UTF-8', 03:48:47 INFO - 'LANGUAGE': 'en_US:en', 03:48:47 INFO - 'LOGNAME': 'cltbld', 03:48:47 INFO - 'MAIL': '/var/mail/cltbld', 03:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:47 INFO - 'MOZ_NO_REMOTE': '1', 03:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:47 INFO - 'NO_EM_RESTART': '1', 03:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:47 INFO - 'PWD': '/builds/slave/test', 03:48:47 INFO - 'SHELL': '/bin/bash', 03:48:47 INFO - 'SHLVL': '1', 03:48:47 INFO - 'TERM': 'linux', 03:48:47 INFO - 'TMOUT': '86400', 03:48:47 INFO - 'USER': 'cltbld', 03:48:47 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:47 INFO - '_': '/tools/buildbot/bin/python'} 03:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:48 INFO - Running setup.py (path:/tmp/pip-pds6Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:48 INFO - Running setup.py (path:/tmp/pip-oigWOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:48 INFO - Running setup.py (path:/tmp/pip-18buEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:48 INFO - Running setup.py (path:/tmp/pip-CEJNMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:48 INFO - Running setup.py (path:/tmp/pip-Bl8ZlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:48 INFO - Running setup.py (path:/tmp/pip-U69oQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:48 INFO - Running setup.py (path:/tmp/pip-96c9ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:48 INFO - Running setup.py (path:/tmp/pip-19Irui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:48 INFO - Running setup.py (path:/tmp/pip-Lc3C5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:48 INFO - Running setup.py (path:/tmp/pip-8_WyCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:48 INFO - Running setup.py (path:/tmp/pip-5nn87D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:48 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:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:48 INFO - Running setup.py (path:/tmp/pip-ukUKCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:49 INFO - Running setup.py (path:/tmp/pip-45hmoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:49 INFO - Running setup.py (path:/tmp/pip-IH3Nq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:49 INFO - Running setup.py (path:/tmp/pip-4uo2AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:49 INFO - Running setup.py (path:/tmp/pip-vmH34F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:49 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:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:49 INFO - Running setup.py (path:/tmp/pip-Bc8JWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:49 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:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:49 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:48:49 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:48:49 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:48:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:49 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:48:51 INFO - Downloading blessings-1.6.tar.gz 03:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:51 INFO - Installing collected packages: blessings 03:48:51 INFO - Running setup.py install for blessings 03:48:51 INFO - Successfully installed blessings 03:48:51 INFO - Cleaning up... 03:48:51 INFO - Return code: 0 03:48:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:51 INFO - Reading from file tmpfile_stdout 03:48:51 INFO - Current package versions: 03:48:51 INFO - argparse == 1.2.1 03:48:51 INFO - blessings == 1.6 03:48:51 INFO - blobuploader == 1.2.4 03:48:51 INFO - docopt == 0.6.1 03:48:51 INFO - functools32 == 3.2.3-2 03:48:51 INFO - jsonschema == 2.5.1 03:48:51 INFO - manifestparser == 1.1 03:48:51 INFO - mozInstall == 1.12 03:48:51 INFO - mozcrash == 0.17 03:48:51 INFO - mozdebug == 0.1 03:48:51 INFO - mozdevice == 0.48 03:48:51 INFO - mozfile == 1.2 03:48:51 INFO - mozhttpd == 0.7 03:48:51 INFO - mozinfo == 0.9 03:48:51 INFO - mozleak == 0.1 03:48:51 INFO - mozlog == 3.4 03:48:51 INFO - moznetwork == 0.27 03:48:51 INFO - mozprocess == 0.23 03:48:51 INFO - mozprofile == 0.28 03:48:51 INFO - mozrunner == 6.12 03:48:51 INFO - mozscreenshot == 0.1 03:48:51 INFO - mozsystemmonitor == 0.3 03:48:51 INFO - moztest == 0.7 03:48:51 INFO - mozversion == 1.4 03:48:51 INFO - psutil == 3.1.1 03:48:51 INFO - requests == 1.2.3 03:48:51 INFO - wsgiref == 0.1.2 03:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:51 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:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:51 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:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:51 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 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:51 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:48:51 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:48:51 INFO - Using env: {'DISPLAY': ':0', 03:48:51 INFO - 'HOME': '/home/cltbld', 03:48:51 INFO - 'LANG': 'en_US.UTF-8', 03:48:51 INFO - 'LANGUAGE': 'en_US:en', 03:48:51 INFO - 'LOGNAME': 'cltbld', 03:48:51 INFO - 'MAIL': '/var/mail/cltbld', 03:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:51 INFO - 'MOZ_NO_REMOTE': '1', 03:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:51 INFO - 'NO_EM_RESTART': '1', 03:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:51 INFO - 'PWD': '/builds/slave/test', 03:48:51 INFO - 'SHELL': '/bin/bash', 03:48:51 INFO - 'SHLVL': '1', 03:48:51 INFO - 'TERM': 'linux', 03:48:51 INFO - 'TMOUT': '86400', 03:48:51 INFO - 'USER': 'cltbld', 03:48:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:51 INFO - '_': '/tools/buildbot/bin/python'} 03:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 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:48:52 INFO - Cleaning up... 03:48:52 INFO - Return code: 0 03:48:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05296dbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, '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': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', '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:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:52 INFO - Using env: {'DISPLAY': ':0', 03:48:52 INFO - 'HOME': '/home/cltbld', 03:48:52 INFO - 'LANG': 'en_US.UTF-8', 03:48:52 INFO - 'LANGUAGE': 'en_US:en', 03:48:52 INFO - 'LOGNAME': 'cltbld', 03:48:52 INFO - 'MAIL': '/var/mail/cltbld', 03:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:52 INFO - 'MOZ_NO_REMOTE': '1', 03:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:52 INFO - 'NO_EM_RESTART': '1', 03:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:52 INFO - 'PWD': '/builds/slave/test', 03:48:52 INFO - 'SHELL': '/bin/bash', 03:48:52 INFO - 'SHLVL': '1', 03:48:52 INFO - 'TERM': 'linux', 03:48:52 INFO - 'TMOUT': '86400', 03:48:52 INFO - 'USER': 'cltbld', 03:48:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:52 INFO - '_': '/tools/buildbot/bin/python'} 03:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:48:52 INFO - Cleaning up... 03:48:52 INFO - Return code: 0 03:48:52 INFO - Running post-action listener: _resource_record_post_action 03:48:52 INFO - Running post-action listener: _start_resource_monitoring 03:48:52 INFO - Starting resource monitoring. 03:48:52 INFO - [mozharness: 2016-10-18 10:48:52.322627Z] Finished create-virtualenv step (success) 03:48:52 INFO - [mozharness: 2016-10-18 10:48:52.323137Z] Running install step. 03:48:52 INFO - Running pre-action listener: _resource_record_pre_action 03:48:52 INFO - Running main action method: install 03:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:52 INFO - Reading from file tmpfile_stdout 03:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:52 INFO - Reading from file tmpfile_stdout 03:48:52 INFO - Output received: 03:48:52 INFO - Usage: mozinstall [options] installer 03:48:52 INFO - Options: 03:48:52 INFO - -h, --help show this help message and exit 03:48:52 INFO - -d DEST, --destination=DEST 03:48:52 INFO - Directory to install application into. [default: 03:48:52 INFO - "/builds/slave/test"] 03:48:52 INFO - --app=APP Application being installed. [default: firefox] 03:48:52 INFO - mkdir: /builds/slave/test/build/application 03:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:49:09 INFO - Reading from file tmpfile_stdout 03:49:09 INFO - Output received: 03:49:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:49:09 INFO - Running post-action listener: _resource_record_post_action 03:49:09 INFO - [mozharness: 2016-10-18 10:49:09.559274Z] Finished install step (success) 03:49:09 INFO - [mozharness: 2016-10-18 10:49:09.559548Z] Running run-tests step. 03:49:09 INFO - Running pre-action listener: _resource_record_pre_action 03:49:09 INFO - Running main action method: run_tests 03:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:49:09 INFO - Python 2.7.3 03:49:09 INFO - Return code: 0 03:49:09 INFO - grabbing minidump binary from tooltool 03:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:49:09 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 0x17c2930>, '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 0x17c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c3cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:49:09 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:49:09 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:49:09 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:49:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:09 INFO - Return code: 0 03:49:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:49:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:49:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:49:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:49:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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:49:09 INFO - Using env: {'DISPLAY': ':0', 03:49:09 INFO - 'HOME': '/home/cltbld', 03:49:09 INFO - 'LANG': 'en_US.UTF-8', 03:49:09 INFO - 'LANGUAGE': 'en_US:en', 03:49:09 INFO - 'LOGNAME': 'cltbld', 03:49:09 INFO - 'MAIL': '/var/mail/cltbld', 03:49:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:09 INFO - 'MOZ_NO_REMOTE': '1', 03:49:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:09 INFO - 'NO_EM_RESTART': '1', 03:49:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:09 INFO - 'PWD': '/builds/slave/test', 03:49:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:09 INFO - 'SHELL': '/bin/bash', 03:49:09 INFO - 'SHLVL': '1', 03:49:09 INFO - 'TERM': 'linux', 03:49:09 INFO - 'TMOUT': '86400', 03:49:09 INFO - 'USER': 'cltbld', 03:49:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710', 03:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:09 INFO - '_': '/tools/buildbot/bin/python'} 03:49:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:49:09 INFO - mozversion application_buildid: 20161018003002 03:49:09 INFO - mozversion application_changeset: 4c00c744b5cc395f1b497085229bcffd5033513c 03:49:09 INFO - mozversion application_display_name: Nightly 03:49:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:09 INFO - mozversion application_name: Firefox 03:49:09 INFO - mozversion application_remotingname: firefox 03:49:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:49:09 INFO - mozversion application_vendor: Mozilla 03:49:09 INFO - mozversion application_version: 52.0a1 03:49:09 INFO - mozversion platform_buildid: 20161018003002 03:49:09 INFO - mozversion platform_changeset: 4c00c744b5cc395f1b497085229bcffd5033513c 03:49:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:49:09 INFO - mozversion platform_version: 52.0a1 03:49:09 INFO - using testdate: 1476787749 03:49:09 INFO - actual date: 1476787749 03:49:09 INFO - starting webserver on 'localhost:40972' 03:49:09 INFO - SUITE-START | Running 2 tests 03:49:09 INFO - TEST-START | dromaeo_css 03:49:09 INFO - operating with platform_type : linux_ 03:49:09 INFO - Initialising browser for dromaeo_css test... 03:49:09 INFO - TEST-INFO | started process 31784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_WjOz/profile http://localhost:40972/getInfo.html) 03:49:14 INFO - PROCESS | 31784 | __metrics Screen width/height:1600/1200 03:49:14 INFO - PROCESS | 31784 | colorDepth:24 03:49:14 INFO - PROCESS | 31784 | Browser inner width/height: 1024/697 03:49:14 INFO - PROCESS | 31784 | __metrics 03:49:14 INFO - PROCESS | 31784 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:49:14 INFO - PROCESS | 31784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:15 INFO - PROCESS | 31784 | console.error: PushService: 03:49:15 INFO - PROCESS | 31784 | stateChangeProcessEnqueue: Error transitioning state 03:49:15 INFO - PROCESS | 31784 | UnknownError 03:49:16 INFO - TEST-INFO | 31784: exit 0 03:49:16 INFO - Browser initialized. 03:49:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:16 INFO - TEST-INFO | started process 31865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_WjOz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:28 INFO - PROCESS | 31865 | RSS: Main: 172044288 03:49:28 INFO - PROCESS | 31865 | 03:50:19 INFO - PROCESS | 31865 | 1476787819311 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:52:30 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40972/tests/dromaeo/cssquery-ext.html) 03:52:32 INFO - PROCESS | 31865 | RSS: Main: 288763904 03:52:32 INFO - PROCESS | 31865 | 03:55:34 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-ext.html (next: http://localhost:40972/tests/dromaeo/cssquery-jquery.html) 03:55:35 INFO - PROCESS | 31865 | RSS: Main: 276426752 03:55:35 INFO - PROCESS | 31865 | 03:58:37 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40972/tests/dromaeo/cssquery-mootools.html) 03:58:37 INFO - PROCESS | 31865 | RSS: Main: 259231744 03:58:37 INFO - PROCESS | 31865 | 04:01:39 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40972/tests/dromaeo/cssquery-prototype.html) 04:01:40 INFO - PROCESS | 31865 | RSS: Main: 248999936 04:01:40 INFO - PROCESS | 31865 | 04:04:43 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40972/tests/dromaeo/cssquery-yui.html) 04:04:43 INFO - PROCESS | 31865 | RSS: Main: 216260608 04:04:43 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | Cycle 1(1): loaded http://localhost:40972/tests/dromaeo/cssquery-yui.html (next: http://localhost:40972/tests/dromaeo/cssquery-dojo.html) 04:07:46 INFO - PROCESS | 31865 | RSS: Main: 312213504 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | __start_tp_report 04:07:46 INFO - PROCESS | 31865 | _x_x_mozilla_page_load 04:07:46 INFO - PROCESS | 31865 | _x_x_mozilla_page_load_details 04:07:46 INFO - PROCESS | 31865 | |i|pagename|runs| 04:07:46 INFO - PROCESS | 31865 | |0;dojo.html;3007.0978706388087;3067.8772849086035;3102.1469095998596;3104.534319852022;3112.3152906360606;5177.844664660057;5283.524482796547;5341.813036543722;5414.8917021659545;5451.182322651599;5291.047611429941;5303.549198318138;5315.681059136445;5316.016536940669;5318.787248510064;4802.5197480252045;4825.276208568725;4844.951550484503;4880.389951256093;4882.829100981467;4818.975905120469;4839.419269687643;4846.297286893398;4850.151223535885;4855.902881942359;4827.396575428072;4861.683990540603;4903.338049363326;4926.852194434155;4944.233643785201;4917.532834380746;4934.555889969884;4938.333325001151;4953.554180123806;5005.974970125162;4681.812727490897;4715.31627913954;4717.528247175289;4889.193283108283;4890.3642526471685;5224.947750522484;5291.735413229323;5301.522862942315;5309.681419114865;5377.274068000848;5611.270534830487;5678.5741069419955;5681.886362272731;5683.318001839806;5685.061964775807;5495.780168793243;5633.0423827948935;5636.04187288162;5734.770609175628;5818.185454036438;5294.523492885659;5309.41596424393;5309.601779866525;5360.410354860962;5371.194320851903;5796.217510636095;5802.21670074543;5802.767889284466;5808.361080281165;5811.215485909433;5397.703126328011;5509.146082357241;5564.554835613141;5570.888582228333;5579.609427340129;5608.074667679869;5677.545796336283;5687.374388817309;5745.1382292656435;5756.359437560275;5617.32592088952;5661.971690141605;5667.574931880125;5669.801556945487;5675.602707810496;5484.040292948718;5692.174634677948;5702.54379649627;5709.3434255060365;5711.114777209539;4256.084941737541;4305.225059489322;4305.4187684662165;4351.586599273064;4357.368181613711;3884.2425726983533;3885.572587015426;3890.513685789276;3929.1945151243926;3931.1351502669368;5423.132298832168;5433.673979561239;5439.428859969726;5444.40111587725;5501;5502.0921547944945;5539.723013849291;5607.915881261784;5670.773169073191;5763.740631671585;5344.171653393731;5352.732363381815;5353.973230133903;5394.838154855361;5415.891682166413;4876.000419913909;4881;4883.536064073907;4884.877878053077;4901.166801643729;5682.6306290091015;5684.0621297487105;5745.74144163522;5842.737076831553;5855.121731740188;5627.465390787868;5671.468703449963;5697.943020569741;5759.683217422914;5770.13447982806;5844.620099693507;5883.294004719461;5889.587728858939;5893.174955506147;5894.440028197314;5396.379416367168;5590.888182236251;5605.103183490622;5608.579356548194;5612.494875461228;5518.779248830002;5668.178114173505;5716.9142462862255;5738.885222295614;5813.476787089182;5596.496315331477;5653.802116926053;5661.264035675501;5665.745041473061;5666.405027472056;5565.415631358811;5617.32592088952;5618.044932361427;5625.549956003591;5625.549956003591;5348.5988550858065;5389.595780316414;5404.972975135099;5458.754356053908;5478.808241711521;5588.30146231721;5589.916151257653;5593.07714227148;5593.692346920959;5646.830595082154;5253.395859476209;5286.550643195218;5300.31095957523;5440.347158341025;5455.481729235717 04:07:46 INFO - PROCESS | 31865 | |1;ext.html;550.4283994618452;575.8905807896499;608.1455554945302;627.5857933763714;647.7732793522265;31877.681223187763;43348.349774753406;44079.33880991788;44193.55806441935;44236;43289.78355108228;43666.92161950033;43809.56190438095;43834.56165438345;43918.780406098005;8166.836663266731;8846.690365837181;9012;9016.098390160996;9045.728628141167;7986.081600615946;10526.789464210711;10782.946085269563;10787.892121078807;11102.777944441106;10856.294340867858;10909.07272881806;10911.127109831234;10937.289076210061;10957.12343012557;10325.741856453611;10391.636292729718;10396.948015259875;10398.896011039868;10457;10407.271490995634;10415.635452759192;10458.267921245515;10462.529186186639;10468.581256749721;41387.1722565547;41645;41790.58209417928;41837.58162418398;41850.1629967402;3353.144948038235;3458.5503884495106;3506.6142724300307;3557.683657046883;3730.9626903730887;30997.380052398825;31174.84412577945;31730.206744831565;31857;32473.188170295696;4283.528811830696;4324.113556720865;4379.671524635633;4400.779961001969;4580.129775342674;301101;302191.9999999978;303009;303986;306829;33175.17062073467;34017.82991085029;56359.154612680846;56521.71739141278;56637.433625663216;35932;35937.46093808595;36048.09879753027;36134.638653613656;36184.81907590445;14011;14102.576922692335;14121;14128.646783830487;14133.929330353489;10434.217433692504;10677;11375.203735738585;11377.715557110972;11387.829182562267;8010;8130.918690813016;8146.063202731643;8215.09633940266;8272.255497005299;3164.920876978048;3173.8730450782173;3211.887583934551;3220.3559288142465;3242.918927026796;977.5014742481386;992.731962370156;1001.3140998416109;1037.4657051618422;1074.5164675895878;31013.689863101532;31025;31069.223269418446;31083.378332433225;31704.207394815316;981.7153025622632;998.7503124218945;1024.4314405505015;1039.7140786283833;1073.350622873166;16336.712860199581;16353.509394718178;16522;16531.421400250932;16669.832351970927;447626;452633;455608;455945;458803;57786.7110664444;58016.41983580195;58197.70901145467;58429;58443.70778146082;1178.6169494914186;1210.727586293077;1218.7745267125788;1299.9935000325127;1323;24633.876830615733;31059.22351941129;31275.374492509567;33500.49749253714;34010.38782199971;52978.470215297355;53344.73327633337;53549;53576.73211633917;53736;335591;335820;336188;336649;337374;24259.150929717376;24772.752272477046;26221.868890655423;27377;27791.16626501208;41015.794921025205;45666.54333456623;45706.31440528461;45737.542624573325;46405.30392044054;38216.04459888525;38450.230995380494;38937.805310973265;39089.21821563496;40618.59381406148;38038.54033670851;38391.42412863753;38641.42037869378;38711.80611102323;39037.60962390454;37863;39149.60850391573;39246.607533924296;39464.40803388009;39481;32610.51084233691;34141.14647133742;34401;34940;35094;26371.475506423358;26679.599806003313;26794;26861.462770744085;27256.182314530597 04:07:46 INFO - PROCESS | 31865 | |2;jquery.html;362.4762218594131;377.34907284933485;381.3916802699694;386.8297948902484;410.26357687950144;16835.989840609556;18972.5256868578;19242.422727318168;19460.63775535713;19619.5095122622;18352.174152163152;18721.438356849318;18858;19239.42281731547;19267.614647707036;5423.105187644034;5438.238646589481;5657.9717101414435;5665.943340566583;5666.291713535808;5543.722813859311;5559.694216818073;5602.355729091166;5615.101583746601;5623.80316688916;5492.835214943558;5569.554435645159;5569.777208911639;5574.47042530961;5578.219049333096;5341.572674186055;5550.195221692872;5560.638558493685;5560.972195139018;5561.443855614447;4949.08441938239;4957.876053098666;4962.1812400953795;5011.899762004739;5237.685738855681;13393.129446585941;13509.864901350958;13577.59267221985;13613.727725445535;13620.387082581308;2178.194068194762;2214.236088549464;2292.3008482412856;2308.6421604651305;2879;9765.414075155513;9845.950770246174;9939.90060099397;9971.25215608825;10247.538860751209;1769.6991511443086;1859.9256029758794;1866.850651947841;1895.981040189608;1942.4561122885614;85010;94636;95196.9999999993;95407.52296238474;95491.52254238684;14887.404503819942;16746.581335466468;16942.745858812126;17063.317467301167;17463.912680436515;30313.848430757706;30677.386452270828;30839.845800770854;30929.741943869598;31115.68884311128;8668.8699669505;9063.13900179482;9122.771930701785;9313.627454901729;9504.144626983605;7446.24488939096;7474.177840437547;7497.362724168398;7670.808229794188;7678.846423071507;8424.831503369898;8463.534505602127;8535.829283414298;8617.95691021541;8690.261327787082;3146.8269245191277;3253.8698452062126;3369.814660193713;3377.6453472385047;3467.3238718450166;909.9135582119688;925.5233554719325;938.4134915677702;966.3090890013533;1020.7295066807302;16539.421120260733;17872.28510859577;18190.63618727618;18817.529561761065;18959.241630334633;872.8690696395591;911.4485736129678;916.9587368568297;919.990800092004;945.2721404518483;9983.15143212835;9991.800163996679;10387.84418233727;10444.251825726487;10456.947715261374;438834;443982;445068;447346;452293;49177;78645.21354786493;80504;81400.59299703463;82659;1013.7921726046143;1031.3141760729181;1088.9128869690405;1091.2361347057092;1092.82514797632;16400;16669.406215288636;16949;17511.38710145139;17547.56131096733;29761.10716678503;35253;38680.41979370368;40732.1853562933;42058.4898210117;55994.720026401235;56456.717716411156;56623.433765661815;56775;58736;8134.63394147253;8165.836683266182;8175.672973081248;8454.070052294119;8481.109483504144;9404.905950940676;12203.572874949334;12373.443195056065;12812.807807883075;12831.294278814381;10207.336523125972;10360.430176340073;10404.167666586807;10830;11656.358900260568;11218;11575.42122893835;11603.767924641628;11698.899137161694;12053.63839084829;11606.70983225426;11835.46740396667;12015.158938874194;12107.33409662477;12212.267263964191;8161.714339998071;8362.790930226793;8459.873101903353;8511.40420170607;8541.95729021351;9341.532923353941;11053.226274160732;11219.71950701239;11244.943775281072;11651.41742912834 04:07:46 INFO - PROCESS | 31865 | |3;mootools.html;1309.0509380699;1423.8077859488965;1464.1581090872749;1612.6774645070989;1774.059748333383;7993.600319984;8860.20258176764;9193.35646504745;9263.953680231607;9323.393979391334;9033.954830225839;9109.95445022774;9116.225120864734;9123.270138388929;9124.40691355063;2270.8523945943502;2297.322289924468;2300.114455934469;2302.861828290308;2307.227078928561;2208.3043841190056;2255.1655887321713;2258.4918393361527;2285.108807565051;2293.5068960173558;2199.9450013749624;2225.4770129019666;2237.9104835806547;2249.0553967333676;2249.977500225001;2197.41768431365;2199.197292988056;2208.9668654970187;2209.8011178993806;2213.225371120111;2188.616992026405;2196.374033400489;2197.681336206257;2197.912083516673;2201.559688062378;8764.474131552128;8870.758093866863;8899.243564296978;9063.274938004944;9138.862917056249;5256.947430525723;5400.243965844785;5407.648502847342;5411.783528658849;5413.431589683105;3394.8811791587423;3442.7417943654327;3477.600075991268;3479.6172421033666;3484.756067075306;1089.2593036735018;1108.3294606762954;2158.881261530615;2186.814120799734;2233.743119541241;12334.136610437274;12766.744665106646;12840.165389249669;12861.485540578366;12904.870951290555;4386.912261754811;4617.492075871652;4706.458757242893;4717.150912835723;4737.431508219036;10809;10823.621173258898;10824.404657743742;10834.349939003685;10847.67456976292;5374.838754837361;5376.112941364631;5378.381486129067;5379.058664733656;5379.811706590251;4265.594768496988;4388.824447022147;4768.546988036131;4913.778879950411;4961.330220420269;3793.6206379361843;3895.8052097395584;4000.8999775005277;4004.5795191505053;4018;1220.6338098570393;1261.7476504698914;1267.473998290699;1272.6182145356356;1273.2933222061658;694.3091623834317;804.9154838741965;805.0781854776249;817.7424111404888;847.0597636623343;5397.919031214535;5473.972630136904;5534.723263836872;5582.274304340491;5607.691576963224;436.4391756592763;447.83206297638384;448.47304417309533;453.5124740903542;458.5666545114834;3716.3124821907495;3744.569374521965;3780.281746468162;3822.513436204061;3930.312195365857;10926.617568385227;11502.884971150348;11518.769624607628;11520.13598980063;11544;11414.828777568344;11415;11419;11422.885771142348;11446.656600302003;7952;8356.373272004503;8478;8543.487390756574;8574;5854.151148083419;5989.8203053908455;6064.908117982332;6069.2716873975405;6119.2350956130485;10458.843117353397;10480.266381353233;10583.629572965217;10614.946925265323;10677.786444271227;9958.103770660675;10242.6415075472;10380.636677716546;10388.220883433622;10690.57237710514;7101.82245443868;7339.339459448675;7598.544087354777;7863.252990965849;8088.029436467662;8521.957390213258;8770.956145219234;8773.605187766694;8780.736577902673;8781.824363512565;7759.883601745865;7800.297973182441;7853.175416581176;7967.641456134604;8059.879101813594;7692.653830577526;7704.499207551491;7830.8825367620675;7907.762767116996;7913.3669306456495;6958.165020197609;7066.258042905421;7070.823229419306;7071.434285257064;7075.964620176866;5132.897342053213;5179.171332586768;5180.6891586503425;5278.630495865253;5400.378956420062;5166.199239117943;5183.637145399785;5221.660592061504;5275.89448211026;5503.284573005644 04:07:46 INFO - PROCESS | 31865 | |4;prototype.html;311.604262586515;313.50153256322443;317.3399329394859;324.7288514090734;325.2665239884061;5086.313347698059;5173.9482605173935;5256.474352564742;5321.92017119743;5329.8134565290175;4988.251762235666;5114.53969142778;5133.845984620468;5169.457206993258;5172.060477321004;4071.9389209161886;4083.203775263825;4100.425940368351;4103.9794801025955;4139.875803725893;3811.866584669537;3962.5839286874893;4076.5515793262866;4114.938275925863;4139.254934111858;3969.9206015879663;4019.914623051789;4050.979745101285;4074.348104303312;4097.848629469538;4043.130726893717;4075.5735492577655;4076.6331030207275;4084.7344922579937;4090.6318431341324;3618.8733394331334;3619.348517266891;3619.457081437779;3629.800360980145;3637.4543818427182;4935.605151587864;5010.296499190293;5014.52362025607;5020.272060551236;5080.364954380702;4627.305904114376;4634.3048542718525;4652.441706995149;4673.415823022122;4688.156131896258;5428.782848686087;5434.728263586805;5434.728263586844;5458.563314934796;5478.643888147258;3765.736398452082;3927.705422093326;3957.426173204869;3974.841006359771;3979.880603581897;5615.326160860723;5696.515796157331;5696.572757043238;5707.74315155819;5710.257666503369;4102.897427564275;4112.067328355668;4115.464989551339;4115.753054816721;4136;3932.193900250442;4107.8973025674595;4124.113120815441;4161.52142503616;4161.854335098257;4667.32323813052;4677.95322046782;4682.836100736458;4685.742284174335;4702.482726900038;5496.890062198813;5540.252065971123;5543.750531226105;5547.667139971614;5554.805581804618;1374.7558459594084;1417.595985144229;1419.4747943260852;1430.8783753380872;1436.992815035918;909.7361765088183;916.9174774270348;926.3654396738256;927.8608208768738;929.5956259027345;4673.579377856009;4695.154872122982;4699.699774706174;4699.976500117477;4713.010267843722;4943.579795717333;4981.651284410129;4982.9252561211615;4986.55121039101;4987.902661414483;4450.888727781767;4669.252919532859;4679.461861885927;4689.718616882998;4715.834945776881;2625.2124362691115;2644.405008872988;2645.4576811753545;2658.3088397016913;2671.545837207679;5029.572486338702;5076.44159142494;5078.263651770547;5078.644494885322;5116.186097646279;4821.770448535601;4982.302477653131;5003.324551185616;5040.798368065236;5066.518680725325;5020.096382651158;5062.215356619729;5070.594352451795;5091.872703182376;5113.772694553355;4919.827806026772;4942.481039490802;4960.677555958851;4990.525900039491;4991.825286114969;4548.408706868218;4826.831060912851;4875.1712208923855;4913.63147763912;4977.427595826382;5009.974950125226;5039.949600503948;5040.6219533534395;5091.87270318245;5127.179651255781;3713.7586056906216;3723;3762.548494180716;3851.9614803851605;3964.861229856941;5389.62272640927;5591.804286849941;5591.860203494945;5609.831705048855;5630;5484.972575137099;5500.477454641803;5508.283923089973;5525.557955363481;5528.903813864249;5290.6032047597355;5378.892422151614;5408.945910540844;5476.220228425698;5491.615586908878;5353.491418315254;5355.892882142413;5395.757190926496;5397.168010712438;5409.161579955114;5499.780008799603;5511.409637470382;5516.531094856982;5521.917171242515;5526.58550608714;5144.742762861917;5366.919496207638;5387.730613469389;5389.407165211745;5394.757235924471 04:07:46 INFO - PROCESS | 31865 | |5;yui.html;653.9182602174725;724.6376811594203;756.9280918312759;792.3146478296273;818.4148333941233;15384.692306153871;15998.440054598092;16098.83901160988;16119.032858028511;16120.113393763339;14870.405183792662;15003.699926001473;15035.699286014273;15042.24788760563;15062.397504099823;646.4246820329887;662.3839828959091;769.8806684963839;770.5838847022601;793.8015496125969;794.5788731972035;794.6265255329986;797.314309693663;798.8282519258358;801.4790386248956;839.95380254086;840.4495055738471;841.2386789955101;841.5750046226647;842.4650347029619;830;834.7120243516038;834.9833003339929;835.448603921412;835.5446281776447;501.5330159284116;515.8375111839758;593.8307582339056;611.3092205807453;615.2524682510771;14762.483313084098;14809.259537023214;14838.70322593553;14871.925640371728;14948.850511494855;12871.742565148645;13004.739905201843;13582.864171358258;13678.247696376695;13804.378802953892;12454.626361209179;12725.490980360775;12743.74512509754;13199.076064675477;13584;4390.231709450865;4391.8462853799965;4470.128324976631;4530.909381812346;4608.8386906458445;79488.60255698685;79743;80693.59653201755;80943;84753;10798.622048228275;10872.945635271773;11025.724356891142;11186.105111591054;11287.887121128684;20155.596888062155;20359.287424940354;20365.185392584426;20375;20375.28686495995;7694.923050769421;7888.6450109744055;7932.960335198287;7980.281774640311;8123.75628731139;4579.381783459257;4599.770011499411;4627.236505976476;4642.46611639659;4674.626029917598;3290.276139249361;3422.845971931269;3437.7937323760652;3441.3633477806184;3453.8963831085107;605.4369436424167;609.3662590905409;619.2754477261615;646.247122102745;651.6513665189195;584.3017593975159;626.3611116661071;666.3003845961721;671.0612269137146;683.064202043204;9147;9191.908080919238;9264.675736349196;9285.535723213812;9715.562799674031;555.4501043966525;609.4667166229549;622.6699849079995;647.4723100672936;650.3189255773877;4179.791010449526;4484.596386325246;4519.84180553679;4522.276435770261;4634.652401069933;68162.65918670375;68211.65894170597;68374.3162568368;68943;108952.91047089428;86639.56680216685;91635.08364916265;93433;93650.53174734219;95256.52371738097;52345;54524;77300;87782.56108719416;89293.55353223323;8258.215469530385;8365.205305495969;8479.830403392021;8618.569071546523;8644.56777161152;39873.60126398699;50249.74875125601;50900.23649645184;53147;53244.46755532395;71368.64315678389;72103.63948180225;75845.62077189579;76336.23663763292;76942;10987.230893837355;11309.943450283025;11580.652580422264;11628.53485860556;11678.065754739431;12565.811512827499;12599.622011339674;12644.873551264369;12893.613191604267;13114.950743963833;11057.336559806437;11085.778284434105;11736.823947640622;12148.939255303667;12496.812547811973;10776.29954052984;11215.43922803873;11225.214235003472;11567.132465064986;11646.650600481998;11557.479913404086;11919.702007449883;12362;12505.249685018563;12511.249325040526;9458.621655133718;9771.560279787569;9805.166560842408;9935.65225217114;9941.751456213653;8256.339492840438;9022.774430639287;9066.320025998208;9551.952240238754;9622.663206787729 04:07:46 INFO - PROCESS | 31865 | __end_tp_report 04:07:46 INFO - PROCESS | 31865 | __start_cc_report 04:07:46 INFO - PROCESS | 31865 | _x_x_mozilla_cycle_collect,1073 04:07:46 INFO - PROCESS | 31865 | __end_cc_report 04:07:46 INFO - PROCESS | 31865 | __startTimestamp1476788866914__endTimestamp 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | ------- Summary: start ------- 04:07:46 INFO - PROCESS | 31865 | Number of tests: 6 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#0] dojo.html Cycles:165 Average:5275.92 Median:5451.18 stddev:591.13 (10.8%) stddev-sans-first:565.51 04:07:46 INFO - PROCESS | 31865 | Values: 3007.1 3067.9 3102.1 3104.5 3112.3 5177.8 5283.5 5341.8 5414.9 5451.2 5291.0 5303.5 5315.7 5316.0 5318.8 4802.5 4825.3 4845.0 4880.4 4882.8 4819.0 4839.4 4846.3 4850.2 4855.9 4827.4 4861.7 4903.3 4926.9 4944.2 4917.5 4934.6 4938.3 4953.6 5006.0 4681.8 4715.3 4717.5 4889.2 4890.4 5224.9 5291.7 5301.5 5309.7 5377.3 5611.3 5678.6 5681.9 5683.3 5685.1 5495.8 5633.0 5636.0 5734.8 5818.2 5294.5 5309.4 5309.6 5360.4 5371.2 5796.2 5802.2 5802.8 5808.4 5811.2 5397.7 5509.1 5564.6 5570.9 5579.6 5608.1 5677.5 5687.4 5745.1 5756.4 5617.3 5662.0 5667.6 5669.8 5675.6 5484.0 5692.2 5702.5 5709.3 5711.1 4256.1 4305.2 4305.4 4351.6 4357.4 3884.2 3885.6 3890.5 3929.2 3931.1 5423.1 5433.7 5439.4 5444.4 5501.0 5502.1 5539.7 5607.9 5670.8 5763.7 5344.2 5352.7 5354.0 5394.8 5415.9 4876.0 4881.0 4883.5 4884.9 4901.2 5682.6 5684.1 5745.7 5842.7 5855.1 5627.5 5671.5 5697.9 5759.7 5770.1 5844.6 5883.3 5889.6 5893.2 5894.4 5396.4 5590.9 5605.1 5608.6 5612.5 5518.8 5668.2 5716.9 5738.9 5813.5 5596.5 5653.8 5661.3 5665.7 5666.4 5565.4 5617.3 5618.0 5625.5 5625.5 5348.6 5389.6 5405.0 5458.8 5478.8 5588.3 5589.9 5593.1 5593.7 5646.8 5253.4 5286.6 5300.3 5440.3 5455.5 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#1] ext.html Cycles:180 Average:52050.94 Median:34271.07 stddev:97810.40 (285.4%) stddev-sans-first:98008.35 04:07:46 INFO - PROCESS | 31865 | Values: 550.4 575.9 608.1 627.6 647.8 31877.7 43348.3 44079.3 44193.6 44236.0 43289.8 43666.9 43809.6 43834.6 43918.8 8166.8 8846.7 9012.0 9016.1 9045.7 7986.1 10526.8 10782.9 10787.9 11102.8 10856.3 10909.1 10911.1 10937.3 10957.1 10325.7 10391.6 10396.9 10398.9 10457.0 10407.3 10415.6 10458.3 10462.5 10468.6 41387.2 41645.0 41790.6 41837.6 41850.2 3353.1 3458.6 3506.6 3557.7 3731.0 30997.4 31174.8 31730.2 31857.0 32473.2 4283.5 4324.1 4379.7 4400.8 4580.1 301101.0 302192.0 303009.0 303986.0 306829.0 33175.2 34017.8 56359.2 56521.7 56637.4 35932.0 35937.5 36048.1 36134.6 36184.8 14011.0 14102.6 14121.0 14128.6 14133.9 10434.2 10677.0 11375.2 11377.7 11387.8 8010.0 8130.9 8146.1 8215.1 8272.3 3164.9 3173.9 3211.9 3220.4 3242.9 977.5 992.7 1001.3 1037.5 1074.5 31013.7 31025.0 31069.2 31083.4 31704.2 981.7 998.8 1024.4 1039.7 1073.4 16336.7 16353.5 16522.0 16531.4 16669.8 447626.0 452633.0 455608.0 455945.0 458803.0 57786.7 58016.4 58197.7 58429.0 58443.7 1178.6 1210.7 1218.8 1300.0 1323.0 24633.9 31059.2 31275.4 33500.5 34010.4 52978.5 53344.7 53549.0 53576.7 53736.0 335591.0 335820.0 336188.0 336649.0 337374.0 24259.2 24772.8 26221.9 27377.0 27791.2 41015.8 45666.5 45706.3 45737.5 46405.3 38216.0 38450.2 38937.8 39089.2 40618.6 38038.5 38391.4 38641.4 38711.8 39037.6 37863.0 39149.6 39246.6 39464.4 39481.0 32610.5 34141.1 34401.0 34940.0 35094.0 26371.5 26679.6 26794.0 26861.5 27256.2 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#2] jquery.html Cycles:180 Average:27734.90 Median:20571.22 stddev:73609.50 (357.8%) stddev-sans-first:73787.30 04:07:46 INFO - PROCESS | 31865 | Values: 362.5 377.3 381.4 386.8 410.3 16836.0 18972.5 19242.4 19460.6 19619.5 18352.2 18721.4 18858.0 19239.4 19267.6 5423.1 5438.2 5658.0 5665.9 5666.3 5543.7 5559.7 5602.4 5615.1 5623.8 5492.8 5569.6 5569.8 5574.5 5578.2 5341.6 5550.2 5560.6 5561.0 5561.4 4949.1 4957.9 4962.2 5011.9 5237.7 13393.1 13509.9 13577.6 13613.7 13620.4 2178.2 2214.2 2292.3 2308.6 2879.0 9765.4 9846.0 9939.9 9971.3 10247.5 1769.7 1859.9 1866.9 1896.0 1942.5 85010.0 94636.0 95197.0 95407.5 95491.5 14887.4 16746.6 16942.7 17063.3 17463.9 30313.8 30677.4 30839.8 30929.7 31115.7 8668.9 9063.1 9122.8 9313.6 9504.1 7446.2 7474.2 7497.4 7670.8 7678.8 8424.8 8463.5 8535.8 8618.0 8690.3 3146.8 3253.9 3369.8 3377.6 3467.3 909.9 925.5 938.4 966.3 1020.7 16539.4 17872.3 18190.6 18817.5 18959.2 872.9 911.4 917.0 920.0 945.3 9983.2 9991.8 10387.8 10444.3 10456.9 438834.0 443982.0 445068.0 447346.0 452293.0 49177.0 78645.2 80504.0 81400.6 82659.0 1013.8 1031.3 1088.9 1091.2 1092.8 16400.0 16669.4 16949.0 17511.4 17547.6 29761.1 35253.0 38680.4 40732.2 42058.5 55994.7 56456.7 56623.4 56775.0 58736.0 8134.6 8165.8 8175.7 8454.1 8481.1 9404.9 12203.6 12373.4 12812.8 12831.3 10207.3 10360.4 10404.2 10830.0 11656.4 11218.0 11575.4 11603.8 11698.9 12053.6 11606.7 11835.5 12015.2 12107.3 12212.3 8161.7 8362.8 8459.9 8511.4 8542.0 9341.5 11053.2 11219.7 11244.9 11651.4 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#3] mootools.html Cycles:180 Average:5888.09 Median:456.04 stddev:3460.42 (758.8%) stddev-sans-first:3453.01 04:07:46 INFO - PROCESS | 31865 | Values: 1309.1 1423.8 1464.2 1612.7 1774.1 7993.6 8860.2 9193.4 9264.0 9323.4 9034.0 9110.0 9116.2 9123.3 9124.4 2270.9 2297.3 2300.1 2302.9 2307.2 2208.3 2255.2 2258.5 2285.1 2293.5 2199.9 2225.5 2237.9 2249.1 2250.0 2197.4 2199.2 2209.0 2209.8 2213.2 2188.6 2196.4 2197.7 2197.9 2201.6 8764.5 8870.8 8899.2 9063.3 9138.9 5256.9 5400.2 5407.6 5411.8 5413.4 3394.9 3442.7 3477.6 3479.6 3484.8 1089.3 1108.3 2158.9 2186.8 2233.7 12334.1 12766.7 12840.2 12861.5 12904.9 4386.9 4617.5 4706.5 4717.2 4737.4 10809.0 10823.6 10824.4 10834.3 10847.7 5374.8 5376.1 5378.4 5379.1 5379.8 4265.6 4388.8 4768.5 4913.8 4961.3 3793.6 3895.8 4000.9 4004.6 4018.0 1220.6 1261.7 1267.5 1272.6 1273.3 694.3 804.9 805.1 817.7 847.1 5397.9 5474.0 5534.7 5582.3 5607.7 436.4 447.8 448.5 453.5 458.6 3716.3 3744.6 3780.3 3822.5 3930.3 10926.6 11502.9 11518.8 11520.1 11544.0 11414.8 11415.0 11419.0 11422.9 11446.7 7952.0 8356.4 8478.0 8543.5 8574.0 5854.2 5989.8 6064.9 6069.3 6119.2 10458.8 10480.3 10583.6 10614.9 10677.8 9958.1 10242.6 10380.6 10388.2 10690.6 7101.8 7339.3 7598.5 7863.3 8088.0 8522.0 8771.0 8773.6 8780.7 8781.8 7759.9 7800.3 7853.2 7967.6 8059.9 7692.7 7704.5 7830.9 7907.8 7913.4 6958.2 7066.3 7070.8 7071.4 7076.0 5132.9 5179.2 5180.7 5278.6 5400.4 5166.2 5183.6 5221.7 5275.9 5503.3 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#4] prototype.html Cycles:180 Average:4430.19 Median:4979.54 stddev:1270.21 (25.5%) stddev-sans-first:1235.59 04:07:46 INFO - PROCESS | 31865 | Values: 311.6 313.5 317.3 324.7 325.3 5086.3 5173.9 5256.5 5321.9 5329.8 4988.3 5114.5 5133.8 5169.5 5172.1 4071.9 4083.2 4100.4 4104.0 4139.9 3811.9 3962.6 4076.6 4114.9 4139.3 3969.9 4019.9 4051.0 4074.3 4097.8 4043.1 4075.6 4076.6 4084.7 4090.6 3618.9 3619.3 3619.5 3629.8 3637.5 4935.6 5010.3 5014.5 5020.3 5080.4 4627.3 4634.3 4652.4 4673.4 4688.2 5428.8 5434.7 5434.7 5458.6 5478.6 3765.7 3927.7 3957.4 3974.8 3979.9 5615.3 5696.5 5696.6 5707.7 5710.3 4102.9 4112.1 4115.5 4115.8 4136.0 3932.2 4107.9 4124.1 4161.5 4161.9 4667.3 4678.0 4682.8 4685.7 4702.5 5496.9 5540.3 5543.8 5547.7 5554.8 1374.8 1417.6 1419.5 1430.9 1437.0 909.7 916.9 926.4 927.9 929.6 4673.6 4695.2 4699.7 4700.0 4713.0 4943.6 4981.7 4982.9 4986.6 4987.9 4450.9 4669.3 4679.5 4689.7 4715.8 2625.2 2644.4 2645.5 2658.3 2671.5 5029.6 5076.4 5078.3 5078.6 5116.2 4821.8 4982.3 5003.3 5040.8 5066.5 5020.1 5062.2 5070.6 5091.9 5113.8 4919.8 4942.5 4960.7 4990.5 4991.8 4548.4 4826.8 4875.2 4913.6 4977.4 5010.0 5039.9 5040.6 5091.9 5127.2 3713.8 3723.0 3762.5 3852.0 3964.9 5389.6 5591.8 5591.9 5609.8 5630.0 5485.0 5500.5 5508.3 5525.6 5528.9 5290.6 5378.9 5408.9 5476.2 5491.6 5353.5 5355.9 5395.8 5397.2 5409.2 5499.8 5511.4 5516.5 5521.9 5526.6 5144.7 5366.9 5387.7 5389.4 5394.8 04:07:46 INFO - PROCESS | 31865 | 04:07:46 INFO - PROCESS | 31865 | [#5] yui.html Cycles:180 Average:18801.86 Median:569.88 stddev:26290.82 (4613.4%) stddev-sans-first:26329.26 04:07:46 INFO - PROCESS | 31865 | Values: 653.9 724.6 756.9 792.3 818.4 15384.7 15998.4 16098.8 16119.0 16120.1 14870.4 15003.7 15035.7 15042.2 15062.4 646.4 662.4 769.9 770.6 793.8 794.6 794.6 797.3 798.8 801.5 840.0 840.4 841.2 841.6 842.5 830.0 834.7 835.0 835.4 835.5 501.5 515.8 593.8 611.3 615.3 14762.5 14809.3 14838.7 14871.9 14948.9 12871.7 13004.7 13582.9 13678.2 13804.4 12454.6 12725.5 12743.7 13199.1 13584.0 4390.2 4391.8 4470.1 4530.9 4608.8 79488.6 79743.0 80693.6 80943.0 84753.0 10798.6 10872.9 11025.7 11186.1 11287.9 20155.6 20359.3 20365.2 20375.0 20375.3 7694.9 7888.6 7933.0 7980.3 8123.8 4579.4 4599.8 4627.2 4642.5 4674.6 3290.3 3422.8 3437.8 3441.4 3453.9 605.4 609.4 619.3 646.2 651.7 584.3 626.4 666.3 671.1 683.1 9147.0 9191.9 9264.7 9285.5 9715.6 555.5 609.5 622.7 647.5 650.3 4179.8 4484.6 4519.8 4522.3 4634.7 68162.7 68211.7 68374.3 68943.0 108952.9 86639.6 91635.1 93433.0 93650.5 95256.5 52345.0 54524.0 77300.0 87782.6 89293.6 8258.2 8365.2 8479.8 8618.6 8644.6 39873.6 50249.7 50900.2 53147.0 53244.5 71368.6 72103.6 75845.6 76336.2 76942.0 10987.2 11309.9 11580.7 11628.5 11678.1 12565.8 12599.6 12644.9 12893.6 13115.0 11057.3 11085.8 11736.8 12148.9 12496.8 10776.3 11215.4 11225.2 11567.1 11646.7 11557.5 11919.7 12362.0 12505.2 12511.2 9458.6 9771.6 9805.2 9935.7 9941.8 8256.3 9022.8 9066.3 9552.0 9622.7 04:07:46 INFO - PROCESS | 31865 | -------- Summary: end -------- 04:07:46 INFO - PROCESS | 31865 | 04:07:47 INFO - TEST-INFO | 31865: exit 0 04:07:47 INFO - TEST-OK | dromaeo_css | took 1117985ms 04:07:47 INFO - TEST-START | kraken 04:07:47 INFO - operating with platform_type : linux_ 04:07:47 INFO - Initialising browser for kraken test... 04:07:47 INFO - TEST-INFO | started process 32174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7JlPlS/profile http://localhost:40972/getInfo.html) 04:07:51 INFO - PROCESS | 32174 | __metrics Screen width/height:1600/1200 04:07:51 INFO - PROCESS | 32174 | colorDepth:24 04:07:51 INFO - PROCESS | 32174 | Browser inner width/height: 1024/697 04:07:51 INFO - PROCESS | 32174 | __metrics 04:07:52 INFO - PROCESS | 32174 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:07:52 INFO - PROCESS | 32174 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:53 INFO - PROCESS | 32174 | console.error: PushService: 04:07:53 INFO - PROCESS | 32174 | stateChangeProcessEnqueue: Error transitioning state 04:07:53 INFO - PROCESS | 32174 | UnknownError 04:07:53 INFO - TEST-INFO | 32174: exit 0 04:07:53 INFO - Browser initialized. 04:07:53 INFO - Running cycle 1/1 for kraken test... 04:07:53 INFO - TEST-INFO | started process 32257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7JlPlS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:06 INFO - PROCESS | 32257 | RSS: Main: 172408832 04:08:06 INFO - PROCESS | 32257 | 04:08:08 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40972/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:09 INFO - PROCESS | 32257 | RSS: Main: 229306368 04:08:09 INFO - PROCESS | 32257 | 04:08:12 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40972/tests/kraken/driver.html?testName=audio-dft) 04:08:12 INFO - PROCESS | 32257 | RSS: Main: 216047616 04:08:12 INFO - PROCESS | 32257 | 04:08:15 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40972/tests/kraken/driver.html?testName=audio-fft) 04:08:16 INFO - PROCESS | 32257 | RSS: Main: 298151936 04:08:16 INFO - PROCESS | 32257 | 04:08:18 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40972/tests/kraken/driver.html?testName=audio-oscillator) 04:08:19 INFO - PROCESS | 32257 | RSS: Main: 209833984 04:08:19 INFO - PROCESS | 32257 | 04:08:21 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:21 INFO - PROCESS | 32257 | RSS: Main: 212058112 04:08:21 INFO - PROCESS | 32257 | 04:08:24 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40972/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:25 INFO - PROCESS | 32257 | RSS: Main: 247816192 04:08:25 INFO - PROCESS | 32257 | 04:08:28 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40972/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:29 INFO - PROCESS | 32257 | RSS: Main: 246763520 04:08:29 INFO - PROCESS | 32257 | 04:08:31 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40972/tests/kraken/driver.html?testName=json-parse-financial) 04:08:32 INFO - PROCESS | 32257 | RSS: Main: 246497280 04:08:32 INFO - PROCESS | 32257 | 04:08:34 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:08:34 INFO - PROCESS | 32257 | RSS: Main: 209166336 04:08:34 INFO - PROCESS | 32257 | 04:08:36 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:08:36 INFO - PROCESS | 32257 | RSS: Main: 216498176 04:08:36 INFO - PROCESS | 32257 | 04:08:39 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:39 INFO - PROCESS | 32257 | RSS: Main: 226009088 04:08:39 INFO - PROCESS | 32257 | 04:08:42 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:42 INFO - PROCESS | 32257 | RSS: Main: 234393600 04:08:42 INFO - PROCESS | 32257 | 04:08:45 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:46 INFO - PROCESS | 32257 | RSS: Main: 230895616 04:08:46 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | Cycle 1(1): loaded http://localhost:40972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40972/tests/kraken/driver.html?testName=ai-astar) 04:08:48 INFO - PROCESS | 32257 | RSS: Main: 282673152 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | __start_tp_report 04:08:48 INFO - PROCESS | 32257 | _x_x_mozilla_page_load 04:08:48 INFO - PROCESS | 32257 | _x_x_mozilla_page_load_details 04:08:48 INFO - PROCESS | 32257 | |i|pagename|runs| 04:08:48 INFO - PROCESS | 32257 | |0;ai-astar;105;111;112;110;112;110;112;111;112;111 04:08:48 INFO - PROCESS | 32257 | |1;audio-beat-detection;152;123;124;164;126;121;122;122;164;128 04:08:48 INFO - PROCESS | 32257 | |2;audio-dft;163;162;162;163;162;162;162;163;161;161 04:08:48 INFO - PROCESS | 32257 | |3;audio-fft;75;76;76;104;76;75;77;75;105;75 04:08:48 INFO - PROCESS | 32257 | |4;audio-oscillator;82;82;120;84;83;82;102;82;81;115 04:08:48 INFO - PROCESS | 32257 | |5;imaging-gaussian-blur;116;118;117;118;117;116;118;117;116;117 04:08:48 INFO - PROCESS | 32257 | |6;imaging-darkroom;146;146;147;146;145;146;146;146;146;145 04:08:48 INFO - PROCESS | 32257 | |7;imaging-desaturate;85;85;84;85;84;84;86;85;85;85 04:08:48 INFO - PROCESS | 32257 | |8;json-parse-financial;54;51;51;52;52;53;60;52;51;52 04:08:48 INFO - PROCESS | 32257 | |9;json-stringify-tinderbox;59;61;60;61;60;60;60;59;60;61 04:08:48 INFO - PROCESS | 32257 | |10;stanford-crypto-aes;79;79;78;79;79;79;79;80;80;79 04:08:48 INFO - PROCESS | 32257 | |11;stanford-crypto-ccm;138;131;128;130;129;137;140;132;176;132 04:08:48 INFO - PROCESS | 32257 | |12;stanford-crypto-pbkdf2;164;171;167;167;169;166;166;169;167;167 04:08:48 INFO - PROCESS | 32257 | |13;stanford-crypto-sha256-iterative;70;66;65;65;66;65;65;65;65;65 04:08:48 INFO - PROCESS | 32257 | __end_tp_report 04:08:48 INFO - PROCESS | 32257 | __start_cc_report 04:08:48 INFO - PROCESS | 32257 | _x_x_mozilla_cycle_collect,1701 04:08:48 INFO - PROCESS | 32257 | __end_cc_report 04:08:48 INFO - PROCESS | 32257 | __startTimestamp1476788928302__endTimestamp 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | ------- Summary: start ------- 04:08:48 INFO - PROCESS | 32257 | Number of tests: 14 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.12 (1.9%) stddev-sans-first:0.83 04:08:48 INFO - PROCESS | 32257 | Values: 105.0 111.0 112.0 110.0 112.0 110.0 112.0 111.0 112.0 111.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:127.00 stddev:17.95 (14.1%) stddev-sans-first:17.90 04:08:48 INFO - PROCESS | 32257 | Values: 152.0 123.0 124.0 164.0 126.0 121.0 122.0 122.0 164.0 128.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:08:48 INFO - PROCESS | 32257 | Values: 163.0 162.0 162.0 163.0 162.0 162.0 162.0 163.0 161.0 161.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.50 stddev:12.19 (16.2%) stddev-sans-first:12.71 04:08:48 INFO - PROCESS | 32257 | Values: 75.0 76.0 76.0 104.0 76.0 75.0 77.0 75.0 105.0 75.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:15.18 (18.5%) stddev-sans-first:15.72 04:08:48 INFO - PROCESS | 32257 | Values: 82.0 82.0 120.0 84.0 83.0 82.0 102.0 82.0 81.0 115.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 04:08:48 INFO - PROCESS | 32257 | Values: 116.0 118.0 117.0 118.0 117.0 116.0 118.0 117.0 116.0 117.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:08:48 INFO - PROCESS | 32257 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:08:48 INFO - PROCESS | 32257 | Values: 85.0 85.0 84.0 85.0 84.0 84.0 86.0 85.0 85.0 85.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.00 stddev:2.70 (5.2%) stddev-sans-first:2.83 04:08:48 INFO - PROCESS | 32257 | Values: 54.0 51.0 51.0 52.0 52.0 53.0 60.0 52.0 51.0 52.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 04:08:48 INFO - PROCESS | 32257 | Values: 59.0 61.0 60.0 61.0 60.0 60.0 60.0 59.0 60.0 61.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 04:08:48 INFO - PROCESS | 32257 | Values: 79.0 79.0 78.0 79.0 79.0 79.0 79.0 80.0 80.0 79.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.50 stddev:14.18 (10.5%) stddev-sans-first:15.04 04:08:48 INFO - PROCESS | 32257 | Values: 138.0 131.0 128.0 130.0 129.0 137.0 140.0 132.0 176.0 132.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:1.95 (1.2%) stddev-sans-first:1.66 04:08:48 INFO - PROCESS | 32257 | Values: 164.0 171.0 167.0 167.0 169.0 166.0 166.0 169.0 167.0 167.0 04:08:48 INFO - PROCESS | 32257 | 04:08:48 INFO - PROCESS | 32257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:1.57 (2.4%) stddev-sans-first:0.44 04:08:48 INFO - PROCESS | 32257 | Values: 70.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 04:08:48 INFO - PROCESS | 32257 | -------- Summary: end -------- 04:08:48 INFO - PROCESS | 32257 | 04:08:49 INFO - TEST-INFO | 32257: exit 0 04:08:49 INFO - TEST-OK | kraken | took 61811ms 04:08:49 INFO - SUITE-END | took 1179s 04:08:49 INFO - Completed test suite (00:19:40) 04:08:49 INFO - javascript benchmark 04:08:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3007.0978706388087, 3067.8772849086035, 3102.1469095998596, 3104.534319852022, 3112.3152906360606, 5177.844664660057, 5283.524482796547, 5341.813036543722, 5414.8917021659545, 5451.182322651599, 5291.047611429941, 5303.549198318138, 5315.681059136445, 5316.016536940669, 5318.787248510064, 4802.5197480252045, 4825.276208568725, 4844.951550484503, 4880.389951256093, 4882.829100981467, 4818.975905120469, 4839.419269687643, 4846.297286893398, 4850.151223535885, 4855.902881942359, 4827.396575428072, 4861.683990540603, 4903.338049363326, 4926.852194434155, 4944.233643785201, 4917.532834380746, 4934.555889969884, 4938.333325001151, 4953.554180123806, 5005.974970125162, 4681.812727490897, 4715.31627913954, 4717.528247175289, 4889.193283108283, 4890.3642526471685, 5224.947750522484, 5291.735413229323, 5301.522862942315, 5309.681419114865, 5377.274068000848, 5611.270534830487, 5678.5741069419955, 5681.886362272731, 5683.318001839806, 5685.061964775807, 5495.780168793243, 5633.0423827948935, 5636.04187288162, 5734.770609175628, 5818.185454036438, 5294.523492885659, 5309.41596424393, 5309.601779866525, 5360.410354860962, 5371.194320851903, 5796.217510636095, 5802.21670074543, 5802.767889284466, 5808.361080281165, 5811.215485909433, 5397.703126328011, 5509.146082357241, 5564.554835613141, 5570.888582228333, 5579.609427340129, 5608.074667679869, 5677.545796336283, 5687.374388817309, 5745.1382292656435, 5756.359437560275, 5617.32592088952, 5661.971690141605, 5667.574931880125, 5669.801556945487, 5675.602707810496, 5484.040292948718, 5692.174634677948, 5702.54379649627, 5709.3434255060365, 5711.114777209539, 4256.084941737541, 4305.225059489322, 4305.4187684662165, 4351.586599273064, 4357.368181613711, 3884.2425726983533, 3885.572587015426, 3890.513685789276, 3929.1945151243926, 3931.1351502669368, 5423.132298832168, 5433.673979561239, 5439.428859969726, 5444.40111587725, 5501.0, 5502.0921547944945, 5539.723013849291, 5607.915881261784, 5670.773169073191, 5763.740631671585, 5344.171653393731, 5352.732363381815, 5353.973230133903, 5394.838154855361, 5415.891682166413, 4876.000419913909, 4881.0, 4883.536064073907, 4884.877878053077, 4901.166801643729, 5682.6306290091015, 5684.0621297487105, 5745.74144163522, 5842.737076831553, 5855.121731740188, 5627.465390787868, 5671.468703449963, 5697.943020569741, 5759.683217422914, 5770.13447982806, 5844.620099693507, 5883.294004719461, 5889.587728858939, 5893.174955506147, 5894.440028197314, 5396.379416367168, 5590.888182236251, 5605.103183490622, 5608.579356548194, 5612.494875461228, 5518.779248830002, 5668.178114173505, 5716.9142462862255, 5738.885222295614, 5813.476787089182, 5596.496315331477, 5653.802116926053, 5661.264035675501, 5665.745041473061, 5666.405027472056, 5565.415631358811, 5617.32592088952, 5618.044932361427, 5625.549956003591, 5625.549956003591, 5348.5988550858065, 5389.595780316414, 5404.972975135099, 5458.754356053908, 5478.808241711521, 5588.30146231721, 5589.916151257653, 5593.07714227148, 5593.692346920959, 5646.830595082154, 5253.395859476209, 5286.550643195218, 5300.31095957523, 5440.347158341025, 5455.481729235717], "value": 5236.469641589502, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4283994618452, 575.8905807896499, 608.1455554945302, 627.5857933763714, 647.7732793522265, 31877.681223187763, 43348.349774753406, 44079.33880991788, 44193.55806441935, 44236.0, 43289.78355108228, 43666.92161950033, 43809.56190438095, 43834.56165438345, 43918.780406098005, 8166.836663266731, 8846.690365837181, 9012.0, 9016.098390160996, 9045.728628141167, 7986.081600615946, 10526.789464210711, 10782.946085269563, 10787.892121078807, 11102.777944441106, 10856.294340867858, 10909.07272881806, 10911.127109831234, 10937.289076210061, 10957.12343012557, 10325.741856453611, 10391.636292729718, 10396.948015259875, 10398.896011039868, 10457.0, 10407.271490995634, 10415.635452759192, 10458.267921245515, 10462.529186186639, 10468.581256749721, 41387.1722565547, 41645.0, 41790.58209417928, 41837.58162418398, 41850.1629967402, 3353.144948038235, 3458.5503884495106, 3506.6142724300307, 3557.683657046883, 3730.9626903730887, 30997.380052398825, 31174.84412577945, 31730.206744831565, 31857.0, 32473.188170295696, 4283.528811830696, 4324.113556720865, 4379.671524635633, 4400.779961001969, 4580.129775342674, 301101.0, 302191.9999999978, 303009.0, 303986.0, 306829.0, 33175.17062073467, 34017.82991085029, 56359.154612680846, 56521.71739141278, 56637.433625663216, 35932.0, 35937.46093808595, 36048.09879753027, 36134.638653613656, 36184.81907590445, 14011.0, 14102.576922692335, 14121.0, 14128.646783830487, 14133.929330353489, 10434.217433692504, 10677.0, 11375.203735738585, 11377.715557110972, 11387.829182562267, 8010.0, 8130.918690813016, 8146.063202731643, 8215.09633940266, 8272.255497005299, 3164.920876978048, 3173.8730450782173, 3211.887583934551, 3220.3559288142465, 3242.918927026796, 977.5014742481386, 992.731962370156, 1001.3140998416109, 1037.4657051618422, 1074.5164675895878, 31013.689863101532, 31025.0, 31069.223269418446, 31083.378332433225, 31704.207394815316, 981.7153025622632, 998.7503124218945, 1024.4314405505015, 1039.7140786283833, 1073.350622873166, 16336.712860199581, 16353.509394718178, 16522.0, 16531.421400250932, 16669.832351970927, 447626.0, 452633.0, 455608.0, 455945.0, 458803.0, 57786.7110664444, 58016.41983580195, 58197.70901145467, 58429.0, 58443.70778146082, 1178.6169494914186, 1210.727586293077, 1218.7745267125788, 1299.9935000325127, 1323.0, 24633.876830615733, 31059.22351941129, 31275.374492509567, 33500.49749253714, 34010.38782199971, 52978.470215297355, 53344.73327633337, 53549.0, 53576.73211633917, 53736.0, 335591.0, 335820.0, 336188.0, 336649.0, 337374.0, 24259.150929717376, 24772.752272477046, 26221.868890655423, 27377.0, 27791.16626501208, 41015.794921025205, 45666.54333456623, 45706.31440528461, 45737.542624573325, 46405.30392044054, 38216.04459888525, 38450.230995380494, 38937.805310973265, 39089.21821563496, 40618.59381406148, 38038.54033670851, 38391.42412863753, 38641.42037869378, 38711.80611102323, 39037.60962390454, 37863.0, 39149.60850391573, 39246.607533924296, 39464.40803388009, 39481.0, 32610.51084233691, 34141.14647133742, 34401.0, 34940.0, 35094.0, 26371.475506423358, 26679.599806003313, 26794.0, 26861.462770744085, 27256.182314530597], "value": 18354.032553103792, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.4762218594131, 377.34907284933485, 381.3916802699694, 386.8297948902484, 410.26357687950144, 16835.989840609556, 18972.5256868578, 19242.422727318168, 19460.63775535713, 19619.5095122622, 18352.174152163152, 18721.438356849318, 18858.0, 19239.42281731547, 19267.614647707036, 5423.105187644034, 5438.238646589481, 5657.9717101414435, 5665.943340566583, 5666.291713535808, 5543.722813859311, 5559.694216818073, 5602.355729091166, 5615.101583746601, 5623.80316688916, 5492.835214943558, 5569.554435645159, 5569.777208911639, 5574.47042530961, 5578.219049333096, 5341.572674186055, 5550.195221692872, 5560.638558493685, 5560.972195139018, 5561.443855614447, 4949.08441938239, 4957.876053098666, 4962.1812400953795, 5011.899762004739, 5237.685738855681, 13393.129446585941, 13509.864901350958, 13577.59267221985, 13613.727725445535, 13620.387082581308, 2178.194068194762, 2214.236088549464, 2292.3008482412856, 2308.6421604651305, 2879.0, 9765.414075155513, 9845.950770246174, 9939.90060099397, 9971.25215608825, 10247.538860751209, 1769.6991511443086, 1859.9256029758794, 1866.850651947841, 1895.981040189608, 1942.4561122885614, 85010.0, 94636.0, 95196.9999999993, 95407.52296238474, 95491.52254238684, 14887.404503819942, 16746.581335466468, 16942.745858812126, 17063.317467301167, 17463.912680436515, 30313.848430757706, 30677.386452270828, 30839.845800770854, 30929.741943869598, 31115.68884311128, 8668.8699669505, 9063.13900179482, 9122.771930701785, 9313.627454901729, 9504.144626983605, 7446.24488939096, 7474.177840437547, 7497.362724168398, 7670.808229794188, 7678.846423071507, 8424.831503369898, 8463.534505602127, 8535.829283414298, 8617.95691021541, 8690.261327787082, 3146.8269245191277, 3253.8698452062126, 3369.814660193713, 3377.6453472385047, 3467.3238718450166, 909.9135582119688, 925.5233554719325, 938.4134915677702, 966.3090890013533, 1020.7295066807302, 16539.421120260733, 17872.28510859577, 18190.63618727618, 18817.529561761065, 18959.241630334633, 872.8690696395591, 911.4485736129678, 916.9587368568297, 919.990800092004, 945.2721404518483, 9983.15143212835, 9991.800163996679, 10387.84418233727, 10444.251825726487, 10456.947715261374, 438834.0, 443982.0, 445068.0, 447346.0, 452293.0, 49177.0, 78645.21354786493, 80504.0, 81400.59299703463, 82659.0, 1013.7921726046143, 1031.3141760729181, 1088.9128869690405, 1091.2361347057092, 1092.82514797632, 16400.0, 16669.406215288636, 16949.0, 17511.38710145139, 17547.56131096733, 29761.10716678503, 35253.0, 38680.41979370368, 40732.1853562933, 42058.4898210117, 55994.720026401235, 56456.717716411156, 56623.433765661815, 56775.0, 58736.0, 8134.63394147253, 8165.836683266182, 8175.672973081248, 8454.070052294119, 8481.109483504144, 9404.905950940676, 12203.572874949334, 12373.443195056065, 12812.807807883075, 12831.294278814381, 10207.336523125972, 10360.430176340073, 10404.167666586807, 10830.0, 11656.358900260568, 11218.0, 11575.42122893835, 11603.767924641628, 11698.899137161694, 12053.63839084829, 11606.70983225426, 11835.46740396667, 12015.158938874194, 12107.33409662477, 12212.267263964191, 8161.714339998071, 8362.790930226793, 8459.873101903353, 8511.40420170607, 8541.95729021351, 9341.532923353941, 11053.226274160732, 11219.71950701239, 11244.943775281072, 11651.41742912834], "value": 9384.19052639123, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.0509380699, 1423.8077859488965, 1464.1581090872749, 1612.6774645070989, 1774.059748333383, 7993.600319984, 8860.20258176764, 9193.35646504745, 9263.953680231607, 9323.393979391334, 9033.954830225839, 9109.95445022774, 9116.225120864734, 9123.270138388929, 9124.40691355063, 2270.8523945943502, 2297.322289924468, 2300.114455934469, 2302.861828290308, 2307.227078928561, 2208.3043841190056, 2255.1655887321713, 2258.4918393361527, 2285.108807565051, 2293.5068960173558, 2199.9450013749624, 2225.4770129019666, 2237.9104835806547, 2249.0553967333676, 2249.977500225001, 2197.41768431365, 2199.197292988056, 2208.9668654970187, 2209.8011178993806, 2213.225371120111, 2188.616992026405, 2196.374033400489, 2197.681336206257, 2197.912083516673, 2201.559688062378, 8764.474131552128, 8870.758093866863, 8899.243564296978, 9063.274938004944, 9138.862917056249, 5256.947430525723, 5400.243965844785, 5407.648502847342, 5411.783528658849, 5413.431589683105, 3394.8811791587423, 3442.7417943654327, 3477.600075991268, 3479.6172421033666, 3484.756067075306, 1089.2593036735018, 1108.3294606762954, 2158.881261530615, 2186.814120799734, 2233.743119541241, 12334.136610437274, 12766.744665106646, 12840.165389249669, 12861.485540578366, 12904.870951290555, 4386.912261754811, 4617.492075871652, 4706.458757242893, 4717.150912835723, 4737.431508219036, 10809.0, 10823.621173258898, 10824.404657743742, 10834.349939003685, 10847.67456976292, 5374.838754837361, 5376.112941364631, 5378.381486129067, 5379.058664733656, 5379.811706590251, 4265.594768496988, 4388.824447022147, 4768.546988036131, 4913.778879950411, 4961.330220420269, 3793.6206379361843, 3895.8052097395584, 4000.8999775005277, 4004.5795191505053, 4018.0, 1220.6338098570393, 1261.7476504698914, 1267.473998290699, 1272.6182145356356, 1273.2933222061658, 694.3091623834317, 804.9154838741965, 805.0781854776249, 817.7424111404888, 847.0597636623343, 5397.919031214535, 5473.972630136904, 5534.723263836872, 5582.274304340491, 5607.691576963224, 436.4391756592763, 447.83206297638384, 448.47304417309533, 453.5124740903542, 458.5666545114834, 3716.3124821907495, 3744.569374521965, 3780.281746468162, 3822.513436204061, 3930.312195365857, 10926.617568385227, 11502.884971150348, 11518.769624607628, 11520.13598980063, 11544.0, 11414.828777568344, 11415.0, 11419.0, 11422.885771142348, 11446.656600302003, 7952.0, 8356.373272004503, 8478.0, 8543.487390756574, 8574.0, 5854.151148083419, 5989.8203053908455, 6064.908117982332, 6069.2716873975405, 6119.2350956130485, 10458.843117353397, 10480.266381353233, 10583.629572965217, 10614.946925265323, 10677.786444271227, 9958.103770660675, 10242.6415075472, 10380.636677716546, 10388.220883433622, 10690.57237710514, 7101.82245443868, 7339.339459448675, 7598.544087354777, 7863.252990965849, 8088.029436467662, 8521.957390213258, 8770.956145219234, 8773.605187766694, 8780.736577902673, 8781.824363512565, 7759.883601745865, 7800.297973182441, 7853.175416581176, 7967.641456134604, 8059.879101813594, 7692.653830577526, 7704.499207551491, 7830.8825367620675, 7907.762767116996, 7913.3669306456495, 6958.165020197609, 7066.258042905421, 7070.823229419306, 7071.434285257064, 7075.964620176866, 5132.897342053213, 5179.171332586768, 5180.6891586503425, 5278.630495865253, 5400.378956420062, 5166.199239117943, 5183.637145399785, 5221.660592061504, 5275.89448211026, 5503.284573005644], "value": 4593.215604216072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.604262586515, 313.50153256322443, 317.3399329394859, 324.7288514090734, 325.2665239884061, 5086.313347698059, 5173.9482605173935, 5256.474352564742, 5321.92017119743, 5329.8134565290175, 4988.251762235666, 5114.53969142778, 5133.845984620468, 5169.457206993258, 5172.060477321004, 4071.9389209161886, 4083.203775263825, 4100.425940368351, 4103.9794801025955, 4139.875803725893, 3811.866584669537, 3962.5839286874893, 4076.5515793262866, 4114.938275925863, 4139.254934111858, 3969.9206015879663, 4019.914623051789, 4050.979745101285, 4074.348104303312, 4097.848629469538, 4043.130726893717, 4075.5735492577655, 4076.6331030207275, 4084.7344922579937, 4090.6318431341324, 3618.8733394331334, 3619.348517266891, 3619.457081437779, 3629.800360980145, 3637.4543818427182, 4935.605151587864, 5010.296499190293, 5014.52362025607, 5020.272060551236, 5080.364954380702, 4627.305904114376, 4634.3048542718525, 4652.441706995149, 4673.415823022122, 4688.156131896258, 5428.782848686087, 5434.728263586805, 5434.728263586844, 5458.563314934796, 5478.643888147258, 3765.736398452082, 3927.705422093326, 3957.426173204869, 3974.841006359771, 3979.880603581897, 5615.326160860723, 5696.515796157331, 5696.572757043238, 5707.74315155819, 5710.257666503369, 4102.897427564275, 4112.067328355668, 4115.464989551339, 4115.753054816721, 4136.0, 3932.193900250442, 4107.8973025674595, 4124.113120815441, 4161.52142503616, 4161.854335098257, 4667.32323813052, 4677.95322046782, 4682.836100736458, 4685.742284174335, 4702.482726900038, 5496.890062198813, 5540.252065971123, 5543.750531226105, 5547.667139971614, 5554.805581804618, 1374.7558459594084, 1417.595985144229, 1419.4747943260852, 1430.8783753380872, 1436.992815035918, 909.7361765088183, 916.9174774270348, 926.3654396738256, 927.8608208768738, 929.5956259027345, 4673.579377856009, 4695.154872122982, 4699.699774706174, 4699.976500117477, 4713.010267843722, 4943.579795717333, 4981.651284410129, 4982.9252561211615, 4986.55121039101, 4987.902661414483, 4450.888727781767, 4669.252919532859, 4679.461861885927, 4689.718616882998, 4715.834945776881, 2625.2124362691115, 2644.405008872988, 2645.4576811753545, 2658.3088397016913, 2671.545837207679, 5029.572486338702, 5076.44159142494, 5078.263651770547, 5078.644494885322, 5116.186097646279, 4821.770448535601, 4982.302477653131, 5003.324551185616, 5040.798368065236, 5066.518680725325, 5020.096382651158, 5062.215356619729, 5070.594352451795, 5091.872703182376, 5113.772694553355, 4919.827806026772, 4942.481039490802, 4960.677555958851, 4990.525900039491, 4991.825286114969, 4548.408706868218, 4826.831060912851, 4875.1712208923855, 4913.63147763912, 4977.427595826382, 5009.974950125226, 5039.949600503948, 5040.6219533534395, 5091.87270318245, 5127.179651255781, 3713.7586056906216, 3723.0, 3762.548494180716, 3851.9614803851605, 3964.861229856941, 5389.62272640927, 5591.804286849941, 5591.860203494945, 5609.831705048855, 5630.0, 5484.972575137099, 5500.477454641803, 5508.283923089973, 5525.557955363481, 5528.903813864249, 5290.6032047597355, 5378.892422151614, 5408.945910540844, 5476.220228425698, 5491.615586908878, 5353.491418315254, 5355.892882142413, 5395.757190926496, 5397.168010712438, 5409.161579955114, 5499.780008799603, 5511.409637470382, 5516.531094856982, 5521.917171242515, 5526.58550608714, 5144.742762861917, 5366.919496207638, 5387.730613469389, 5389.407165211745, 5394.757235924471], "value": 4028.1800667904627, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.9182602174725, 724.6376811594203, 756.9280918312759, 792.3146478296273, 818.4148333941233, 15384.692306153871, 15998.440054598092, 16098.83901160988, 16119.032858028511, 16120.113393763339, 14870.405183792662, 15003.699926001473, 15035.699286014273, 15042.24788760563, 15062.397504099823, 646.4246820329887, 662.3839828959091, 769.8806684963839, 770.5838847022601, 793.8015496125969, 794.5788731972035, 794.6265255329986, 797.314309693663, 798.8282519258358, 801.4790386248956, 839.95380254086, 840.4495055738471, 841.2386789955101, 841.5750046226647, 842.4650347029619, 830.0, 834.7120243516038, 834.9833003339929, 835.448603921412, 835.5446281776447, 501.5330159284116, 515.8375111839758, 593.8307582339056, 611.3092205807453, 615.2524682510771, 14762.483313084098, 14809.259537023214, 14838.70322593553, 14871.925640371728, 14948.850511494855, 12871.742565148645, 13004.739905201843, 13582.864171358258, 13678.247696376695, 13804.378802953892, 12454.626361209179, 12725.490980360775, 12743.74512509754, 13199.076064675477, 13584.0, 4390.231709450865, 4391.8462853799965, 4470.128324976631, 4530.909381812346, 4608.8386906458445, 79488.60255698685, 79743.0, 80693.59653201755, 80943.0, 84753.0, 10798.622048228275, 10872.945635271773, 11025.724356891142, 11186.105111591054, 11287.887121128684, 20155.596888062155, 20359.287424940354, 20365.185392584426, 20375.0, 20375.28686495995, 7694.923050769421, 7888.6450109744055, 7932.960335198287, 7980.281774640311, 8123.75628731139, 4579.381783459257, 4599.770011499411, 4627.236505976476, 4642.46611639659, 4674.626029917598, 3290.276139249361, 3422.845971931269, 3437.7937323760652, 3441.3633477806184, 3453.8963831085107, 605.4369436424167, 609.3662590905409, 619.2754477261615, 646.247122102745, 651.6513665189195, 584.3017593975159, 626.3611116661071, 666.3003845961721, 671.0612269137146, 683.064202043204, 9147.0, 9191.908080919238, 9264.675736349196, 9285.535723213812, 9715.562799674031, 555.4501043966525, 609.4667166229549, 622.6699849079995, 647.4723100672936, 650.3189255773877, 4179.791010449526, 4484.596386325246, 4519.84180553679, 4522.276435770261, 4634.652401069933, 68162.65918670375, 68211.65894170597, 68374.3162568368, 68943.0, 108952.91047089428, 86639.56680216685, 91635.08364916265, 93433.0, 93650.53174734219, 95256.52371738097, 52345.0, 54524.0, 77300.0, 87782.56108719416, 89293.55353223323, 8258.215469530385, 8365.205305495969, 8479.830403392021, 8618.569071546523, 8644.56777161152, 39873.60126398699, 50249.74875125601, 50900.23649645184, 53147.0, 53244.46755532395, 71368.64315678389, 72103.63948180225, 75845.62077189579, 76336.23663763292, 76942.0, 10987.230893837355, 11309.943450283025, 11580.652580422264, 11628.53485860556, 11678.065754739431, 12565.811512827499, 12599.622011339674, 12644.873551264369, 12893.613191604267, 13114.950743963833, 11057.336559806437, 11085.778284434105, 11736.823947640622, 12148.939255303667, 12496.812547811973, 10776.29954052984, 11215.43922803873, 11225.214235003472, 11567.132465064986, 11646.650600481998, 11557.479913404086, 11919.702007449883, 12362.0, 12505.249685018563, 12511.249325040526, 9458.621655133718, 9771.560279787569, 9805.166560842408, 9935.65225217114, 9941.751456213653, 8256.339492840438, 9022.774430639287, 9066.320025998208, 9551.952240238754, 9622.663206787729], "value": 7070.139885629206, "unit": "score"}], "name": "dromaeo_css", "value": 7003.431216848719, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 110.0, 112.0, 110.0, 112.0, 111.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 124.0, 164.0, 126.0, 121.0, 122.0, 122.0, 164.0, 128.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 104.0, 76.0, 75.0, 77.0, 75.0, 105.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 120.0, 84.0, 83.0, 82.0, 102.0, 82.0, 81.0, 115.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 118.0, 117.0, 116.0, 118.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 86.0, 85.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 51.0, 52.0, 52.0, 53.0, 60.0, 52.0, 51.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 61.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 128.0, 130.0, 129.0, 137.0, 140.0, 132.0, 176.0, 132.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 167.0, 167.0, 169.0, 166.0, 166.0, 169.0, 167.0, 167.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1489.9999999999995, "alertThreshold": 2.0}]} 04:08:50 INFO - Return code: 0 04:08:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:50 INFO - # TBPL SUCCESS # 04:08:50 INFO - Running post-action listener: _resource_record_post_action 04:08:50 INFO - [mozharness: 2016-10-18 11:08:50.108964Z] Finished run-tests step (success) 04:08:50 INFO - Running post-run listener: _resource_record_post_run 04:08:50 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408965120; Read time: 12; Write time: 324840 04:08:50 INFO - TinderboxPrint: CPU usage
13.1% 04:08:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:08:50 INFO - TinderboxPrint: I/O write bytes / time
408,965,120 / 324,840 04:08:50 INFO - TinderboxPrint: CPU idle
8,294.7 (86.9%) 04:08:50 INFO - TinderboxPrint: CPU user
1,204.7 (12.6%) 04:08:50 INFO - TinderboxPrint: Swap in / out
0 / 0 04:08:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120311808; Read time: 0; Write time: 112608 04:08:50 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288653312; Read time: 0; Write time: 212232 04:08:50 INFO - Running post-run listener: _upload_blobber_files 04:08:50 INFO - Blob upload gear active. 04:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:50 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 04:08:50 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:08:50 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:08:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:52 INFO - (blobuploader) - INFO - Done attempting. 04:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:55 INFO - (blobuploader) - INFO - Done attempting. 04:08:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:08:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:56 INFO - (blobuploader) - INFO - Done attempting. 04:08:56 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:56 INFO - Return code: 0 04:08:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/377cfd018d3ee8bc0065bafd50520646cba507a4e699df7679d949e2555888eb1ed97b8d63d208dd7abd2c88e8ec7987c9d8e30a2152f39f17c994e733c75324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0b27c2f1d9500340f71b54955d83ac9fb09ffa750d72e912743f32c8b6e5297be1670016744055fe45647705e43fe8c087c7afcb3f425959a125a8756bb3bee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ffb358549e5eb9f82c71cdb4150225b82958a1a99722dd53b1beecdbf0ac192473b3e11102e33c7916a4ca15c74a6369c4d4b45fba8fc73123e0fa601afe64d"} 04:08:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:56 INFO - Contents: 04:08:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/377cfd018d3ee8bc0065bafd50520646cba507a4e699df7679d949e2555888eb1ed97b8d63d208dd7abd2c88e8ec7987c9d8e30a2152f39f17c994e733c75324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0b27c2f1d9500340f71b54955d83ac9fb09ffa750d72e912743f32c8b6e5297be1670016744055fe45647705e43fe8c087c7afcb3f425959a125a8756bb3bee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ffb358549e5eb9f82c71cdb4150225b82958a1a99722dd53b1beecdbf0ac192473b3e11102e33c7916a4ca15c74a6369c4d4b45fba8fc73123e0fa601afe64d"} 04:08:56 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:56 INFO - Copying logs to upload dir... 04:08:56 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.246057 ========= master_lag: 0.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-18 04:08:56.080969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:08:56.084212) ========= 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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/377cfd018d3ee8bc0065bafd50520646cba507a4e699df7679d949e2555888eb1ed97b8d63d208dd7abd2c88e8ec7987c9d8e30a2152f39f17c994e733c75324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0b27c2f1d9500340f71b54955d83ac9fb09ffa750d72e912743f32c8b6e5297be1670016744055fe45647705e43fe8c087c7afcb3f425959a125a8756bb3bee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ffb358549e5eb9f82c71cdb4150225b82958a1a99722dd53b1beecdbf0ac192473b3e11102e33c7916a4ca15c74a6369c4d4b45fba8fc73123e0fa601afe64d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1476775802/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/377cfd018d3ee8bc0065bafd50520646cba507a4e699df7679d949e2555888eb1ed97b8d63d208dd7abd2c88e8ec7987c9d8e30a2152f39f17c994e733c75324", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0b27c2f1d9500340f71b54955d83ac9fb09ffa750d72e912743f32c8b6e5297be1670016744055fe45647705e43fe8c087c7afcb3f425959a125a8756bb3bee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6ffb358549e5eb9f82c71cdb4150225b82958a1a99722dd53b1beecdbf0ac192473b3e11102e33c7916a4ca15c74a6369c4d4b45fba8fc73123e0fa601afe64d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 04:08:56.117161) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:08:56.117553) ========= 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=836cfdc75598d54cb747368e000001a9-1476787412.136774-57911710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 04:08:56.435901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:08:56.436277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 04:08:56.436634) ========= ========= Total master_lag: 1.35 =========