builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1477837388.74 results: success (0) buildid: 20161030061311 builduid: c85d96fd5d2b48139f4db112a1c14bc9 revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.735600) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.736257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.736662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.752144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.752622) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 07:23:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-10-30 07:23:09 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.880558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.880902) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016815 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:08.931013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:23:08.931509) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 07:23:09,763 truncating revision to first 12 chars 2016-10-30 07:23:09,764 Setting DEBUG logging. 2016-10-30 07:23:09,764 attempt 1/10 2016-10-30 07:23:09,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 07:23:11,149 unpacking tar archive at: fx-team-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 07:23:10.628590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:10.628986) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:10.629447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:10.629724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:23:10.640982) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 07:23:10.641405) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:23:11 INFO - MultiFileLogger online at 20161030 07:23:11 in /builds/slave/test 07:23:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:23:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:23:11 INFO - {'append_to_log': False, 07:23:11 INFO - 'base_work_dir': '/builds/slave/test', 07:23:11 INFO - 'blob_upload_branch': 'Fx-Team', 07:23:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:23:11 INFO - 'branch': 'Fx-Team', 07:23:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:23:11 INFO - 'config_files': ('talos/linux_config.py',), 07:23:11 INFO - 'default_actions': ('clobber', 07:23:11 INFO - 'read-buildbot-config', 07:23:11 INFO - 'download-and-extract', 07:23:11 INFO - 'populate-webroot', 07:23:11 INFO - 'create-virtualenv', 07:23:11 INFO - 'install', 07:23:11 INFO - 'run-tests'), 07:23:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:23:11 INFO - 'download_minidump_stackwalk': True, 07:23:11 INFO - 'download_symbols': 'ondemand', 07:23:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:23:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:23:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:23:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:23:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:23:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:23:11 INFO - 'installer_path': 'installer.exe', 07:23:11 INFO - 'log_level': 'info', 07:23:11 INFO - 'log_name': 'talos', 07:23:11 INFO - 'log_to_console': True, 07:23:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:23:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:23:11 INFO - 'opt_config_files': (), 07:23:11 INFO - 'pip_index': False, 07:23:11 INFO - 'sps_profile': False, 07:23:11 INFO - 'sps_profile_interval': 0, 07:23:11 INFO - 'suite': 'dromaeojs', 07:23:11 INFO - 'system_bits': '32', 07:23:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:23:11 INFO - 'title': 'talos-linux64-ix-042', 07:23:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:23:11 INFO - 'use_talos_json': True, 07:23:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:23:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:23:11 INFO - 'work_dir': 'build'} 07:23:11 INFO - [mozharness: 2016-10-30 14:23:11.577646Z] Running clobber step. 07:23:11 INFO - Running pre-action listener: _resource_record_pre_action 07:23:11 INFO - Running main action method: clobber 07:23:11 INFO - rmtree: /builds/slave/test/build 07:23:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:23:12 INFO - Running post-action listener: _resource_record_post_action 07:23:12 INFO - [mozharness: 2016-10-30 14:23:12.040583Z] Finished clobber step (success) 07:23:12 INFO - [mozharness: 2016-10-30 14:23:12.040685Z] Running read-buildbot-config step. 07:23:12 INFO - Running pre-action listener: _resource_record_pre_action 07:23:12 INFO - Running main action method: read_buildbot_config 07:23:12 INFO - Using buildbot properties: 07:23:12 INFO - { 07:23:12 INFO - "project": "", 07:23:12 INFO - "product": "firefox", 07:23:12 INFO - "script_repo_revision": "production", 07:23:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:23:12 INFO - "repository": "", 07:23:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:23:12 INFO - "buildid": "20161030061311", 07:23:12 INFO - "stage_platform": "linux64-pgo", 07:23:12 INFO - "basedir": "/builds/slave/test", 07:23:12 INFO - "buildnumber": 571, 07:23:12 INFO - "platform": "ubuntu64_hw", 07:23:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:23:12 INFO - "slavebuilddir": "test", 07:23:12 INFO - "branch": "fx-team", 07:23:12 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 07:23:12 INFO - "slavename": "talos-linux64-ix-042", 07:23:12 INFO - "builduid": "c85d96fd5d2b48139f4db112a1c14bc9", 07:23:12 INFO - "repo_path": "integration/fx-team" 07:23:12 INFO - } 07:23:12 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:23:12 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:23:12 INFO - Running post-action listener: _resource_record_post_action 07:23:12 INFO - [mozharness: 2016-10-30 14:23:12.043075Z] Finished read-buildbot-config step (success) 07:23:12 INFO - [mozharness: 2016-10-30 14:23:12.043164Z] Running download-and-extract step. 07:23:12 INFO - Running pre-action listener: _resource_record_pre_action 07:23:12 INFO - Running main action method: download_and_extract 07:23:12 INFO - mkdir: /builds/slave/test/build/tests 07:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:23:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/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 07:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/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 07:23:12 INFO - Downloaded 1361 bytes. 07:23:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:23:12 INFO - Using the following test package requirements: 07:23:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:23:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:23:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'jsshell-linux-x86_64.zip'], 07:23:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:23:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:23:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:23:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:23:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:23:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:23:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:23:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:23:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:23:12 INFO - Http code: 200 07:23:12 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 07:23:12 INFO - x-amz-cf-id: zXJyvOLtWc3r9CA1QwLzEQy7GdjDaYDezlXd8WgyI3b_hjKx8TvN_A== 07:23:12 INFO - x-amz-replication-status: PENDING 07:23:12 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 07:23:12 INFO - Expected file size: 22006612 07:23:12 INFO - Obtained file size: 22006612 07:23:16 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 07:23:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:23:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:23:16 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:23:16 INFO - Http code: 200 07:23:16 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 07:23:16 INFO - x-amz-cf-id: SvGnVjIwA8fsRnav6_jqBy5ALporEQmwcOP-5T4Q4Yb10ki6QKsfhw== 07:23:16 INFO - x-amz-replication-status: PENDING 07:23:16 INFO - x-amz-version-id: osZ4AQHSLmYHTnKNoyV3cZDRYrTso.BD 07:23:16 INFO - Expected file size: 22006612 07:23:16 INFO - Obtained file size: 22006612 07:23:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:23:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:23:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:23:21 INFO - Http code: 200 07:23:21 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 07:23:21 INFO - x-amz-cf-id: NzTgmQsb0HsiUiPM1keITfzwYO6dFiAueFg1Yj9HTPxaJKQWTP2YBg== 07:23:21 INFO - x-amz-replication-status: PENDING 07:23:21 INFO - x-amz-version-id: OEkE0NHKtrItDByKteAlalVk7PCLvBv7 07:23:21 INFO - Expected file size: 14409038 07:23:21 INFO - Obtained file size: 14409038 07:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/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 07:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/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 07:23:22 INFO - Downloaded 59632139 bytes. 07:23:22 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:22 INFO - mkdir: /builds/slave/test/properties 07:23:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:22 INFO - Contents: 07:23:22 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:23:22 INFO - Running post-action listener: _resource_record_post_action 07:23:22 INFO - Running post-action listener: set_extra_try_arguments 07:23:22 INFO - [mozharness: 2016-10-30 14:23:22.878065Z] Finished download-and-extract step (success) 07:23:22 INFO - [mozharness: 2016-10-30 14:23:22.878292Z] Running populate-webroot step. 07:23:22 INFO - Running pre-action listener: _resource_record_pre_action 07:23:22 INFO - Running main action method: populate_webroot 07:23:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:22 INFO - '--tppagecycles', 07:23:22 INFO - '7'], 07:23:22 INFO - 'tests': ['tsvgm']}}, 07:23:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['damp', 'tps']}, 07:23:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'tests': ['damp', 'tps']}, 07:23:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['dromaeo_dom']}, 07:23:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['basic_compositor_video']}, 07:23:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['a11yr', 07:23:22 INFO - 'ts_paint', 07:23:22 INFO - 'tpaint', 07:23:22 INFO - 'sessionrestore', 07:23:22 INFO - 'sessionrestore_no_auto_restore', 07:23:22 INFO - 'tabpaint']}, 07:23:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['tsvgx', 07:23:22 INFO - 'tsvgr_opacity', 07:23:22 INFO - 'tart', 07:23:22 INFO - 'tscrollx', 07:23:22 INFO - 'cart']}, 07:23:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:22 INFO - 'tsvgr_opacity', 07:23:22 INFO - 'tart', 07:23:22 INFO - 'tscrollx', 07:23:22 INFO - 'cart']}, 07:23:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'talos_options': ['--disable-e10s'], 07:23:22 INFO - 'tests': ['tp5o']}, 07:23:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'tests': ['tp5o']}, 07:23:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'talos_options': ['--disable-e10s', 07:23:22 INFO - '--xperf_path', 07:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:22 INFO - 'tests': ['tp5n']}, 07:23:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:22 INFO - 'talos_options': ['--xperf_path', 07:23:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:22 INFO - 'tests': ['tp5n']}}, 07:23:22 INFO - 'talos.zip': {'path': '', 07:23:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:22 INFO - Running post-action listener: _resource_record_post_action 07:23:22 INFO - [mozharness: 2016-10-30 14:23:22.899336Z] Finished populate-webroot step (success) 07:23:22 INFO - [mozharness: 2016-10-30 14:23:22.899425Z] Running create-virtualenv step. 07:23:22 INFO - Running pre-action listener: _resource_record_pre_action 07:23:22 INFO - Running main action method: create_virtualenv 07:23:22 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:22 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 07:23:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:22 INFO - Using real prefix '/usr' 07:23:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:25 INFO - Installing pip.................done. 07:23:25 INFO - Return code: 0 07:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:23:25 INFO - Reading from file tmpfile_stdout 07:23:25 INFO - Output received: 07:23:25 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) 07:23:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23:25 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')]} 07:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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')]} 07:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:25 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 07:23:25 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 07:23:25 INFO - Using env: {'DISPLAY': ':0', 07:23:25 INFO - 'HOME': '/home/cltbld', 07:23:25 INFO - 'LANG': 'en_US.UTF-8', 07:23:25 INFO - 'LANGUAGE': 'en_US:en', 07:23:25 INFO - 'LOGNAME': 'cltbld', 07:23:25 INFO - 'MAIL': '/var/mail/cltbld', 07:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:25 INFO - 'MOZ_NO_REMOTE': '1', 07:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:25 INFO - 'NO_EM_RESTART': '1', 07:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:25 INFO - 'PWD': '/builds/slave/test', 07:23:25 INFO - 'SHELL': '/bin/bash', 07:23:25 INFO - 'SHLVL': '1', 07:23:25 INFO - 'TERM': 'linux', 07:23:25 INFO - 'TMOUT': '86400', 07:23:25 INFO - 'USER': 'cltbld', 07:23:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:25 INFO - '_': '/tools/buildbot/bin/python'} 07:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:25 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 07:23:25 INFO - Cleaning up... 07:23:25 INFO - Return code: 0 07:23:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:25 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')]} 07:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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')]} 07:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:25 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:25 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 07:23:25 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 07:23:25 INFO - Using env: {'DISPLAY': ':0', 07:23:25 INFO - 'HOME': '/home/cltbld', 07:23:25 INFO - 'LANG': 'en_US.UTF-8', 07:23:25 INFO - 'LANGUAGE': 'en_US:en', 07:23:25 INFO - 'LOGNAME': 'cltbld', 07:23:25 INFO - 'MAIL': '/var/mail/cltbld', 07:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:25 INFO - 'MOZ_NO_REMOTE': '1', 07:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:25 INFO - 'NO_EM_RESTART': '1', 07:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:25 INFO - 'PWD': '/builds/slave/test', 07:23:25 INFO - 'SHELL': '/bin/bash', 07:23:25 INFO - 'SHLVL': '1', 07:23:25 INFO - 'TERM': 'linux', 07:23:25 INFO - 'TMOUT': '86400', 07:23:25 INFO - 'USER': 'cltbld', 07:23:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:25 INFO - '_': '/tools/buildbot/bin/python'} 07:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:26 INFO - Downloading/unpacking psutil>=3.1.1 07:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:28 INFO - Installing collected packages: psutil 07:23:28 INFO - Running setup.py install for psutil 07:23:28 INFO - building 'psutil._psutil_linux' extension 07:23:28 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 07:23:28 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 07:23:28 INFO - building 'psutil._psutil_posix' extension 07:23:28 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 07:23:28 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 07:23:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:28 INFO - Successfully installed psutil 07:23:28 INFO - Cleaning up... 07:23:28 INFO - Return code: 0 07:23:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23:28 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')]} 07:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:28 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')]} 07:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:28 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:28 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 07:23:28 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 07:23:28 INFO - Using env: {'DISPLAY': ':0', 07:23:28 INFO - 'HOME': '/home/cltbld', 07:23:28 INFO - 'LANG': 'en_US.UTF-8', 07:23:28 INFO - 'LANGUAGE': 'en_US:en', 07:23:28 INFO - 'LOGNAME': 'cltbld', 07:23:28 INFO - 'MAIL': '/var/mail/cltbld', 07:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:28 INFO - 'MOZ_NO_REMOTE': '1', 07:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:28 INFO - 'NO_EM_RESTART': '1', 07:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:28 INFO - 'PWD': '/builds/slave/test', 07:23:28 INFO - 'SHELL': '/bin/bash', 07:23:28 INFO - 'SHLVL': '1', 07:23:28 INFO - 'TERM': 'linux', 07:23:28 INFO - 'TMOUT': '86400', 07:23:28 INFO - 'USER': 'cltbld', 07:23:28 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:28 INFO - '_': '/tools/buildbot/bin/python'} 07:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:28 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 07:23:28 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 07:23:28 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 07:23:28 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 07:23:28 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 07:23:28 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 07:23:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:30 INFO - Installing collected packages: mozsystemmonitor 07:23:30 INFO - Running setup.py install for mozsystemmonitor 07:23:30 INFO - Successfully installed mozsystemmonitor 07:23:30 INFO - Cleaning up... 07:23:31 INFO - Return code: 0 07:23:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23:31 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')]} 07:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:31 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')]} 07:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:31 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:31 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 07:23:31 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 07:23:31 INFO - Using env: {'DISPLAY': ':0', 07:23:31 INFO - 'HOME': '/home/cltbld', 07:23:31 INFO - 'LANG': 'en_US.UTF-8', 07:23:31 INFO - 'LANGUAGE': 'en_US:en', 07:23:31 INFO - 'LOGNAME': 'cltbld', 07:23:31 INFO - 'MAIL': '/var/mail/cltbld', 07:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:31 INFO - 'MOZ_NO_REMOTE': '1', 07:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:31 INFO - 'NO_EM_RESTART': '1', 07:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:31 INFO - 'PWD': '/builds/slave/test', 07:23:31 INFO - 'SHELL': '/bin/bash', 07:23:31 INFO - 'SHLVL': '1', 07:23:31 INFO - 'TERM': 'linux', 07:23:31 INFO - 'TMOUT': '86400', 07:23:31 INFO - 'USER': 'cltbld', 07:23:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:31 INFO - '_': '/tools/buildbot/bin/python'} 07:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:31 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 07:23:31 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 07:23:31 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 07:23:31 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 07:23:31 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 07:23:31 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 07:23:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:23:33 INFO - warning: no files found matching '*.txt' 07:23:33 INFO - no previously-included directories found matching 'build' 07:23:33 INFO - no previously-included directories found matching 'dist' 07:23:33 INFO - no previously-included directories found matching '.git*' 07:23:33 INFO - Installing collected packages: jsonschema, functools32 07:23:33 INFO - Running setup.py install for functools32 07:23:33 INFO - warning: no files found matching '*.txt' 07:23:33 INFO - no previously-included directories found matching 'build' 07:23:33 INFO - no previously-included directories found matching 'dist' 07:23:33 INFO - no previously-included directories found matching '.git*' 07:23:33 INFO - Successfully installed jsonschema functools32 07:23:33 INFO - Cleaning up... 07:23:33 INFO - Return code: 0 07:23:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:23:33 INFO - Using env: {'DISPLAY': ':0', 07:23:33 INFO - 'HOME': '/home/cltbld', 07:23:33 INFO - 'LANG': 'en_US.UTF-8', 07:23:33 INFO - 'LANGUAGE': 'en_US:en', 07:23:33 INFO - 'LOGNAME': 'cltbld', 07:23:33 INFO - 'MAIL': '/var/mail/cltbld', 07:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:33 INFO - 'MOZ_NO_REMOTE': '1', 07:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:33 INFO - 'NO_EM_RESTART': '1', 07:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:33 INFO - 'PWD': '/builds/slave/test', 07:23:33 INFO - 'SHELL': '/bin/bash', 07:23:33 INFO - 'SHLVL': '1', 07:23:33 INFO - 'TERM': 'linux', 07:23:33 INFO - 'TMOUT': '86400', 07:23:33 INFO - 'USER': 'cltbld', 07:23:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:33 INFO - '_': '/tools/buildbot/bin/python'} 07:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:23:33 INFO - Cleaning up... 07:23:33 INFO - Return code: 0 07:23:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:23:33 INFO - Using env: {'DISPLAY': ':0', 07:23:33 INFO - 'HOME': '/home/cltbld', 07:23:33 INFO - 'LANG': 'en_US.UTF-8', 07:23:33 INFO - 'LANGUAGE': 'en_US:en', 07:23:33 INFO - 'LOGNAME': 'cltbld', 07:23:33 INFO - 'MAIL': '/var/mail/cltbld', 07:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:33 INFO - 'MOZ_NO_REMOTE': '1', 07:23:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:33 INFO - 'NO_EM_RESTART': '1', 07:23:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:33 INFO - 'PWD': '/builds/slave/test', 07:23:33 INFO - 'SHELL': '/bin/bash', 07:23:33 INFO - 'SHLVL': '1', 07:23:33 INFO - 'TERM': 'linux', 07:23:33 INFO - 'TMOUT': '86400', 07:23:33 INFO - 'USER': 'cltbld', 07:23:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:33 INFO - '_': '/tools/buildbot/bin/python'} 07:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:23:34 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 07:23:34 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 07:23:34 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 07:23:34 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 07:23:34 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 07:23:34 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 07:23:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:23:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23:36 INFO - Downloading docopt-0.6.1.tar.gz 07:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:23:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:23:36 INFO - Running setup.py install for blobuploader 07:23:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:23:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:23:36 INFO - Running setup.py install for requests 07:23:37 INFO - Running setup.py install for docopt 07:23:37 INFO - Successfully installed blobuploader requests docopt 07:23:37 INFO - Cleaning up... 07:23:37 INFO - Return code: 0 07:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:37 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:37 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 07:23:37 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 07:23:37 INFO - Using env: {'DISPLAY': ':0', 07:23:37 INFO - 'HOME': '/home/cltbld', 07:23:37 INFO - 'LANG': 'en_US.UTF-8', 07:23:37 INFO - 'LANGUAGE': 'en_US:en', 07:23:37 INFO - 'LOGNAME': 'cltbld', 07:23:37 INFO - 'MAIL': '/var/mail/cltbld', 07:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:37 INFO - 'MOZ_NO_REMOTE': '1', 07:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:37 INFO - 'NO_EM_RESTART': '1', 07:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:37 INFO - 'PWD': '/builds/slave/test', 07:23:37 INFO - 'SHELL': '/bin/bash', 07:23:37 INFO - 'SHLVL': '1', 07:23:37 INFO - 'TERM': 'linux', 07:23:37 INFO - 'TMOUT': '86400', 07:23:37 INFO - 'USER': 'cltbld', 07:23:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:37 INFO - '_': '/tools/buildbot/bin/python'} 07:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:37 INFO - Running setup.py (path:/tmp/pip-fjNcf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:37 INFO - Running setup.py (path:/tmp/pip-NZSvr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:37 INFO - Running setup.py (path:/tmp/pip-OzA2Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:37 INFO - Running setup.py (path:/tmp/pip-4iCvWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:37 INFO - Running setup.py (path:/tmp/pip-gNveaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:37 INFO - Running setup.py (path:/tmp/pip-c7FRWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:38 INFO - Running setup.py (path:/tmp/pip-SKQ2bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:38 INFO - Running setup.py (path:/tmp/pip-sa3EMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:38 INFO - Running setup.py (path:/tmp/pip-l1FAPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:38 INFO - Running setup.py (path:/tmp/pip-nqIGnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:38 INFO - Running setup.py (path:/tmp/pip-MF8yiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:38 INFO - Running setup.py (path:/tmp/pip-5XuxT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:38 INFO - Running setup.py (path:/tmp/pip-zdjzLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:38 INFO - Running setup.py (path:/tmp/pip-sI6acL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:38 INFO - Running setup.py (path:/tmp/pip-Y5w32h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:38 INFO - Running setup.py (path:/tmp/pip-27yPXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:38 INFO - Running setup.py (path:/tmp/pip-VVrNZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:23:38 INFO - Running setup.py install for manifestparser 07:23:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:23:38 INFO - Running setup.py install for mozcrash 07:23:39 INFO - Running setup.py install for mozdebug 07:23:39 INFO - Running setup.py install for mozdevice 07:23:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozfile 07:23:39 INFO - Running setup.py install for mozhttpd 07:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozinfo 07:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozInstall 07:23:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozleak 07:23:39 INFO - Running setup.py install for mozlog 07:23:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for moznetwork 07:23:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:23:39 INFO - Running setup.py install for mozprocess 07:23:40 INFO - Running setup.py install for mozprofile 07:23:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:23:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:23:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:23:40 INFO - Running setup.py install for mozrunner 07:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:23:40 INFO - Running setup.py install for mozscreenshot 07:23:40 INFO - Running setup.py install for moztest 07:23:40 INFO - Running setup.py install for mozversion 07:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:23:40 INFO - Cleaning up... 07:23:40 INFO - Return code: 0 07:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:40 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:40 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 07:23:40 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 07:23:40 INFO - Using env: {'DISPLAY': ':0', 07:23:40 INFO - 'HOME': '/home/cltbld', 07:23:40 INFO - 'LANG': 'en_US.UTF-8', 07:23:40 INFO - 'LANGUAGE': 'en_US:en', 07:23:40 INFO - 'LOGNAME': 'cltbld', 07:23:40 INFO - 'MAIL': '/var/mail/cltbld', 07:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:40 INFO - 'MOZ_NO_REMOTE': '1', 07:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:40 INFO - 'NO_EM_RESTART': '1', 07:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:40 INFO - 'PWD': '/builds/slave/test', 07:23:40 INFO - 'SHELL': '/bin/bash', 07:23:40 INFO - 'SHLVL': '1', 07:23:40 INFO - 'TERM': 'linux', 07:23:40 INFO - 'TMOUT': '86400', 07:23:40 INFO - 'USER': 'cltbld', 07:23:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:40 INFO - '_': '/tools/buildbot/bin/python'} 07:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:23:40 INFO - Running setup.py (path:/tmp/pip-DRqSf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:23:40 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)) 07:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:23:40 INFO - Running setup.py (path:/tmp/pip-o43Pgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:23:41 INFO - Running setup.py (path:/tmp/pip-GtpaYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:23:41 INFO - Running setup.py (path:/tmp/pip-OIioqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:23:41 INFO - Running setup.py (path:/tmp/pip-3ioEN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:23:41 INFO - Running setup.py (path:/tmp/pip-FfHiYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:23:41 INFO - Running setup.py (path:/tmp/pip-vD7fWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:23:41 INFO - Running setup.py (path:/tmp/pip-MBg74L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:23:41 INFO - Running setup.py (path:/tmp/pip-Hnl4T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:23:41 INFO - Running setup.py (path:/tmp/pip-K5DCE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:23:41 INFO - Running setup.py (path:/tmp/pip-KnJHDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:23:41 INFO - Running setup.py (path:/tmp/pip-zDebYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:23:41 INFO - Running setup.py (path:/tmp/pip-ta43kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:23:41 INFO - Running setup.py (path:/tmp/pip-ulwxWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:41 INFO - Running setup.py (path:/tmp/pip-Xm0cuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:23:41 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)) 07:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:23:41 INFO - Running setup.py (path:/tmp/pip-6vSbkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:23:42 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)) 07:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:23:42 INFO - Running setup.py (path:/tmp/pip-lD4UU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:23:42 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)) 07:23:42 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)) 07:23:42 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)) 07:23:42 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)) 07:23:42 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)) 07:23:42 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)) 07:23:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:44 INFO - Downloading blessings-1.6.tar.gz 07:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:23:44 INFO - Installing collected packages: blessings 07:23:44 INFO - Running setup.py install for blessings 07:23:44 INFO - Successfully installed blessings 07:23:44 INFO - Cleaning up... 07:23:44 INFO - Return code: 0 07:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:44 INFO - Reading from file tmpfile_stdout 07:23:44 INFO - Current package versions: 07:23:44 INFO - argparse == 1.2.1 07:23:44 INFO - blessings == 1.6 07:23:44 INFO - blobuploader == 1.2.4 07:23:44 INFO - docopt == 0.6.1 07:23:44 INFO - functools32 == 3.2.3-2 07:23:44 INFO - jsonschema == 2.5.1 07:23:44 INFO - manifestparser == 1.1 07:23:44 INFO - mozInstall == 1.12 07:23:44 INFO - mozcrash == 0.17 07:23:44 INFO - mozdebug == 0.1 07:23:44 INFO - mozdevice == 0.48 07:23:44 INFO - mozfile == 1.2 07:23:44 INFO - mozhttpd == 0.7 07:23:44 INFO - mozinfo == 0.9 07:23:44 INFO - mozleak == 0.1 07:23:44 INFO - mozlog == 3.4 07:23:44 INFO - moznetwork == 0.27 07:23:44 INFO - mozprocess == 0.23 07:23:44 INFO - mozprofile == 0.28 07:23:44 INFO - mozrunner == 6.12 07:23:44 INFO - mozscreenshot == 0.1 07:23:44 INFO - mozsystemmonitor == 0.3 07:23:44 INFO - moztest == 0.7 07:23:44 INFO - mozversion == 1.4 07:23:44 INFO - psutil == 3.1.1 07:23:44 INFO - requests == 1.2.3 07:23:44 INFO - wsgiref == 0.1.2 07:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:44 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:44 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 07:23:44 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 07:23:44 INFO - Using env: {'DISPLAY': ':0', 07:23:44 INFO - 'HOME': '/home/cltbld', 07:23:44 INFO - 'LANG': 'en_US.UTF-8', 07:23:44 INFO - 'LANGUAGE': 'en_US:en', 07:23:44 INFO - 'LOGNAME': 'cltbld', 07:23:44 INFO - 'MAIL': '/var/mail/cltbld', 07:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:44 INFO - 'MOZ_NO_REMOTE': '1', 07:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:44 INFO - 'NO_EM_RESTART': '1', 07:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:44 INFO - 'PWD': '/builds/slave/test', 07:23:44 INFO - 'SHELL': '/bin/bash', 07:23:44 INFO - 'SHLVL': '1', 07:23:44 INFO - 'TERM': 'linux', 07:23:44 INFO - 'TMOUT': '86400', 07:23:44 INFO - 'USER': 'cltbld', 07:23:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:44 INFO - '_': '/tools/buildbot/bin/python'} 07:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 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)) 07:23:44 INFO - Cleaning up... 07:23:44 INFO - Return code: 0 07:23:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:23: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')]} 07:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23: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')]} 07:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:44 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 0x7fa83d90ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a05790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', '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 07:23:44 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 07:23:44 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 07:23:44 INFO - Using env: {'DISPLAY': ':0', 07:23:44 INFO - 'HOME': '/home/cltbld', 07:23:44 INFO - 'LANG': 'en_US.UTF-8', 07:23:44 INFO - 'LANGUAGE': 'en_US:en', 07:23:44 INFO - 'LOGNAME': 'cltbld', 07:23:44 INFO - 'MAIL': '/var/mail/cltbld', 07:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:44 INFO - 'MOZ_NO_REMOTE': '1', 07:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:44 INFO - 'NO_EM_RESTART': '1', 07:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:44 INFO - 'PWD': '/builds/slave/test', 07:23:44 INFO - 'SHELL': '/bin/bash', 07:23:44 INFO - 'SHLVL': '1', 07:23:44 INFO - 'TERM': 'linux', 07:23:44 INFO - 'TMOUT': '86400', 07:23:44 INFO - 'USER': 'cltbld', 07:23:44 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:44 INFO - '_': '/tools/buildbot/bin/python'} 07:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:23:44 INFO - Cleaning up... 07:23:44 INFO - Return code: 0 07:23:44 INFO - Running post-action listener: _resource_record_post_action 07:23:44 INFO - Running post-action listener: _start_resource_monitoring 07:23:45 INFO - Starting resource monitoring. 07:23:45 INFO - [mozharness: 2016-10-30 14:23:45.010074Z] Finished create-virtualenv step (success) 07:23:45 INFO - [mozharness: 2016-10-30 14:23:45.010630Z] Running install step. 07:23:45 INFO - Running pre-action listener: _resource_record_pre_action 07:23:45 INFO - Running main action method: install 07:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:23:45 INFO - Reading from file tmpfile_stdout 07:23:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:23:45 INFO - Reading from file tmpfile_stdout 07:23:45 INFO - Output received: 07:23:45 INFO - Usage: mozinstall [options] installer 07:23:45 INFO - Options: 07:23:45 INFO - -h, --help show this help message and exit 07:23:45 INFO - -d DEST, --destination=DEST 07:23:45 INFO - Directory to install application into. [default: 07:23:45 INFO - "/builds/slave/test"] 07:23:45 INFO - --app=APP Application being installed. [default: firefox] 07:23:45 INFO - mkdir: /builds/slave/test/build/application 07:23:45 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'] 07:23:45 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 07:24:02 INFO - Reading from file tmpfile_stdout 07:24:02 INFO - Output received: 07:24:02 INFO - /builds/slave/test/build/application/firefox/firefox 07:24:02 INFO - Running post-action listener: _resource_record_post_action 07:24:02 INFO - [mozharness: 2016-10-30 14:24:02.251981Z] Finished install step (success) 07:24:02 INFO - [mozharness: 2016-10-30 14:24:02.252253Z] Running run-tests step. 07:24:02 INFO - Running pre-action listener: _resource_record_pre_action 07:24:02 INFO - Running main action method: run_tests 07:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:24:02 INFO - Python 2.7.3 07:24:02 INFO - Return code: 0 07:24:02 INFO - grabbing minidump binary from tooltool 07:24:02 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')]} 07:24:02 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 0x2a02930>, '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 0x2a03830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a03cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:24:02 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 07:24:02 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 07:24:02 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 07:24:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:24:02 INFO - Return code: 0 07:24:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:24:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:24:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:24:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:24:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 07:24:02 INFO - Using env: {'DISPLAY': ':0', 07:24:02 INFO - 'HOME': '/home/cltbld', 07:24:02 INFO - 'LANG': 'en_US.UTF-8', 07:24:02 INFO - 'LANGUAGE': 'en_US:en', 07:24:02 INFO - 'LOGNAME': 'cltbld', 07:24:02 INFO - 'MAIL': '/var/mail/cltbld', 07:24:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:24:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:02 INFO - 'MOZ_NO_REMOTE': '1', 07:24:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:02 INFO - 'NO_EM_RESTART': '1', 07:24:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:02 INFO - 'PWD': '/builds/slave/test', 07:24:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:24:02 INFO - 'SHELL': '/bin/bash', 07:24:02 INFO - 'SHLVL': '1', 07:24:02 INFO - 'TERM': 'linux', 07:24:02 INFO - 'TMOUT': '86400', 07:24:02 INFO - 'USER': 'cltbld', 07:24:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371', 07:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:02 INFO - '_': '/tools/buildbot/bin/python'} 07:24:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 07:24:02 INFO - mozversion application_buildid: 20161029063242 07:24:02 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 07:24:02 INFO - mozversion application_display_name: Nightly 07:24:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:24:02 INFO - mozversion application_name: Firefox 07:24:02 INFO - mozversion application_remotingname: firefox 07:24:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:24:02 INFO - mozversion application_vendor: Mozilla 07:24:02 INFO - mozversion application_version: 52.0a1 07:24:02 INFO - mozversion platform_buildid: 20161029063242 07:24:02 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 07:24:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:24:02 INFO - mozversion platform_version: 52.0a1 07:24:02 INFO - using testdate: 1477837442 07:24:02 INFO - actual date: 1477837442 07:24:02 INFO - starting webserver on 'localhost:54611' 07:24:02 INFO - SUITE-START | Running 2 tests 07:24:02 INFO - TEST-START | dromaeo_css 07:24:02 INFO - operating with platform_type : linux_ 07:24:02 INFO - Initialising browser for dromaeo_css test... 07:24:02 INFO - TEST-INFO | started process 3875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzGzl_h/profile http://localhost:54611/getInfo.html) 07:24:06 INFO - PROCESS | 3875 | __metrics Screen width/height:1600/1200 07:24:06 INFO - PROCESS | 3875 | colorDepth:24 07:24:06 INFO - PROCESS | 3875 | Browser inner width/height: 1024/697 07:24:06 INFO - PROCESS | 3875 | __metrics 07:24:07 INFO - PROCESS | 3875 | 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" 07:24:07 INFO - PROCESS | 3875 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:08 INFO - PROCESS | 3875 | console.error: PushService: 07:24:08 INFO - PROCESS | 3875 | stateChangeProcessEnqueue: Error transitioning state 07:24:08 INFO - PROCESS | 3875 | UnknownError 07:24:08 INFO - TEST-INFO | 3875: exit 0 07:24:08 INFO - Browser initialized. 07:24:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:08 INFO - TEST-INFO | started process 3958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzGzl_h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:20 INFO - PROCESS | 3958 | RSS: Main: 174690304 07:24:20 INFO - PROCESS | 3958 | 07:25:12 INFO - PROCESS | 3958 | 1477837512161 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] 07:27:21 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54611/tests/dromaeo/cssquery-ext.html) 07:27:24 INFO - PROCESS | 3958 | RSS: Main: 427311104 07:27:24 INFO - PROCESS | 3958 | 07:30:26 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-ext.html (next: http://localhost:54611/tests/dromaeo/cssquery-jquery.html) 07:30:27 INFO - PROCESS | 3958 | RSS: Main: 285949952 07:30:27 INFO - PROCESS | 3958 | 07:33:29 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54611/tests/dromaeo/cssquery-mootools.html) 07:33:29 INFO - PROCESS | 3958 | RSS: Main: 221278208 07:33:29 INFO - PROCESS | 3958 | 07:36:32 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54611/tests/dromaeo/cssquery-prototype.html) 07:36:32 INFO - PROCESS | 3958 | RSS: Main: 257703936 07:36:32 INFO - PROCESS | 3958 | 07:39:35 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54611/tests/dromaeo/cssquery-yui.html) 07:39:35 INFO - PROCESS | 3958 | RSS: Main: 222826496 07:39:35 INFO - PROCESS | 3958 | 07:42:38 INFO - PROCESS | 3958 | Cycle 1(1): loaded http://localhost:54611/tests/dromaeo/cssquery-yui.html (next: http://localhost:54611/tests/dromaeo/cssquery-dojo.html) 07:42:39 INFO - PROCESS | 3958 | RSS: Main: 299675648 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | __start_tp_report 07:42:39 INFO - PROCESS | 3958 | _x_x_mozilla_page_load 07:42:39 INFO - PROCESS | 3958 | _x_x_mozilla_page_load_details 07:42:39 INFO - PROCESS | 3958 | |i|pagename|runs| 07:42:39 INFO - PROCESS | 3958 | |0;dojo.html;2908.0839535546306;2946.1014390610853;2946.1308913870407;2963.2295603143184;2974.3605124898145;4995.075910956476;5051.444341122483;5185.37775466944;5220.477952204782;5324.227986941891;5090.643654944155;5192.324997750287;5293.814716484924;5299.28459657946;5350.27771250882;4779.402574678165;4793.328933949232;4801.039792041588;4844.394450693663;4898.975505122487;4831.550534839552;4853.708777473345;4899.926501102486;4903.338049363326;4949.975250123744;4620.445546534404;4841.612670986313;4844.079624871263;4892.14387482191;4963.652544321899;4638.095571363586;4683.063387322515;4701.435827700664;4709.788059537294;4746.501617330166;4713.387259656257;4719.244920812688;4726.054789042171;4771.212749896263;4792.640551958617;5144.305518754958;5171.844844654666;5186.50728180826;5188.481151884819;5196.272521846944;5426.647267927572;5478.068728316196;5509.146082357241;5569.610127291091;5575.69333686647;5637.379888212294;5656.349519805234;5678.517326027292;5701.059325211377;5711.971440142815;5242.397124330712;5257.316548848626;5264.236685680593;5265.6840589564745;5315.601329900195;5516.420775818561;5567.749451274703;5734.741936612862;5744.138379243147;5746.42535746422;5357.973210134002;5442.8911421771345;5465.863353416117;5468.808591699271;5566.4990150886615;5536.889262214733;5570.192322113352;5574.637648552831;5577.637453565505;5579.637323573955;5550.722463876871;5559.916601250984;5563.721813909369;5566.55467562594;5623.268975033219;5382.91925621116;5391.838244852661;5421.512063914267;5436.728163591804;5439.265699130646;4300.634446072057;4311.676624253131;4312.504062032844;4313.266744653416;4315.287977483743;3784.4512545680723;3785.3943369060817;3795.4876091727815;3834.0606551395085;3836.731428800013;5231.084560201949;5242.7640756166065;5243.501867322599;5245.737713114329;5251.947480525146;5408.13469844823;5414.512693857571;5489.451054894478;5506.449355064461;5531.25328080712;5239.030779305841;5309.123994540934;5317.202419637086;5318.601104917147;5362.463753624606;4796.37647105881;4801.423829140525;4802.231642937113;4813.15769740294;4851.320815085891;5594.804181853616;5629.296337957755;5633.549316054788;5717.971410142923;5758.596898217084;5564.10974244119;5666.9716651416475;5667.4615911488345;5688.345840228427;5699.715014249188;5806.361300256884;5807.506361959281;5821.563382746395;5823.94176058234;5829.941700583109;5460.235567020541;5499.752511137089;5506;5519.420460851713;5529.336479622471;5343.812966546152;5372.946270537244;5374.328208973879;5390.892182156414;5449.209864569536;5310.601704872072;5319.468053194804;5320.042392369411;5323.3878104016985;5324.680519168863;5317.361916570037;5321.068812957639;5324.574034077187;5326.920096198638;5327.09439395296;5309.283246761638;5311.044012077863;5311.548518375981;5313.734313284243;5321.148616221386;5337.946620533745;5340.75966581497;5362.383325917569;5363.088274993339;5365.731713414391;5353.625246232727;5389.730513474389;5440.945590544044;5488.615796894179;5513 07:42:39 INFO - PROCESS | 3958 | |1;ext.html;604.2507290959211;616.4236438929603;638.9297177310498;645.932177121402;646.6637348578736;33277.33445331095;40922.18155636886;42680;42763.78618106909;46244.53755462445;43684.56315436845;44037.559624403824;44066.99999999992;44072.338914916305;44083.77958110213;8889.466632002068;9017.77455563613;9032.638694452215;9037.59330830111;9041.547922603877;8054.516728996279;8257.339412846957;10754.354738715663;11032.669019929415;11033.503492342863;10862.773131508022;10904.727381815479;10925.836112458319;10932.781344373108;10933.289336193122;10711.678649640484;10762.085222756075;10771.515281812337;10775.515101820436;10781.921807819233;10618.628348007782;10681.41252231127;10689.46552672371;10711.83932241017;10717.571297148104;40025.59974400248;40273;40299.19401611981;40346;40354.19291614181;3438.5186073949667;3450.7929524228625;3466.532018177539;3592.6766591006935;3794.31702293587;30866.382672346426;31095;31206.21984450407;31566.684333156834;31855.52216716751;4306.160298741746;4366.982376213891;4392.582704643054;4419.845305414295;4446.199684056868;316149;317242;319724;320129;320418.3979080113;33531.83234083863;58447.41552584505;59793.402065978786;59810.401895981355;59894.70052649709;33388.83305583456;35809.01724163763;35811.70259568869;35825.46261806075;35831.283374332364;13249.271290078945;13299.26854023038;13412.262325572186;13430.19418834873;13436.664083397993;10247.282690211763;10434.339243493012;11606.88393116075;11674.591389301333;11676.70808229784;8048.275655190944;8335.29103041514;8373.539455330016;8480.872786908201;8559.95720021396;3248.951265731016;3292.094673964631;3329.667033296651;3350.2796898666415;3355.345707586997;1046.4296958157822;1064.99467502662;1078.9730256743644;1093.8796732359433;1106.9059129974041;31868;32212.19469513234;32682.509762353584;32721.509177362357;33014.66985330116;1126.357975953715;1129.4352823588206;1142.4973011874915;1146.4554336690005;1186.1104171871098;17019.31922723102;17161.399351022905;17216.31134754621;17270.82729172717;17400.73898891518;528332;532926;534392;535230;535619;55886.441135588124;56326;56457.43542564604;56457.71771141118;56466.71766641222;1197.479096592985;1203.9518419263131;1274.1972557288848;1283.9679008024875;1336.111485861891;28948.710512894602;32874.83562582268;32946.34107317792;33047;33620;48977.265341020626;52625;54181;54285.72857135689;59769.402305978125;437478;441050;441066;441495;441663;27300.31749206286;28053.85973070203;28077.719222808326;43274.13451731011;43811;46028;46468.53531464642;46627.30059049049;46754.53245467502;47020.76489617667;39724.40413393744;40012.199756004135;40321.39517907175;41155.58844411637;41882.790586046875;40167.397489038274;40321.19357612773;40827.1834563313;41358.79320603378;41656;40876.59123408847;40881;41112.58887411088;41785.79107104445;41817.58182418137;32625.510617340286;34320;34401.31197375988;34559.481607776404;35250.823745881105;28046.158615241577;28622.139560928474;28637.713622863506;28670.856645716638;28802.27994300159 07:42:39 INFO - PROCESS | 3958 | |2;jquery.html;362.1652091928105;371.5819702834313;380.5927657406575;388.71623714688275;406.932856078747;14809.777853332194;17896;18341.358052468167;18890.149943252552;19097.14062867171;17467.73798393022;18862.43412697621;18946.242150314007;19103.713444298348;19123.52191195217;5510.559155267579;5843.5325173985975;5844.2402487676545;5852.67810270435;5854.443827836349;5593.496585307342;5749.482546570808;5753.223314852504;5793.7392817323325;5846.941530584682;5751.194832723422;5757.625754325955;5758.193852860602;5759;5761.654300741969;5635.63368381056;5685.204071429983;5707.1724599933195;5748.7125643717645;5761.107028410603;5087.847364579068;5098.974505127488;5101.311322971388;5121.590272778169;5142.357205349332;22211.777882221133;22405.887970560205;22525.436864078365;22664.886675566682;22693.319200424015;2249.932502024942;2299.678045073691;2367.526494701067;2431.149097815768;2954.70452954705;14009.85990140106;14139.363728632134;14336.28318584077;14895.329710163069;14909.850901490954;1848.4824249210242;1859.3399343233093;1883.877547959392;1917.4151883675474;1932.9710054349196;73194.63402683006;74238.26851377156;75813.24186758116;75940.24059759387;77075;9823.705288841345;10013.799724005625;10025.899741002642;10282.434466104287;10455.424951627581;14235.857641423454;14244.287785610679;14246.43014279438;14247.857521424861;14285.500007499895;7611.505252158703;7679.769606911802;7724.652390642322;7867.567283799446;7942.761717148494;6865.759698410531;7161.89257161143;7209.855802883913;7361.779146625503;7659.655315510815;6134.601250918765;6401.839954001187;6425.742970281136;6473.22321321435;6525.738970441224;1694.9661006779795;1776.7601373814628;1793.5695433095964;1808.7196484544916;1822.9817701823076;911.4166933162782;942;945.7021038372891;1018.3024628129755;1043.8695163104612;18521.814781852278;19680;20296;20755.58488830215;20996.47508812292;987.2546227598261;1010.686687126993;1015.2334987084852;1016.1616666250374;1055.9313644613076;10454.268201225994;10979.121670266359;11035.44822758859;11039.83440248397;11098.667039988813;439656;441315;443077;451099;452869;77082;82104;82193.58903205446;92296;92875;470.7622650561513;476.7925952210799;494.90378810933953;495.92809042688606;496.44646219465756;10286.691399258034;10848.945755271174;10923.836142458029;11263.069223527209;11536.884631153916;36007.81996090003;40531.39202912018;40827;40893.59106408898;40916;50393.49606503888;53276.73361633167;54466.45533544614;54883.45116548943;54931.72534137464;8249.711260105867;8298.04572474149;8389.664413423394;8561;8582.699605513777;11361.54553817871;12761.170523915916;12952.222866627655;13015.284159371326;13101.344932753134;10793.460326983777;10936.945315273373;10939;11063.557457701601;11195.328280303207;10789.946050269698;11401.714957125807;11650.941745291218;11680.70798230051;11748.177627565989;10836.295640783324;11049.944750276198;11185.552577896793;11767.646970590897;11936.28382297065;8140.837183256183;8460.576971151295;8554.871676924726;8655.653773848975;8692.261157801404;10661.680149595524;10707.839382409114;10741.194410419093;10742.8388574173;11360.829587556358 07:42:39 INFO - PROCESS | 3958 | |3;mootools.html;1333.6265845563235;1461.3350925328975;1498.6777842763806;1620.586750378654;1779.644071185763;7502.849943001143;8227.835443291131;8504.95747521263;8514.999999999984;8745.212930836224;8542.402031857773;8608.311335093193;8612.91387086129;8615.698450554231;8615.784605384868;2328.9883550582267;2351.776581224781;2353.799927006198;2359.1035406545575;2359.681443005198;2299.6435552489393;2367.822413319008;2385.71371435428;2390.3546042568496;2394.245812569035;2321.802646775026;2331.6852224949585;2349.8707571083582;2354.8587084774967;2358.492924021335;2292.3695983604475;2303.608386574286;2308.2382813671447;2320.14154762738;2324.7094113235844;2232.3079845248026;2234.206856565912;2241.3612120545567;2245.595792757303;2248.359217622986;8480;8560.871586926201;8598.312135029182;8618.870716939251;8633.913660863436;5130.127878260705;5150.793968241266;5266.289050978107;5266.736663166865;5294.338207724035;3205.8397080146133;3377.847996840148;3454.291870166635;3492.947605785915;3523.841427135785;1085.234909388879;1089.2974031749557;1141.5433826469396;1154.5901205072162;1158.2008414194263;11732.472038758277;11777.293362398283;11858.644240672793;11861.703457413634;11977.760444791056;4167.458230430025;4449.532799056117;4485.775711214426;4517.435320584927;4518.299663552155;9310.348275620778;9350.766230844147;9387.389819661701;9392.154706076486;9404.858927116098;5021.7740201690285;5057.165567681292;5060.468650791614;5130.050940576006;5134.743262836843;4170.937435938464;4283.7429754214845;4715.151272770934;4741.644376671763;4836.129496690559;3527.5414196154848;3624.8187590620364;3653.598104208535;3676.761010534307;3705.94441083384;1086.1528008153653;1104.4091411095026;1135.1543100390263;1147.4090843215752;1153.613539464272;934.5747684803398;949.6343907595488;963.205355581648;971.7862070344513;1003.3829195045141;5580.302462192226;5716.828495145152;5730.856728581819;5785.392533783892;5839.474447299678;889.2930120554175;925.2459245714721;947.3415975896686;954.5586164891065;1018.4093225928943;3739.990202645325;3780.1494663700996;3835.53973523179;3924.686025118041;4079.143379890197;10397.11624511925;10727.624533141303;10753.946230268799;10755.09612404662;10755.516001779939;10443.84334234987;10518.526666300035;10615.734606634896;10709.571617135383;10774.084202842689;8006.799830004296;8068.152843951418;8191;8192.795180120545;8196.713115040944;5502.80740174092;5551.750171242223;5587.916181257203;5683.2895888014;5765.135229715576;9589.232861371212;9604.423734575948;9614.471204083842;9617.374870633386;9753.024697530474;9108.180263776292;9438.764030899283;9458.33791634579;9781.462019588706;9806.460644664327;6803.353681400259;6977.720891164499;7239.565626062453;7513;7620.961895190489;7876.4092693047105;8240.381971352053;8252.092269850431;8257.545834979133;8292.2951549119;7390.556566606021;7443.404527637885;7641.1212710539;7702.345300649284;7713.112992005991;7343.669534870837;7456.403487721078;7459.142198647225;7512;7513.2862378074;6831.69257383409;6924.307569243036;6929.203141638776;6930.826729331807;6931.514793964576;4908.239222920453;4917.606591472745;5010.649254552146;5017.598592112549;5309.973450132725;4948.233023881304;4990.326305948651;5033.0688822567945;5096.974515127549;5129.179331306973 07:42:39 INFO - PROCESS | 3958 | |4;prototype.html;321.687962676204;326.7369767337293;334.5166234790727;336.69024497462334;338.80010793631754;5241.056609810233;5272.288241087452;5280.577553795697;5286.101362768329;5305.602079844008;4966.850994470172;5060.40597211879;5086.33877595913;5098.878246785711;5193.948060519394;4087.305158123111;4096.54937956826;4099.528554216258;4106.445629839964;4106.938395924063;4103.117829666621;4103.281925663012;4119.423280740699;4121.381792731099;4159.729617574863;4036.7577945323374;4043.1913617276514;4050.7569545827346;4053.5338436079787;4064.471618689581;4061.6547593454593;4063.918721625566;4067.2678917794783;4072.3077076896852;4109.650679692199;3599.136207310227;3603.513525674027;3621.7102631789394;3626.2928728897878;3638.5633723953297;4828.251620998751;5002.24966255061;5027.245913113025;5027.371578552681;5055.747212639353;4587.79354929029;4596.126735920165;4602.872296287397;4606.562376574254;4606.815727370901;5352.384475785296;5393.973030134864;5394.8921021579345;5395.946040539584;5429.158480435539;3838.7312888097845;3879.534455865286;3928.52857657083;3931.744436611611;3933.1936952924866;5547.25112109868;5580.944190558123;5589.854079913608;5593;5599.692016939026;3997.2804895119157;4005.319095753729;4010.218007488512;4011.4183443400543;4024.3561030235023;3951.4072889066297;4066.8169932353117;4083.5099788025627;4088.345864661699;4095.3652183910945;4563.604107843409;4575.405197324327;4602.629645732451;4638.863478447734;4648.814047438133;5291.417944026154;5332.653377530448;5336.519713225751;5369.919451208235;5408.675479471244;1319.9538016169388;1352.5130952856964;1379.799929010288;1387.4866299469059;1393.804867318556;909.6543313540813;960.8030353777459;960.9759756006156;969.5297780576415;978.6281213138961;5230.92153617696;5255.159174532057;5282.81510147143;5285.286486324374;5287.814926477632;5337.226102215157;5503.091989821714;5510.531604813636;5551.472610102034;5566.443355664482;5202.869928251824;5216.7913283469;5220.712860792617;5235;5245.7114858683135;2908.476474234658;2909.912702618925;2923.269182704324;2923.9269018274713;2933.990216701566;5458.399576046631;5659.858503537363;5693.345265294462;5695.60130790849;5710.571707121982;5538.9169162462595;5550.917571073602;5555.194496797942;5560.582956278296;5599.272094627672;5679.31848178213;5687.402822703557;5701.971490142523;5706.172604972173;5733.054046082433;5248.9737551312;5398.379186393615;5420.945790542202;5430.348358197041;5452.672839629635;5362.977766674994;5377.650452720561;5379.73101344939;5387.218853266333;5408.78364865401;5489.862753431196;5630.408807075198;5636.323641162922;5654.3497497788285;5672.971635141798;3873.8837834865;3875.96124038756;3890.7860067696547;3891.591382904754;3894.493715817039;5449.618526703092;5457.20870473787;5477.287952566141;5549.7780088796;5576.219329293983;5149.639525233348;5329.626926115135;5408.594355423437;5416.566674666096;5440.809571664972;5297.231901374356;5326.440723723953;5350.090484617546;5354.464553544614;5361.463853614763;5125;5203.869903252449;5221.242919776535;5277.28756617867;5352;5367.973160134175;5373.919391209057;5393.217983392465;5409.621326507264;5437.619366644297;5106.234064890147;5253.159494480865;5317.0960936640095;5332;5334.199870019528 07:42:39 INFO - PROCESS | 3958 | |5;yui.html;727.4725823777761;752.604882436721;752.9510581812181;757.6855604923957;806.1052232022457;15292.31184596693;15667.60830979226;15673.45142919998;15857.20713964303;15861.286242119104;14270.857291427083;14482.058666186691;14486.710265794678;14491;14522;640.6476437959116;662.2450406536552;775.3951917504328;790.8299715561153;796.2276591706036;798.253632853284;801.6713147609481;802.2899733735657;802.4623502253504;802.6067227058758;673.8147009572382;850.9872351914727;854.9230569248766;854.9487030778142;855.2388374346805;685.1093578348152;806.6974884418344;829.0217543298905;839.4585492357456;841.3689732700475;608.2609629300377;608.46455119495;608.8417011576978;608.9299730530958;608.9939100608982;13218.73562528744;13257.204567725967;13267.071305008652;13278.867211327859;13326.133801302884;12625.305608191546;12866.806997895039;12915.483380664762;13329.200247985153;13419.597412077654;12547.498100075985;12698.619041428772;12729.108962372638;12954.157979731288;12973.61079167617;4410.338449232609;4448.132614140244;4472.217361961643;4488.41650585425;4508.504064552896;62434.68782656103;64400;64416.35583644151;64805.351946480405;66105.66947165281;9932.553035113437;10678.466076696133;10704.411257380763;10736;10980.890191098146;18430.447086587425;18436.446906592824;18472.907635461735;18473.907630462032;18489.7226541602;7234.348908598251;7236.746713864989;7304.890426643605;7306.4885458017425;7704.537727736354;4355.194289056535;4393.692441529126;4448.266036104072;4467.687261891637;4600.700954437951;3275.394052100369;3368.7136593389837;3370.0563842124243;3371.679690429405;3376.69609735125;568.85494198979;569.2116418759964;574.9022666146765;576.7779404929132;601.137367877089;673.7843889955167;685.266764561914;705.5942832871119;723.8443734597087;733.9339459448569;9090.09099090099;9178.21985131258;9200.35597508168;9284.993556250427;9389;651.4690527220395;697.6267696782197;716.3588588213623;734.2510639148039;757.0650246945019;4407.955920440754;4659.5806377425515;4734.100520901018;4748.691335063209;4759.143354196209;52982.73508632432;61814;84192;84755;85602.14397855941;68389.65805170943;69719;70320.2967970324;70654;71990.2800971994;65358;66501;66552.6672366635;67180;67354.32645673578;8944.463332200088;9085.818283634158;9226.308026898143;9235.907640923504;9278.11857873501;46784.76607617076;47300.29049564191;48356.51643483661;48649;48745;39518.60481395264;41020.589794101674;51570.74214628903;56425.71787141038;57236;12615.180013299107;12664.74670506603;12720.936395318335;12760.936195318964;12824.166429182447;13522.661933451742;13968.720625587228;14495.130292182503;14515.491957781427;14585;12328.363132876002;12485.31330776816;13310.600681979557;13598.796018059538;13864.237466939416;13419.731605367642;13526.120802147829;13841.446342146604;14365;14437.639059023608;13100.60698179056;13211.207327560378;13792.93103534476;14179.361928713026;14207.360668769723;10623.468826558486;10859;11039.834402483808;11533.480993355486;11725.706857328634;11448.771024579628;11491;11509.251898626562;11677.248412737817;11703.824442633197 07:42:39 INFO - PROCESS | 3958 | __end_tp_report 07:42:39 INFO - PROCESS | 3958 | __start_cc_report 07:42:39 INFO - PROCESS | 3958 | _x_x_mozilla_cycle_collect,2608 07:42:39 INFO - PROCESS | 3958 | __end_cc_report 07:42:39 INFO - PROCESS | 3958 | __startTimestamp1477838559050__endTimestamp 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | ------- Summary: start ------- 07:42:39 INFO - PROCESS | 3958 | Number of tests: 6 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#0] dojo.html Cycles:165 Average:5162.93 Median:5323.39 stddev:576.58 (10.8%) stddev-sans-first:550.55 07:42:39 INFO - PROCESS | 3958 | Values: 2908.1 2946.1 2946.1 2963.2 2974.4 4995.1 5051.4 5185.4 5220.5 5324.2 5090.6 5192.3 5293.8 5299.3 5350.3 4779.4 4793.3 4801.0 4844.4 4899.0 4831.6 4853.7 4899.9 4903.3 4950.0 4620.4 4841.6 4844.1 4892.1 4963.7 4638.1 4683.1 4701.4 4709.8 4746.5 4713.4 4719.2 4726.1 4771.2 4792.6 5144.3 5171.8 5186.5 5188.5 5196.3 5426.6 5478.1 5509.1 5569.6 5575.7 5637.4 5656.3 5678.5 5701.1 5712.0 5242.4 5257.3 5264.2 5265.7 5315.6 5516.4 5567.7 5734.7 5744.1 5746.4 5358.0 5442.9 5465.9 5468.8 5566.5 5536.9 5570.2 5574.6 5577.6 5579.6 5550.7 5559.9 5563.7 5566.6 5623.3 5382.9 5391.8 5421.5 5436.7 5439.3 4300.6 4311.7 4312.5 4313.3 4315.3 3784.5 3785.4 3795.5 3834.1 3836.7 5231.1 5242.8 5243.5 5245.7 5251.9 5408.1 5414.5 5489.5 5506.4 5531.3 5239.0 5309.1 5317.2 5318.6 5362.5 4796.4 4801.4 4802.2 4813.2 4851.3 5594.8 5629.3 5633.5 5718.0 5758.6 5564.1 5667.0 5667.5 5688.3 5699.7 5806.4 5807.5 5821.6 5823.9 5829.9 5460.2 5499.8 5506.0 5519.4 5529.3 5343.8 5372.9 5374.3 5390.9 5449.2 5310.6 5319.5 5320.0 5323.4 5324.7 5317.4 5321.1 5324.6 5326.9 5327.1 5309.3 5311.0 5311.5 5313.7 5321.1 5337.9 5340.8 5362.4 5363.1 5365.7 5353.6 5389.7 5440.9 5488.6 5513.0 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#1] ext.html Cycles:180 Average:58247.15 Median:19358.68 stddev:116796.65 (603.3%) stddev-sans-first:117044.11 07:42:39 INFO - PROCESS | 3958 | Values: 604.3 616.4 638.9 645.9 646.7 33277.3 40922.2 42680.0 42763.8 46244.5 43684.6 44037.6 44067.0 44072.3 44083.8 8889.5 9017.8 9032.6 9037.6 9041.5 8054.5 8257.3 10754.4 11032.7 11033.5 10862.8 10904.7 10925.8 10932.8 10933.3 10711.7 10762.1 10771.5 10775.5 10781.9 10618.6 10681.4 10689.5 10711.8 10717.6 40025.6 40273.0 40299.2 40346.0 40354.2 3438.5 3450.8 3466.5 3592.7 3794.3 30866.4 31095.0 31206.2 31566.7 31855.5 4306.2 4367.0 4392.6 4419.8 4446.2 316149.0 317242.0 319724.0 320129.0 320418.4 33531.8 58447.4 59793.4 59810.4 59894.7 33388.8 35809.0 35811.7 35825.5 35831.3 13249.3 13299.3 13412.3 13430.2 13436.7 10247.3 10434.3 11606.9 11674.6 11676.7 8048.3 8335.3 8373.5 8480.9 8560.0 3249.0 3292.1 3329.7 3350.3 3355.3 1046.4 1065.0 1079.0 1093.9 1106.9 31868.0 32212.2 32682.5 32721.5 33014.7 1126.4 1129.4 1142.5 1146.5 1186.1 17019.3 17161.4 17216.3 17270.8 17400.7 528332.0 532926.0 534392.0 535230.0 535619.0 55886.4 56326.0 56457.4 56457.7 56466.7 1197.5 1204.0 1274.2 1284.0 1336.1 28948.7 32874.8 32946.3 33047.0 33620.0 48977.3 52625.0 54181.0 54285.7 59769.4 437478.0 441050.0 441066.0 441495.0 441663.0 27300.3 28053.9 28077.7 43274.1 43811.0 46028.0 46468.5 46627.3 46754.5 47020.8 39724.4 40012.2 40321.4 41155.6 41882.8 40167.4 40321.2 40827.2 41358.8 41656.0 40876.6 40881.0 41112.6 41785.8 41817.6 32625.5 34320.0 34401.3 34559.5 35250.8 28046.2 28622.1 28637.7 28670.9 28802.3 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#2] jquery.html Cycles:180 Average:27001.83 Median:18184.99 stddev:73471.92 (404.0%) stddev-sans-first:73650.80 07:42:39 INFO - PROCESS | 3958 | Values: 362.2 371.6 380.6 388.7 406.9 14809.8 17896.0 18341.4 18890.1 19097.1 17467.7 18862.4 18946.2 19103.7 19123.5 5510.6 5843.5 5844.2 5852.7 5854.4 5593.5 5749.5 5753.2 5793.7 5846.9 5751.2 5757.6 5758.2 5759.0 5761.7 5635.6 5685.2 5707.2 5748.7 5761.1 5087.8 5099.0 5101.3 5121.6 5142.4 22211.8 22405.9 22525.4 22664.9 22693.3 2249.9 2299.7 2367.5 2431.1 2954.7 14009.9 14139.4 14336.3 14895.3 14909.9 1848.5 1859.3 1883.9 1917.4 1933.0 73194.6 74238.3 75813.2 75940.2 77075.0 9823.7 10013.8 10025.9 10282.4 10455.4 14235.9 14244.3 14246.4 14247.9 14285.5 7611.5 7679.8 7724.7 7867.6 7942.8 6865.8 7161.9 7209.9 7361.8 7659.7 6134.6 6401.8 6425.7 6473.2 6525.7 1695.0 1776.8 1793.6 1808.7 1823.0 911.4 942.0 945.7 1018.3 1043.9 18521.8 19680.0 20296.0 20755.6 20996.5 987.3 1010.7 1015.2 1016.2 1055.9 10454.3 10979.1 11035.4 11039.8 11098.7 439656.0 441315.0 443077.0 451099.0 452869.0 77082.0 82104.0 82193.6 92296.0 92875.0 470.8 476.8 494.9 495.9 496.4 10286.7 10848.9 10923.8 11263.1 11536.9 36007.8 40531.4 40827.0 40893.6 40916.0 50393.5 53276.7 54466.5 54883.5 54931.7 8249.7 8298.0 8389.7 8561.0 8582.7 11361.5 12761.2 12952.2 13015.3 13101.3 10793.5 10936.9 10939.0 11063.6 11195.3 10789.9 11401.7 11650.9 11680.7 11748.2 10836.3 11049.9 11185.6 11767.6 11936.3 8140.8 8460.6 8554.9 8655.7 8692.3 10661.7 10707.8 10741.2 10742.8 11360.8 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#3] mootools.html Cycles:180 Average:5598.80 Median:5058.82 stddev:3148.57 (62.2%) stddev-sans-first:3141.08 07:42:39 INFO - PROCESS | 3958 | Values: 1333.6 1461.3 1498.7 1620.6 1779.6 7502.8 8227.8 8505.0 8515.0 8745.2 8542.4 8608.3 8612.9 8615.7 8615.8 2329.0 2351.8 2353.8 2359.1 2359.7 2299.6 2367.8 2385.7 2390.4 2394.2 2321.8 2331.7 2349.9 2354.9 2358.5 2292.4 2303.6 2308.2 2320.1 2324.7 2232.3 2234.2 2241.4 2245.6 2248.4 8480.0 8560.9 8598.3 8618.9 8633.9 5130.1 5150.8 5266.3 5266.7 5294.3 3205.8 3377.8 3454.3 3492.9 3523.8 1085.2 1089.3 1141.5 1154.6 1158.2 11732.5 11777.3 11858.6 11861.7 11977.8 4167.5 4449.5 4485.8 4517.4 4518.3 9310.3 9350.8 9387.4 9392.2 9404.9 5021.8 5057.2 5060.5 5130.1 5134.7 4170.9 4283.7 4715.2 4741.6 4836.1 3527.5 3624.8 3653.6 3676.8 3705.9 1086.2 1104.4 1135.2 1147.4 1153.6 934.6 949.6 963.2 971.8 1003.4 5580.3 5716.8 5730.9 5785.4 5839.5 889.3 925.2 947.3 954.6 1018.4 3740.0 3780.1 3835.5 3924.7 4079.1 10397.1 10727.6 10753.9 10755.1 10755.5 10443.8 10518.5 10615.7 10709.6 10774.1 8006.8 8068.2 8191.0 8192.8 8196.7 5502.8 5551.8 5587.9 5683.3 5765.1 9589.2 9604.4 9614.5 9617.4 9753.0 9108.2 9438.8 9458.3 9781.5 9806.5 6803.4 6977.7 7239.6 7513.0 7621.0 7876.4 8240.4 8252.1 8257.5 8292.3 7390.6 7443.4 7641.1 7702.3 7713.1 7343.7 7456.4 7459.1 7512.0 7513.3 6831.7 6924.3 6929.2 6930.8 6931.5 4908.2 4917.6 5010.6 5017.6 5310.0 4948.2 4990.3 5033.1 5097.0 5129.2 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#4] prototype.html Cycles:180 Average:4545.57 Median:5243.38 stddev:1315.38 (25.1%) stddev-sans-first:1280.29 07:42:39 INFO - PROCESS | 3958 | Values: 321.7 326.7 334.5 336.7 338.8 5241.1 5272.3 5280.6 5286.1 5305.6 4966.9 5060.4 5086.3 5098.9 5193.9 4087.3 4096.5 4099.5 4106.4 4106.9 4103.1 4103.3 4119.4 4121.4 4159.7 4036.8 4043.2 4050.8 4053.5 4064.5 4061.7 4063.9 4067.3 4072.3 4109.7 3599.1 3603.5 3621.7 3626.3 3638.6 4828.3 5002.2 5027.2 5027.4 5055.7 4587.8 4596.1 4602.9 4606.6 4606.8 5352.4 5394.0 5394.9 5395.9 5429.2 3838.7 3879.5 3928.5 3931.7 3933.2 5547.3 5580.9 5589.9 5593.0 5599.7 3997.3 4005.3 4010.2 4011.4 4024.4 3951.4 4066.8 4083.5 4088.3 4095.4 4563.6 4575.4 4602.6 4638.9 4648.8 5291.4 5332.7 5336.5 5369.9 5408.7 1320.0 1352.5 1379.8 1387.5 1393.8 909.7 960.8 961.0 969.5 978.6 5230.9 5255.2 5282.8 5285.3 5287.8 5337.2 5503.1 5510.5 5551.5 5566.4 5202.9 5216.8 5220.7 5235.0 5245.7 2908.5 2909.9 2923.3 2923.9 2934.0 5458.4 5659.9 5693.3 5695.6 5710.6 5538.9 5550.9 5555.2 5560.6 5599.3 5679.3 5687.4 5702.0 5706.2 5733.1 5249.0 5398.4 5420.9 5430.3 5452.7 5363.0 5377.7 5379.7 5387.2 5408.8 5489.9 5630.4 5636.3 5654.3 5673.0 3873.9 3876.0 3890.8 3891.6 3894.5 5449.6 5457.2 5477.3 5549.8 5576.2 5149.6 5329.6 5408.6 5416.6 5440.8 5297.2 5326.4 5350.1 5354.5 5361.5 5125.0 5203.9 5221.2 5277.3 5352.0 5368.0 5373.9 5393.2 5409.6 5437.6 5106.2 5253.2 5317.1 5332.0 5334.2 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - PROCESS | 3958 | [#5] yui.html Cycles:180 Average:16946.53 Median:4741.40 stddev:21464.95 (452.7%) stddev-sans-first:21490.62 07:42:39 INFO - PROCESS | 3958 | Values: 727.5 752.6 753.0 757.7 806.1 15292.3 15667.6 15673.5 15857.2 15861.3 14270.9 14482.1 14486.7 14491.0 14522.0 640.6 662.2 775.4 790.8 796.2 798.3 801.7 802.3 802.5 802.6 673.8 851.0 854.9 854.9 855.2 685.1 806.7 829.0 839.5 841.4 608.3 608.5 608.8 608.9 609.0 13218.7 13257.2 13267.1 13278.9 13326.1 12625.3 12866.8 12915.5 13329.2 13419.6 12547.5 12698.6 12729.1 12954.2 12973.6 4410.3 4448.1 4472.2 4488.4 4508.5 62434.7 64400.0 64416.4 64805.4 66105.7 9932.6 10678.5 10704.4 10736.0 10980.9 18430.4 18436.4 18472.9 18473.9 18489.7 7234.3 7236.7 7304.9 7306.5 7704.5 4355.2 4393.7 4448.3 4467.7 4600.7 3275.4 3368.7 3370.1 3371.7 3376.7 568.9 569.2 574.9 576.8 601.1 673.8 685.3 705.6 723.8 733.9 9090.1 9178.2 9200.4 9285.0 9389.0 651.5 697.6 716.4 734.3 757.1 4408.0 4659.6 4734.1 4748.7 4759.1 52982.7 61814.0 84192.0 84755.0 85602.1 68389.7 69719.0 70320.3 70654.0 71990.3 65358.0 66501.0 66552.7 67180.0 67354.3 8944.5 9085.8 9226.3 9235.9 9278.1 46784.8 47300.3 48356.5 48649.0 48745.0 39518.6 41020.6 51570.7 56425.7 57236.0 12615.2 12664.7 12720.9 12760.9 12824.2 13522.7 13968.7 14495.1 14515.5 14585.0 12328.4 12485.3 13310.6 13598.8 13864.2 13419.7 13526.1 13841.4 14365.0 14437.6 13100.6 13211.2 13792.9 14179.4 14207.4 10623.5 10859.0 11039.8 11533.5 11725.7 11448.8 11491.0 11509.3 11677.2 11703.8 07:42:39 INFO - PROCESS | 3958 | -------- Summary: end -------- 07:42:39 INFO - PROCESS | 3958 | 07:42:39 INFO - TEST-INFO | 3958: exit 0 07:42:39 INFO - TEST-OK | dromaeo_css | took 1117456ms 07:42:39 INFO - TEST-START | kraken 07:42:39 INFO - operating with platform_type : linux_ 07:42:39 INFO - Initialising browser for kraken test... 07:42:39 INFO - TEST-INFO | started process 4379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKRmv4/profile http://localhost:54611/getInfo.html) 07:42:43 INFO - PROCESS | 4379 | __metrics Screen width/height:1600/1200 07:42:43 INFO - PROCESS | 4379 | colorDepth:24 07:42:43 INFO - PROCESS | 4379 | Browser inner width/height: 1024/697 07:42:43 INFO - PROCESS | 4379 | __metrics 07:42:44 INFO - PROCESS | 4379 | 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" 07:42:44 INFO - PROCESS | 4379 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:45 INFO - PROCESS | 4379 | console.error: PushService: 07:42:45 INFO - PROCESS | 4379 | stateChangeProcessEnqueue: Error transitioning state 07:42:45 INFO - PROCESS | 4379 | UnknownError 07:42:45 INFO - TEST-INFO | 4379: exit 0 07:42:45 INFO - Browser initialized. 07:42:45 INFO - Running cycle 1/1 for kraken test... 07:42:45 INFO - TEST-INFO | started process 4462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLKRmv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:58 INFO - PROCESS | 4462 | RSS: Main: 174542848 07:42:58 INFO - PROCESS | 4462 | 07:43:00 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54611/tests/kraken/driver.html?testName=audio-beat-detection) 07:43:01 INFO - PROCESS | 4462 | RSS: Main: 231743488 07:43:01 INFO - PROCESS | 4462 | 07:43:04 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54611/tests/kraken/driver.html?testName=audio-dft) 07:43:04 INFO - PROCESS | 4462 | RSS: Main: 218333184 07:43:04 INFO - PROCESS | 4462 | 07:43:07 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54611/tests/kraken/driver.html?testName=audio-fft) 07:43:08 INFO - PROCESS | 4462 | RSS: Main: 299737088 07:43:08 INFO - PROCESS | 4462 | 07:43:10 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54611/tests/kraken/driver.html?testName=audio-oscillator) 07:43:11 INFO - PROCESS | 4462 | RSS: Main: 208715776 07:43:11 INFO - PROCESS | 4462 | 07:43:13 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:13 INFO - PROCESS | 4462 | RSS: Main: 214388736 07:43:13 INFO - PROCESS | 4462 | 07:43:16 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54611/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:17 INFO - PROCESS | 4462 | RSS: Main: 250499072 07:43:17 INFO - PROCESS | 4462 | 07:43:20 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54611/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:21 INFO - PROCESS | 4462 | RSS: Main: 249511936 07:43:21 INFO - PROCESS | 4462 | 07:43:23 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54611/tests/kraken/driver.html?testName=json-parse-financial) 07:43:24 INFO - PROCESS | 4462 | RSS: Main: 248332288 07:43:24 INFO - PROCESS | 4462 | 07:43:26 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:43:26 INFO - PROCESS | 4462 | RSS: Main: 210964480 07:43:26 INFO - PROCESS | 4462 | 07:43:28 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:43:29 INFO - PROCESS | 4462 | RSS: Main: 219607040 07:43:29 INFO - PROCESS | 4462 | 07:43:31 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:43:31 INFO - PROCESS | 4462 | RSS: Main: 228081664 07:43:31 INFO - PROCESS | 4462 | 07:43:34 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:43:35 INFO - PROCESS | 4462 | RSS: Main: 236068864 07:43:35 INFO - PROCESS | 4462 | 07:43:37 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:43:38 INFO - PROCESS | 4462 | RSS: Main: 233484288 07:43:38 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:54611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54611/tests/kraken/driver.html?testName=ai-astar) 07:43:40 INFO - PROCESS | 4462 | RSS: Main: 283545600 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | __start_tp_report 07:43:40 INFO - PROCESS | 4462 | _x_x_mozilla_page_load 07:43:40 INFO - PROCESS | 4462 | _x_x_mozilla_page_load_details 07:43:40 INFO - PROCESS | 4462 | |i|pagename|runs| 07:43:40 INFO - PROCESS | 4462 | |0;ai-astar;105;112;111;110;111;112;112;112;111;111 07:43:40 INFO - PROCESS | 4462 | |1;audio-beat-detection;151;122;121;163;123;125;126;136;158;122 07:43:40 INFO - PROCESS | 4462 | |2;audio-dft;159;162;161;159;160;162;161;163;163;161 07:43:40 INFO - PROCESS | 4462 | |3;audio-fft;75;75;76;118;74;76;76;75;99;74 07:43:40 INFO - PROCESS | 4462 | |4;audio-oscillator;81;81;118;83;83;83;110;83;84;113 07:43:40 INFO - PROCESS | 4462 | |5;imaging-gaussian-blur;117;117;116;116;118;117;118;117;117;117 07:43:40 INFO - PROCESS | 4462 | |6;imaging-darkroom;145;147;146;145;145;145;145;146;145;145 07:43:40 INFO - PROCESS | 4462 | |7;imaging-desaturate;84;84;85;86;84;84;84;85;85;84 07:43:40 INFO - PROCESS | 4462 | |8;json-parse-financial;53;53;62;50;53;53;52;52;54;54 07:43:40 INFO - PROCESS | 4462 | |9;json-stringify-tinderbox;62;62;62;63;63;63;62;63;63;62 07:43:40 INFO - PROCESS | 4462 | |10;stanford-crypto-aes;81;80;79;86;80;88;79;80;80;79 07:43:40 INFO - PROCESS | 4462 | |11;stanford-crypto-ccm;145;134;128;129;134;132;141;132;170;139 07:43:40 INFO - PROCESS | 4462 | |12;stanford-crypto-pbkdf2;165;165;172;170;167;165;175;164;166;166 07:43:40 INFO - PROCESS | 4462 | |13;stanford-crypto-sha256-iterative;66;65;66;65;80;64;63;64;66;66 07:43:40 INFO - PROCESS | 4462 | __end_tp_report 07:43:40 INFO - PROCESS | 4462 | __start_cc_report 07:43:40 INFO - PROCESS | 4462 | _x_x_mozilla_cycle_collect,1677 07:43:40 INFO - PROCESS | 4462 | __end_cc_report 07:43:40 INFO - PROCESS | 4462 | __startTimestamp1477838620431__endTimestamp 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | ------- Summary: start ------- 07:43:40 INFO - PROCESS | 4462 | Number of tests: 14 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.11 (1.9%) stddev-sans-first:0.71 07:43:40 INFO - PROCESS | 4462 | Values: 105.0 112.0 111.0 110.0 111.0 112.0 112.0 112.0 111.0 111.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:131.00 stddev:16.43 (12.5%) stddev-sans-first:16.33 07:43:40 INFO - PROCESS | 4462 | Values: 151.0 122.0 121.0 163.0 123.0 125.0 126.0 136.0 158.0 122.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.45 (0.9%) stddev-sans-first:1.32 07:43:40 INFO - PROCESS | 4462 | Values: 159.0 162.0 161.0 159.0 160.0 162.0 161.0 163.0 163.0 161.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:14.79 (19.6%) stddev-sans-first:15.48 07:43:40 INFO - PROCESS | 4462 | Values: 75.0 75.0 76.0 118.0 74.0 76.0 76.0 75.0 99.0 74.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:15.17 (18.3%) stddev-sans-first:15.57 07:43:40 INFO - PROCESS | 4462 | Values: 81.0 81.0 118.0 83.0 83.0 83.0 110.0 83.0 84.0 113.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:43:40 INFO - PROCESS | 4462 | Values: 117.0 117.0 116.0 116.0 118.0 117.0 118.0 117.0 117.0 117.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:43:40 INFO - PROCESS | 4462 | Values: 145.0 147.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 07:43:40 INFO - PROCESS | 4462 | Values: 84.0 84.0 85.0 86.0 84.0 84.0 84.0 85.0 85.0 84.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:3.17 (6.0%) stddev-sans-first:3.35 07:43:40 INFO - PROCESS | 4462 | Values: 53.0 53.0 62.0 50.0 53.0 53.0 52.0 52.0 54.0 54.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:43:40 INFO - PROCESS | 4462 | Values: 62.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 62.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.00 stddev:3.16 (3.9%) stddev-sans-first:3.35 07:43:40 INFO - PROCESS | 4462 | Values: 81.0 80.0 79.0 86.0 80.0 88.0 79.0 80.0 80.0 79.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:136.50 stddev:12.32 (9.0%) stddev-sans-first:12.84 07:43:40 INFO - PROCESS | 4462 | Values: 145.0 134.0 128.0 129.0 134.0 132.0 141.0 132.0 170.0 139.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:166.50 stddev:3.63 (2.2%) stddev-sans-first:3.73 07:43:40 INFO - PROCESS | 4462 | Values: 165.0 165.0 172.0 170.0 167.0 165.0 175.0 164.0 166.0 166.0 07:43:40 INFO - PROCESS | 4462 | 07:43:40 INFO - PROCESS | 4462 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:4.86 (7.4%) stddev-sans-first:5.15 07:43:40 INFO - PROCESS | 4462 | Values: 66.0 65.0 66.0 65.0 80.0 64.0 63.0 64.0 66.0 66.0 07:43:40 INFO - PROCESS | 4462 | -------- Summary: end -------- 07:43:40 INFO - PROCESS | 4462 | 07:43:41 INFO - TEST-INFO | 4462: exit 0 07:43:41 INFO - TEST-OK | kraken | took 61725ms 07:43:41 INFO - SUITE-END | took 1179s 07:43:42 INFO - Completed test suite (00:19:39) 07:43:42 INFO - javascript benchmark 07:43:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2908.0839535546306, 2946.1014390610853, 2946.1308913870407, 2963.2295603143184, 2974.3605124898145, 4995.075910956476, 5051.444341122483, 5185.37775466944, 5220.477952204782, 5324.227986941891, 5090.643654944155, 5192.324997750287, 5293.814716484924, 5299.28459657946, 5350.27771250882, 4779.402574678165, 4793.328933949232, 4801.039792041588, 4844.394450693663, 4898.975505122487, 4831.550534839552, 4853.708777473345, 4899.926501102486, 4903.338049363326, 4949.975250123744, 4620.445546534404, 4841.612670986313, 4844.079624871263, 4892.14387482191, 4963.652544321899, 4638.095571363586, 4683.063387322515, 4701.435827700664, 4709.788059537294, 4746.501617330166, 4713.387259656257, 4719.244920812688, 4726.054789042171, 4771.212749896263, 4792.640551958617, 5144.305518754958, 5171.844844654666, 5186.50728180826, 5188.481151884819, 5196.272521846944, 5426.647267927572, 5478.068728316196, 5509.146082357241, 5569.610127291091, 5575.69333686647, 5637.379888212294, 5656.349519805234, 5678.517326027292, 5701.059325211377, 5711.971440142815, 5242.397124330712, 5257.316548848626, 5264.236685680593, 5265.6840589564745, 5315.601329900195, 5516.420775818561, 5567.749451274703, 5734.741936612862, 5744.138379243147, 5746.42535746422, 5357.973210134002, 5442.8911421771345, 5465.863353416117, 5468.808591699271, 5566.4990150886615, 5536.889262214733, 5570.192322113352, 5574.637648552831, 5577.637453565505, 5579.637323573955, 5550.722463876871, 5559.916601250984, 5563.721813909369, 5566.55467562594, 5623.268975033219, 5382.91925621116, 5391.838244852661, 5421.512063914267, 5436.728163591804, 5439.265699130646, 4300.634446072057, 4311.676624253131, 4312.504062032844, 4313.266744653416, 4315.287977483743, 3784.4512545680723, 3785.3943369060817, 3795.4876091727815, 3834.0606551395085, 3836.731428800013, 5231.084560201949, 5242.7640756166065, 5243.501867322599, 5245.737713114329, 5251.947480525146, 5408.13469844823, 5414.512693857571, 5489.451054894478, 5506.449355064461, 5531.25328080712, 5239.030779305841, 5309.123994540934, 5317.202419637086, 5318.601104917147, 5362.463753624606, 4796.37647105881, 4801.423829140525, 4802.231642937113, 4813.15769740294, 4851.320815085891, 5594.804181853616, 5629.296337957755, 5633.549316054788, 5717.971410142923, 5758.596898217084, 5564.10974244119, 5666.9716651416475, 5667.4615911488345, 5688.345840228427, 5699.715014249188, 5806.361300256884, 5807.506361959281, 5821.563382746395, 5823.94176058234, 5829.941700583109, 5460.235567020541, 5499.752511137089, 5506.0, 5519.420460851713, 5529.336479622471, 5343.812966546152, 5372.946270537244, 5374.328208973879, 5390.892182156414, 5449.209864569536, 5310.601704872072, 5319.468053194804, 5320.042392369411, 5323.3878104016985, 5324.680519168863, 5317.361916570037, 5321.068812957639, 5324.574034077187, 5326.920096198638, 5327.09439395296, 5309.283246761638, 5311.044012077863, 5311.548518375981, 5313.734313284243, 5321.148616221386, 5337.946620533745, 5340.75966581497, 5362.383325917569, 5363.088274993339, 5365.731713414391, 5353.625246232727, 5389.730513474389, 5440.945590544044, 5488.615796894179, 5513.0], "value": 5123.984125075907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.2507290959211, 616.4236438929603, 638.9297177310498, 645.932177121402, 646.6637348578736, 33277.33445331095, 40922.18155636886, 42680.0, 42763.78618106909, 46244.53755462445, 43684.56315436845, 44037.559624403824, 44066.99999999992, 44072.338914916305, 44083.77958110213, 8889.466632002068, 9017.77455563613, 9032.638694452215, 9037.59330830111, 9041.547922603877, 8054.516728996279, 8257.339412846957, 10754.354738715663, 11032.669019929415, 11033.503492342863, 10862.773131508022, 10904.727381815479, 10925.836112458319, 10932.781344373108, 10933.289336193122, 10711.678649640484, 10762.085222756075, 10771.515281812337, 10775.515101820436, 10781.921807819233, 10618.628348007782, 10681.41252231127, 10689.46552672371, 10711.83932241017, 10717.571297148104, 40025.59974400248, 40273.0, 40299.19401611981, 40346.0, 40354.19291614181, 3438.5186073949667, 3450.7929524228625, 3466.532018177539, 3592.6766591006935, 3794.31702293587, 30866.382672346426, 31095.0, 31206.21984450407, 31566.684333156834, 31855.52216716751, 4306.160298741746, 4366.982376213891, 4392.582704643054, 4419.845305414295, 4446.199684056868, 316149.0, 317242.0, 319724.0, 320129.0, 320418.3979080113, 33531.83234083863, 58447.41552584505, 59793.402065978786, 59810.401895981355, 59894.70052649709, 33388.83305583456, 35809.01724163763, 35811.70259568869, 35825.46261806075, 35831.283374332364, 13249.271290078945, 13299.26854023038, 13412.262325572186, 13430.19418834873, 13436.664083397993, 10247.282690211763, 10434.339243493012, 11606.88393116075, 11674.591389301333, 11676.70808229784, 8048.275655190944, 8335.29103041514, 8373.539455330016, 8480.872786908201, 8559.95720021396, 3248.951265731016, 3292.094673964631, 3329.667033296651, 3350.2796898666415, 3355.345707586997, 1046.4296958157822, 1064.99467502662, 1078.9730256743644, 1093.8796732359433, 1106.9059129974041, 31868.0, 32212.19469513234, 32682.509762353584, 32721.509177362357, 33014.66985330116, 1126.357975953715, 1129.4352823588206, 1142.4973011874915, 1146.4554336690005, 1186.1104171871098, 17019.31922723102, 17161.399351022905, 17216.31134754621, 17270.82729172717, 17400.73898891518, 528332.0, 532926.0, 534392.0, 535230.0, 535619.0, 55886.441135588124, 56326.0, 56457.43542564604, 56457.71771141118, 56466.71766641222, 1197.479096592985, 1203.9518419263131, 1274.1972557288848, 1283.9679008024875, 1336.111485861891, 28948.710512894602, 32874.83562582268, 32946.34107317792, 33047.0, 33620.0, 48977.265341020626, 52625.0, 54181.0, 54285.72857135689, 59769.402305978125, 437478.0, 441050.0, 441066.0, 441495.0, 441663.0, 27300.31749206286, 28053.85973070203, 28077.719222808326, 43274.13451731011, 43811.0, 46028.0, 46468.53531464642, 46627.30059049049, 46754.53245467502, 47020.76489617667, 39724.40413393744, 40012.199756004135, 40321.39517907175, 41155.58844411637, 41882.790586046875, 40167.397489038274, 40321.19357612773, 40827.1834563313, 41358.79320603378, 41656.0, 40876.59123408847, 40881.0, 41112.58887411088, 41785.79107104445, 41817.58182418137, 32625.510617340286, 34320.0, 34401.31197375988, 34559.481607776404, 35250.823745881105, 28046.158615241577, 28622.139560928474, 28637.713622863506, 28670.856645716638, 28802.27994300159], "value": 19114.20014908692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1652091928105, 371.5819702834313, 380.5927657406575, 388.71623714688275, 406.932856078747, 14809.777853332194, 17896.0, 18341.358052468167, 18890.149943252552, 19097.14062867171, 17467.73798393022, 18862.43412697621, 18946.242150314007, 19103.713444298348, 19123.52191195217, 5510.559155267579, 5843.5325173985975, 5844.2402487676545, 5852.67810270435, 5854.443827836349, 5593.496585307342, 5749.482546570808, 5753.223314852504, 5793.7392817323325, 5846.941530584682, 5751.194832723422, 5757.625754325955, 5758.193852860602, 5759.0, 5761.654300741969, 5635.63368381056, 5685.204071429983, 5707.1724599933195, 5748.7125643717645, 5761.107028410603, 5087.847364579068, 5098.974505127488, 5101.311322971388, 5121.590272778169, 5142.357205349332, 22211.777882221133, 22405.887970560205, 22525.436864078365, 22664.886675566682, 22693.319200424015, 2249.932502024942, 2299.678045073691, 2367.526494701067, 2431.149097815768, 2954.70452954705, 14009.85990140106, 14139.363728632134, 14336.28318584077, 14895.329710163069, 14909.850901490954, 1848.4824249210242, 1859.3399343233093, 1883.877547959392, 1917.4151883675474, 1932.9710054349196, 73194.63402683006, 74238.26851377156, 75813.24186758116, 75940.24059759387, 77075.0, 9823.705288841345, 10013.799724005625, 10025.899741002642, 10282.434466104287, 10455.424951627581, 14235.857641423454, 14244.287785610679, 14246.43014279438, 14247.857521424861, 14285.500007499895, 7611.505252158703, 7679.769606911802, 7724.652390642322, 7867.567283799446, 7942.761717148494, 6865.759698410531, 7161.89257161143, 7209.855802883913, 7361.779146625503, 7659.655315510815, 6134.601250918765, 6401.839954001187, 6425.742970281136, 6473.22321321435, 6525.738970441224, 1694.9661006779795, 1776.7601373814628, 1793.5695433095964, 1808.7196484544916, 1822.9817701823076, 911.4166933162782, 942.0, 945.7021038372891, 1018.3024628129755, 1043.8695163104612, 18521.814781852278, 19680.0, 20296.0, 20755.58488830215, 20996.47508812292, 987.2546227598261, 1010.686687126993, 1015.2334987084852, 1016.1616666250374, 1055.9313644613076, 10454.268201225994, 10979.121670266359, 11035.44822758859, 11039.83440248397, 11098.667039988813, 439656.0, 441315.0, 443077.0, 451099.0, 452869.0, 77082.0, 82104.0, 82193.58903205446, 92296.0, 92875.0, 470.7622650561513, 476.7925952210799, 494.90378810933953, 495.92809042688606, 496.44646219465756, 10286.691399258034, 10848.945755271174, 10923.836142458029, 11263.069223527209, 11536.884631153916, 36007.81996090003, 40531.39202912018, 40827.0, 40893.59106408898, 40916.0, 50393.49606503888, 53276.73361633167, 54466.45533544614, 54883.45116548943, 54931.72534137464, 8249.711260105867, 8298.04572474149, 8389.664413423394, 8561.0, 8582.699605513777, 11361.54553817871, 12761.170523915916, 12952.222866627655, 13015.284159371326, 13101.344932753134, 10793.460326983777, 10936.945315273373, 10939.0, 11063.557457701601, 11195.328280303207, 10789.946050269698, 11401.714957125807, 11650.941745291218, 11680.70798230051, 11748.177627565989, 10836.295640783324, 11049.944750276198, 11185.552577896793, 11767.646970590897, 11936.28382297065, 8140.837183256183, 8460.576971151295, 8554.871676924726, 8655.653773848975, 8692.261157801404, 10661.680149595524, 10707.839382409114, 10741.194410419093, 10742.8388574173, 11360.829587556358], "value": 8796.199986959815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.6265845563235, 1461.3350925328975, 1498.6777842763806, 1620.586750378654, 1779.644071185763, 7502.849943001143, 8227.835443291131, 8504.95747521263, 8514.999999999984, 8745.212930836224, 8542.402031857773, 8608.311335093193, 8612.91387086129, 8615.698450554231, 8615.784605384868, 2328.9883550582267, 2351.776581224781, 2353.799927006198, 2359.1035406545575, 2359.681443005198, 2299.6435552489393, 2367.822413319008, 2385.71371435428, 2390.3546042568496, 2394.245812569035, 2321.802646775026, 2331.6852224949585, 2349.8707571083582, 2354.8587084774967, 2358.492924021335, 2292.3695983604475, 2303.608386574286, 2308.2382813671447, 2320.14154762738, 2324.7094113235844, 2232.3079845248026, 2234.206856565912, 2241.3612120545567, 2245.595792757303, 2248.359217622986, 8480.0, 8560.871586926201, 8598.312135029182, 8618.870716939251, 8633.913660863436, 5130.127878260705, 5150.793968241266, 5266.289050978107, 5266.736663166865, 5294.338207724035, 3205.8397080146133, 3377.847996840148, 3454.291870166635, 3492.947605785915, 3523.841427135785, 1085.234909388879, 1089.2974031749557, 1141.5433826469396, 1154.5901205072162, 1158.2008414194263, 11732.472038758277, 11777.293362398283, 11858.644240672793, 11861.703457413634, 11977.760444791056, 4167.458230430025, 4449.532799056117, 4485.775711214426, 4517.435320584927, 4518.299663552155, 9310.348275620778, 9350.766230844147, 9387.389819661701, 9392.154706076486, 9404.858927116098, 5021.7740201690285, 5057.165567681292, 5060.468650791614, 5130.050940576006, 5134.743262836843, 4170.937435938464, 4283.7429754214845, 4715.151272770934, 4741.644376671763, 4836.129496690559, 3527.5414196154848, 3624.8187590620364, 3653.598104208535, 3676.761010534307, 3705.94441083384, 1086.1528008153653, 1104.4091411095026, 1135.1543100390263, 1147.4090843215752, 1153.613539464272, 934.5747684803398, 949.6343907595488, 963.205355581648, 971.7862070344513, 1003.3829195045141, 5580.302462192226, 5716.828495145152, 5730.856728581819, 5785.392533783892, 5839.474447299678, 889.2930120554175, 925.2459245714721, 947.3415975896686, 954.5586164891065, 1018.4093225928943, 3739.990202645325, 3780.1494663700996, 3835.53973523179, 3924.686025118041, 4079.143379890197, 10397.11624511925, 10727.624533141303, 10753.946230268799, 10755.09612404662, 10755.516001779939, 10443.84334234987, 10518.526666300035, 10615.734606634896, 10709.571617135383, 10774.084202842689, 8006.799830004296, 8068.152843951418, 8191.0, 8192.795180120545, 8196.713115040944, 5502.80740174092, 5551.750171242223, 5587.916181257203, 5683.2895888014, 5765.135229715576, 9589.232861371212, 9604.423734575948, 9614.471204083842, 9617.374870633386, 9753.024697530474, 9108.180263776292, 9438.764030899283, 9458.33791634579, 9781.462019588706, 9806.460644664327, 6803.353681400259, 6977.720891164499, 7239.565626062453, 7513.0, 7620.961895190489, 7876.4092693047105, 8240.381971352053, 8252.092269850431, 8257.545834979133, 8292.2951549119, 7390.556566606021, 7443.404527637885, 7641.1212710539, 7702.345300649284, 7713.112992005991, 7343.669534870837, 7456.403487721078, 7459.142198647225, 7512.0, 7513.2862378074, 6831.69257383409, 6924.307569243036, 6929.203141638776, 6930.826729331807, 6931.514793964576, 4908.239222920453, 4917.606591472745, 5010.649254552146, 5017.598592112549, 5309.973450132725, 4948.233023881304, 4990.326305948651, 5033.0688822567945, 5096.974515127549, 5129.179331306973], "value": 4502.730758641598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.687962676204, 326.7369767337293, 334.5166234790727, 336.69024497462334, 338.80010793631754, 5241.056609810233, 5272.288241087452, 5280.577553795697, 5286.101362768329, 5305.602079844008, 4966.850994470172, 5060.40597211879, 5086.33877595913, 5098.878246785711, 5193.948060519394, 4087.305158123111, 4096.54937956826, 4099.528554216258, 4106.445629839964, 4106.938395924063, 4103.117829666621, 4103.281925663012, 4119.423280740699, 4121.381792731099, 4159.729617574863, 4036.7577945323374, 4043.1913617276514, 4050.7569545827346, 4053.5338436079787, 4064.471618689581, 4061.6547593454593, 4063.918721625566, 4067.2678917794783, 4072.3077076896852, 4109.650679692199, 3599.136207310227, 3603.513525674027, 3621.7102631789394, 3626.2928728897878, 3638.5633723953297, 4828.251620998751, 5002.24966255061, 5027.245913113025, 5027.371578552681, 5055.747212639353, 4587.79354929029, 4596.126735920165, 4602.872296287397, 4606.562376574254, 4606.815727370901, 5352.384475785296, 5393.973030134864, 5394.8921021579345, 5395.946040539584, 5429.158480435539, 3838.7312888097845, 3879.534455865286, 3928.52857657083, 3931.744436611611, 3933.1936952924866, 5547.25112109868, 5580.944190558123, 5589.854079913608, 5593.0, 5599.692016939026, 3997.2804895119157, 4005.319095753729, 4010.218007488512, 4011.4183443400543, 4024.3561030235023, 3951.4072889066297, 4066.8169932353117, 4083.5099788025627, 4088.345864661699, 4095.3652183910945, 4563.604107843409, 4575.405197324327, 4602.629645732451, 4638.863478447734, 4648.814047438133, 5291.417944026154, 5332.653377530448, 5336.519713225751, 5369.919451208235, 5408.675479471244, 1319.9538016169388, 1352.5130952856964, 1379.799929010288, 1387.4866299469059, 1393.804867318556, 909.6543313540813, 960.8030353777459, 960.9759756006156, 969.5297780576415, 978.6281213138961, 5230.92153617696, 5255.159174532057, 5282.81510147143, 5285.286486324374, 5287.814926477632, 5337.226102215157, 5503.091989821714, 5510.531604813636, 5551.472610102034, 5566.443355664482, 5202.869928251824, 5216.7913283469, 5220.712860792617, 5235.0, 5245.7114858683135, 2908.476474234658, 2909.912702618925, 2923.269182704324, 2923.9269018274713, 2933.990216701566, 5458.399576046631, 5659.858503537363, 5693.345265294462, 5695.60130790849, 5710.571707121982, 5538.9169162462595, 5550.917571073602, 5555.194496797942, 5560.582956278296, 5599.272094627672, 5679.31848178213, 5687.402822703557, 5701.971490142523, 5706.172604972173, 5733.054046082433, 5248.9737551312, 5398.379186393615, 5420.945790542202, 5430.348358197041, 5452.672839629635, 5362.977766674994, 5377.650452720561, 5379.73101344939, 5387.218853266333, 5408.78364865401, 5489.862753431196, 5630.408807075198, 5636.323641162922, 5654.3497497788285, 5672.971635141798, 3873.8837834865, 3875.96124038756, 3890.7860067696547, 3891.591382904754, 3894.493715817039, 5449.618526703092, 5457.20870473787, 5477.287952566141, 5549.7780088796, 5576.219329293983, 5149.639525233348, 5329.626926115135, 5408.594355423437, 5416.566674666096, 5440.809571664972, 5297.231901374356, 5326.440723723953, 5350.090484617546, 5354.464553544614, 5361.463853614763, 5125.0, 5203.869903252449, 5221.242919776535, 5277.28756617867, 5352.0, 5367.973160134175, 5373.919391209057, 5393.217983392465, 5409.621326507264, 5437.619366644297, 5106.234064890147, 5253.159494480865, 5317.0960936640095, 5332.0, 5334.199870019528], "value": 4129.402385153363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.4725823777761, 752.604882436721, 752.9510581812181, 757.6855604923957, 806.1052232022457, 15292.31184596693, 15667.60830979226, 15673.45142919998, 15857.20713964303, 15861.286242119104, 14270.857291427083, 14482.058666186691, 14486.710265794678, 14491.0, 14522.0, 640.6476437959116, 662.2450406536552, 775.3951917504328, 790.8299715561153, 796.2276591706036, 798.253632853284, 801.6713147609481, 802.2899733735657, 802.4623502253504, 802.6067227058758, 673.8147009572382, 850.9872351914727, 854.9230569248766, 854.9487030778142, 855.2388374346805, 685.1093578348152, 806.6974884418344, 829.0217543298905, 839.4585492357456, 841.3689732700475, 608.2609629300377, 608.46455119495, 608.8417011576978, 608.9299730530958, 608.9939100608982, 13218.73562528744, 13257.204567725967, 13267.071305008652, 13278.867211327859, 13326.133801302884, 12625.305608191546, 12866.806997895039, 12915.483380664762, 13329.200247985153, 13419.597412077654, 12547.498100075985, 12698.619041428772, 12729.108962372638, 12954.157979731288, 12973.61079167617, 4410.338449232609, 4448.132614140244, 4472.217361961643, 4488.41650585425, 4508.504064552896, 62434.68782656103, 64400.0, 64416.35583644151, 64805.351946480405, 66105.66947165281, 9932.553035113437, 10678.466076696133, 10704.411257380763, 10736.0, 10980.890191098146, 18430.447086587425, 18436.446906592824, 18472.907635461735, 18473.907630462032, 18489.7226541602, 7234.348908598251, 7236.746713864989, 7304.890426643605, 7306.4885458017425, 7704.537727736354, 4355.194289056535, 4393.692441529126, 4448.266036104072, 4467.687261891637, 4600.700954437951, 3275.394052100369, 3368.7136593389837, 3370.0563842124243, 3371.679690429405, 3376.69609735125, 568.85494198979, 569.2116418759964, 574.9022666146765, 576.7779404929132, 601.137367877089, 673.7843889955167, 685.266764561914, 705.5942832871119, 723.8443734597087, 733.9339459448569, 9090.09099090099, 9178.21985131258, 9200.35597508168, 9284.993556250427, 9389.0, 651.4690527220395, 697.6267696782197, 716.3588588213623, 734.2510639148039, 757.0650246945019, 4407.955920440754, 4659.5806377425515, 4734.100520901018, 4748.691335063209, 4759.143354196209, 52982.73508632432, 61814.0, 84192.0, 84755.0, 85602.14397855941, 68389.65805170943, 69719.0, 70320.2967970324, 70654.0, 71990.2800971994, 65358.0, 66501.0, 66552.6672366635, 67180.0, 67354.32645673578, 8944.463332200088, 9085.818283634158, 9226.308026898143, 9235.907640923504, 9278.11857873501, 46784.76607617076, 47300.29049564191, 48356.51643483661, 48649.0, 48745.0, 39518.60481395264, 41020.589794101674, 51570.74214628903, 56425.71787141038, 57236.0, 12615.180013299107, 12664.74670506603, 12720.936395318335, 12760.936195318964, 12824.166429182447, 13522.661933451742, 13968.720625587228, 14495.130292182503, 14515.491957781427, 14585.0, 12328.363132876002, 12485.31330776816, 13310.600681979557, 13598.796018059538, 13864.237466939416, 13419.731605367642, 13526.120802147829, 13841.446342146604, 14365.0, 14437.639059023608, 13100.60698179056, 13211.207327560378, 13792.93103534476, 14179.361928713026, 14207.360668769723, 10623.468826558486, 10859.0, 11039.834402483808, 11533.480993355486, 11725.706857328634, 11448.771024579628, 11491.0, 11509.251898626562, 11677.248412737817, 11703.824442633197], "value": 7024.994972002672, "unit": "score"}], "name": "dromaeo_css", "value": 6948.412259279002, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 110.0, 111.0, 112.0, 112.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 121.0, 163.0, 123.0, 125.0, 126.0, 136.0, 158.0, 122.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 159.0, 160.0, 162.0, 161.0, 163.0, 163.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 118.0, 74.0, 76.0, 76.0, 75.0, 99.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 118.0, 83.0, 83.0, 83.0, 110.0, 83.0, 84.0, 113.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 62.0, 50.0, 53.0, 53.0, 52.0, 52.0, 54.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 86.0, 80.0, 88.0, 79.0, 80.0, 80.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 128.0, 129.0, 134.0, 132.0, 141.0, 132.0, 170.0, 139.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 172.0, 170.0, 167.0, 165.0, 175.0, 164.0, 166.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 80.0, 64.0, 63.0, 64.0, 66.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1496.8000000000002, "alertThreshold": 2.0}]} 07:43:42 INFO - Return code: 0 07:43:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:43:42 INFO - # TBPL SUCCESS # 07:43:42 INFO - Running post-action listener: _resource_record_post_action 07:43:42 INFO - [mozharness: 2016-10-30 14:43:42.252819Z] Finished run-tests step (success) 07:43:42 INFO - Running post-run listener: _resource_record_post_run 07:43:42 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4730880; Write bytes: 400187392; Read time: 2760; Write time: 276600 07:43:42 INFO - TinderboxPrint: CPU usage
13.1% 07:43:42 INFO - TinderboxPrint: I/O read bytes / time
4,730,880 / 2,760 07:43:42 INFO - TinderboxPrint: I/O write bytes / time
400,187,392 / 276,600 07:43:42 INFO - TinderboxPrint: CPU idle
8,301.1 (86.9%) 07:43:42 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 07:43:42 INFO - TinderboxPrint: Swap in / out
0 / 0 07:43:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110526464; Read time: 0; Write time: 90736 07:43:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4722688; Write bytes: 289660928; Read time: 2740; Write time: 185864 07:43:42 INFO - Running post-run listener: _upload_blobber_files 07:43:42 INFO - Blob upload gear active. 07:43:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:43:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:43:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:43:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:43:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:43:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:44 INFO - (blobuploader) - INFO - Done attempting. 07:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:45 INFO - (blobuploader) - INFO - Done attempting. 07:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:43:48 INFO - (blobuploader) - INFO - Done attempting. 07:43:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:43:48 INFO - Return code: 0 07:43:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:43:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:43:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5eb089bbfe2bd2807de1c2fe3f08a315f1c8c0c8556cfb2d28db2eda4847ee51d5d7cade2c8702cfb8b96876e022f712a03b34b4bc75b70c1a3217c22f60db31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0ffc692f4c9483cdfd747e7ba4a06d6fa9c949790591fddb394ca69343e7924ac5bcea79335607f7af8faa9e601b521143d38146d755d0a6bd66fa43d6779e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00a4c47d004f2f2105464dfc099e93d84785e2afa95459800c5e37795d569b76389a490caf3acf9f08f388db067eea19c2a0a4b0a18b513b3ba0f50fb71c1ee"} 07:43:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:43:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:43:48 INFO - Contents: 07:43:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5eb089bbfe2bd2807de1c2fe3f08a315f1c8c0c8556cfb2d28db2eda4847ee51d5d7cade2c8702cfb8b96876e022f712a03b34b4bc75b70c1a3217c22f60db31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0ffc692f4c9483cdfd747e7ba4a06d6fa9c949790591fddb394ca69343e7924ac5bcea79335607f7af8faa9e601b521143d38146d755d0a6bd66fa43d6779e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00a4c47d004f2f2105464dfc099e93d84785e2afa95459800c5e37795d569b76389a490caf3acf9f08f388db067eea19c2a0a4b0a18b513b3ba0f50fb71c1ee"} 07:43:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:43:48 INFO - Copying logs to upload dir... 07:43:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:43:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.922181 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-30 07:43:47.571772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:43:47.575911) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5eb089bbfe2bd2807de1c2fe3f08a315f1c8c0c8556cfb2d28db2eda4847ee51d5d7cade2c8702cfb8b96876e022f712a03b34b4bc75b70c1a3217c22f60db31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0ffc692f4c9483cdfd747e7ba4a06d6fa9c949790591fddb394ca69343e7924ac5bcea79335607f7af8faa9e601b521143d38146d755d0a6bd66fa43d6779e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00a4c47d004f2f2105464dfc099e93d84785e2afa95459800c5e37795d569b76389a490caf3acf9f08f388db067eea19c2a0a4b0a18b513b3ba0f50fb71c1ee"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477747962/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5eb089bbfe2bd2807de1c2fe3f08a315f1c8c0c8556cfb2d28db2eda4847ee51d5d7cade2c8702cfb8b96876e022f712a03b34b4bc75b70c1a3217c22f60db31", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e0ffc692f4c9483cdfd747e7ba4a06d6fa9c949790591fddb394ca69343e7924ac5bcea79335607f7af8faa9e601b521143d38146d755d0a6bd66fa43d6779e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f00a4c47d004f2f2105464dfc099e93d84785e2afa95459800c5e37795d569b76389a490caf3acf9f08f388db067eea19c2a0a4b0a18b513b3ba0f50fb71c1ee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:43:47.601834) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:43:47.602256) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477837388.502908-1278014371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:43:47.685228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:43:47.685563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:43:47.685877) ========= ========= Total master_lag: 0.16 =========